builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1449173557.67 results: success (0) buildid: 20151203113227 builduid: 7cc026766b4e47738c703a7d86bbc657 revision: b8249000cec9855cf25054abe8870a25bf0bbc3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.667928) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.668657) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.668979) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006510 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.711274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.711574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.735360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.735640) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.792009) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.792283) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.792854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.793184) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 12:12:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-03 12:12:38 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188013 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.997201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:37.997486) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013782 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:38.047506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 12:12:38.047853) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b8249000cec9855cf25054abe8870a25bf0bbc3c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b8249000cec9855cf25054abe8870a25bf0bbc3c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 12:12:38,236 truncating revision to first 12 chars 2015-12-03 12:12:38,236 Setting DEBUG logging. 2015-12-03 12:12:38,236 attempt 1/10 2015-12-03 12:12:38,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b8249000cec9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 12:12:39,248 unpacking tar archive at: fx-team-b8249000cec9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 12:12:39.433663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:39.434002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:39.443789) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:39.444076) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 12:12:39.444495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 12:12:39.444779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:12:39 INFO - MultiFileLogger online at 20151203 12:12:39 in /builds/slave/test 12:12:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:12:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:12:39 INFO - {'append_to_log': False, 12:12:39 INFO - 'base_work_dir': '/builds/slave/test', 12:12:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:12:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:12:39 INFO - 'branch': 'Fx-Team-Non-PGO', 12:12:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:12:39 INFO - 'config_files': ('talos/linux_config.py',), 12:12:39 INFO - 'default_actions': ('clobber', 12:12:39 INFO - 'read-buildbot-config', 12:12:39 INFO - 'download-and-extract', 12:12:39 INFO - 'populate-webroot', 12:12:39 INFO - 'create-virtualenv', 12:12:39 INFO - 'install', 12:12:39 INFO - 'run-tests'), 12:12:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:12:39 INFO - 'download_minidump_stackwalk': True, 12:12:39 INFO - 'download_symbols': 'ondemand', 12:12:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:12:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:12:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:12:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:12:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:12:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:12:39 INFO - 'installer_path': 'installer.exe', 12:12:39 INFO - 'log_level': 'info', 12:12:39 INFO - 'log_name': 'talos', 12:12:39 INFO - 'log_to_console': True, 12:12:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:12:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:12:39 INFO - 'opt_config_files': (), 12:12:39 INFO - 'pip_index': False, 12:12:39 INFO - 'sps_profile': False, 12:12:39 INFO - 'sps_profile_interval': 0, 12:12:39 INFO - 'suite': 'dromaeojs', 12:12:39 INFO - 'system_bits': '64', 12:12:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:12:39 INFO - 'title': 'talos-linux64-ix-027', 12:12:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:12:39 INFO - 'use_talos_json': True, 12:12:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:12:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:12:39 INFO - 'work_dir': 'build'} 12:12:39 INFO - ##### 12:12:39 INFO - ##### Running clobber step. 12:12:39 INFO - ##### 12:12:39 INFO - Running pre-action listener: _resource_record_pre_action 12:12:39 INFO - Running main action method: clobber 12:12:39 INFO - rmtree: /builds/slave/test/build 12:12:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:12:40 INFO - Running post-action listener: _resource_record_post_action 12:12:40 INFO - ##### 12:12:40 INFO - ##### Running read-buildbot-config step. 12:12:40 INFO - ##### 12:12:40 INFO - Running pre-action listener: _resource_record_pre_action 12:12:40 INFO - Running main action method: read_buildbot_config 12:12:40 INFO - Using buildbot properties: 12:12:40 INFO - { 12:12:40 INFO - "properties": { 12:12:40 INFO - "buildnumber": 2184, 12:12:40 INFO - "product": "firefox", 12:12:40 INFO - "script_repo_revision": "production", 12:12:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:12:40 INFO - "repository": "", 12:12:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:12:40 INFO - "buildid": "20151203113227", 12:12:40 INFO - "slavename": "talos-linux64-ix-027", 12:12:40 INFO - "pgo_build": "False", 12:12:40 INFO - "basedir": "/builds/slave/test", 12:12:40 INFO - "project": "", 12:12:40 INFO - "platform": "ubuntu64_hw", 12:12:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:12:40 INFO - "slavebuilddir": "test", 12:12:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:12:40 INFO - "branch": "fx-team", 12:12:40 INFO - "repo_path": "integration/fx-team", 12:12:40 INFO - "stage_platform": "linux64", 12:12:40 INFO - "builduid": "7cc026766b4e47738c703a7d86bbc657", 12:12:40 INFO - "revision": "b8249000cec9855cf25054abe8870a25bf0bbc3c" 12:12:40 INFO - }, 12:12:40 INFO - "sourcestamp": { 12:12:40 INFO - "repository": "", 12:12:40 INFO - "hasPatch": false, 12:12:40 INFO - "project": "", 12:12:40 INFO - "branch": "fx-team-linux64-talos", 12:12:40 INFO - "changes": [ 12:12:40 INFO - { 12:12:40 INFO - "category": null, 12:12:40 INFO - "files": [ 12:12:40 INFO - { 12:12:40 INFO - "url": null, 12:12:40 INFO - "name": "https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:12:40 INFO - } 12:12:40 INFO - ], 12:12:40 INFO - "repository": "", 12:12:40 INFO - "rev": "b8249000cec9855cf25054abe8870a25bf0bbc3c", 12:12:40 INFO - "who": "s.kaspari@gmail.com", 12:12:40 INFO - "when": 1449173503, 12:12:40 INFO - "number": 6740531, 12:12:40 INFO - "comments": "Bug 1197720 - Introduce background service for downloadable content. r=rnewman\n\nThis patch introduces a background service for downloading content from a\ncatalog (bug 1200291). This catalog ships with the application and contains\nonly fonts in this first version (MOZ_ANDROID_EXCLUDE_FONTS).\n\nFor now this service is disabled by default (MOZ_ANDROID_DOWNLOAD_CONTENT_SERVICE).", 12:12:40 INFO - "project": "", 12:12:40 INFO - "at": "Thu 03 Dec 2015 12:11:43", 12:12:40 INFO - "branch": "fx-team-linux64-talos", 12:12:40 INFO - "revlink": "", 12:12:40 INFO - "properties": [ 12:12:40 INFO - [ 12:12:40 INFO - "buildid", 12:12:40 INFO - "20151203113227", 12:12:40 INFO - "Change" 12:12:40 INFO - ], 12:12:40 INFO - [ 12:12:40 INFO - "builduid", 12:12:40 INFO - "7cc026766b4e47738c703a7d86bbc657", 12:12:40 INFO - "Change" 12:12:40 INFO - ], 12:12:40 INFO - [ 12:12:40 INFO - "pgo_build", 12:12:40 INFO - "False", 12:12:40 INFO - "Change" 12:12:40 INFO - ] 12:12:40 INFO - ], 12:12:40 INFO - "revision": "b8249000cec9855cf25054abe8870a25bf0bbc3c" 12:12:40 INFO - } 12:12:40 INFO - ], 12:12:40 INFO - "revision": "b8249000cec9855cf25054abe8870a25bf0bbc3c" 12:12:40 INFO - } 12:12:40 INFO - } 12:12:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:12:40 INFO - Running post-action listener: _resource_record_post_action 12:12:40 INFO - ##### 12:12:40 INFO - ##### Running download-and-extract step. 12:12:40 INFO - ##### 12:12:40 INFO - Running pre-action listener: _resource_record_pre_action 12:12:40 INFO - Running main action method: download_and_extract 12:12:40 INFO - mkdir: /builds/slave/test/build/tests 12:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:40 INFO - https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/test_packages.json 12:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/test_packages.json 12:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:12:41 INFO - Downloaded 1302 bytes. 12:12:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:12:41 INFO - Using the following test package requirements: 12:12:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:12:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:12:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'jsshell-linux-x86_64.zip'], 12:12:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:12:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:12:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:12:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:12:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:12:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:12:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:12:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:12:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:41 INFO - https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:12:43 INFO - Downloaded 21788775 bytes. 12:12:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:12:44 INFO - Return code: 0 12:12:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:44 INFO - https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:12:51 INFO - Downloaded 21788775 bytes. 12:12:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:12:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:12:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:12:52 INFO - Return code: 0 12:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:52 INFO - https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:12:53 INFO - Downloaded 11132001 bytes. 12:12:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:12:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:12:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:12:53 INFO - Return code: 0 12:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:12:53 INFO - https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:12:57 INFO - Downloaded 57688333 bytes. 12:12:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:12:57 INFO - mkdir: /builds/slave/test/properties 12:12:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:12:57 INFO - Writing to file /builds/slave/test/properties/build_url 12:12:57 INFO - Contents: 12:12:57 INFO - build_url:https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:12:57 INFO - Running post-action listener: _resource_record_post_action 12:12:57 INFO - Running post-action listener: set_extra_try_arguments 12:12:57 INFO - ##### 12:12:57 INFO - ##### Running populate-webroot step. 12:12:57 INFO - ##### 12:12:57 INFO - Running pre-action listener: _resource_record_pre_action 12:12:57 INFO - Running main action method: populate_webroot 12:12:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:12:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:12:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:12:57 INFO - '../fennec_ids.txt'], 12:12:57 INFO - 'tests': ['tcheck2']}, 12:12:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:12:57 INFO - '--tppagecycles', 12:12:57 INFO - '7'], 12:12:57 INFO - 'tests': ['tsvgm']}}, 12:12:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:12:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:12:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:12:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:12:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'tests': ['damp', 'tps']}, 12:12:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['damp', 'tps']}, 12:12:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:12:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:12:57 INFO - 'other': {'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'other_l64': {'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'other_nol64': {'tests': ['a11yr', 12:12:57 INFO - 'ts_paint', 12:12:57 INFO - 'tpaint', 12:12:57 INFO - 'sessionrestore', 12:12:57 INFO - 'sessionrestore_no_auto_restore']}, 12:12:57 INFO - 'svgr': {'tests': ['tsvgx', 12:12:57 INFO - 'tsvgr_opacity', 12:12:57 INFO - 'tart', 12:12:57 INFO - 'tscrollx', 12:12:57 INFO - 'cart']}, 12:12:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['tsvgx', 12:12:57 INFO - 'tsvgr_opacity', 12:12:57 INFO - 'tart', 12:12:57 INFO - 'tscrollx', 12:12:57 INFO - 'cart']}, 12:12:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'tests': ['tp5o']}, 12:12:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'talos_options': ['--e10s'], 12:12:57 INFO - 'tests': ['tp5o']}, 12:12:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'talos_options': ['--xperf_path', 12:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:57 INFO - 'tests': ['tp5n']}, 12:12:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:57 INFO - 'talos_options': ['--e10s', 12:12:57 INFO - '--xperf_path', 12:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:57 INFO - 'tests': ['tp5n']}}, 12:12:57 INFO - 'talos.zip': {'path': '', 12:12:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:12:57 INFO - Running post-action listener: _resource_record_post_action 12:12:57 INFO - ##### 12:12:57 INFO - ##### Running create-virtualenv step. 12:12:57 INFO - ##### 12:12:57 INFO - Running pre-action listener: _resource_record_pre_action 12:12:57 INFO - Running main action method: create_virtualenv 12:12:57 INFO - Creating virtualenv /builds/slave/test/build/venv 12:12:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:12:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:12:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:12:58 INFO - Using real prefix '/usr' 12:12:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:12:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:13:00 INFO - Installing pip.................done. 12:13:00 INFO - Return code: 0 12:13:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:13:00 INFO - Using env: {'DISPLAY': ':0', 12:13:00 INFO - 'HOME': '/home/cltbld', 12:13:00 INFO - 'LANG': 'en_US.UTF-8', 12:13:00 INFO - 'LANGUAGE': 'en_US:en', 12:13:00 INFO - 'LOGNAME': 'cltbld', 12:13:00 INFO - 'MAIL': '/var/mail/cltbld', 12:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:00 INFO - 'MOZ_NO_REMOTE': '1', 12:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:00 INFO - 'NO_EM_RESTART': '1', 12:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:00 INFO - 'PWD': '/builds/slave/test', 12:13:00 INFO - 'SHELL': '/bin/bash', 12:13:00 INFO - 'SHLVL': '1', 12:13:00 INFO - 'TERM': 'linux', 12:13:00 INFO - 'TMOUT': '86400', 12:13:00 INFO - 'USER': 'cltbld', 12:13:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:00 INFO - '_': '/tools/buildbot/bin/python'} 12:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:13:00 INFO - Cleaning up... 12:13:00 INFO - Return code: 0 12:13:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:13:00 INFO - Using env: {'DISPLAY': ':0', 12:13:00 INFO - 'HOME': '/home/cltbld', 12:13:00 INFO - 'LANG': 'en_US.UTF-8', 12:13:00 INFO - 'LANGUAGE': 'en_US:en', 12:13:00 INFO - 'LOGNAME': 'cltbld', 12:13:00 INFO - 'MAIL': '/var/mail/cltbld', 12:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:00 INFO - 'MOZ_NO_REMOTE': '1', 12:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:00 INFO - 'NO_EM_RESTART': '1', 12:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:00 INFO - 'PWD': '/builds/slave/test', 12:13:00 INFO - 'SHELL': '/bin/bash', 12:13:00 INFO - 'SHLVL': '1', 12:13:00 INFO - 'TERM': 'linux', 12:13:00 INFO - 'TMOUT': '86400', 12:13:00 INFO - 'USER': 'cltbld', 12:13:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:00 INFO - '_': '/tools/buildbot/bin/python'} 12:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:00 INFO - Downloading/unpacking psutil>=0.7.1 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:02 INFO - Installing collected packages: psutil 12:13:02 INFO - Running setup.py install for psutil 12:13:02 INFO - building 'psutil._psutil_linux' extension 12:13:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:13:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:13:03 INFO - building 'psutil._psutil_posix' extension 12:13:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:13:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:13:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:03 INFO - Successfully installed psutil 12:13:03 INFO - Cleaning up... 12:13:03 INFO - Return code: 0 12:13:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:13:03 INFO - Using env: {'DISPLAY': ':0', 12:13:03 INFO - 'HOME': '/home/cltbld', 12:13:03 INFO - 'LANG': 'en_US.UTF-8', 12:13:03 INFO - 'LANGUAGE': 'en_US:en', 12:13:03 INFO - 'LOGNAME': 'cltbld', 12:13:03 INFO - 'MAIL': '/var/mail/cltbld', 12:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:03 INFO - 'MOZ_NO_REMOTE': '1', 12:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:03 INFO - 'NO_EM_RESTART': '1', 12:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:03 INFO - 'PWD': '/builds/slave/test', 12:13:03 INFO - 'SHELL': '/bin/bash', 12:13:03 INFO - 'SHLVL': '1', 12:13:03 INFO - 'TERM': 'linux', 12:13:03 INFO - 'TMOUT': '86400', 12:13:03 INFO - 'USER': 'cltbld', 12:13:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:03 INFO - '_': '/tools/buildbot/bin/python'} 12:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:13:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:13:05 INFO - Installing collected packages: mozsystemmonitor 12:13:05 INFO - Running setup.py install for mozsystemmonitor 12:13:05 INFO - Successfully installed mozsystemmonitor 12:13:05 INFO - Cleaning up... 12:13:05 INFO - Return code: 0 12:13:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:13:05 INFO - Using env: {'DISPLAY': ':0', 12:13:05 INFO - 'HOME': '/home/cltbld', 12:13:05 INFO - 'LANG': 'en_US.UTF-8', 12:13:05 INFO - 'LANGUAGE': 'en_US:en', 12:13:05 INFO - 'LOGNAME': 'cltbld', 12:13:05 INFO - 'MAIL': '/var/mail/cltbld', 12:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:05 INFO - 'MOZ_NO_REMOTE': '1', 12:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:05 INFO - 'NO_EM_RESTART': '1', 12:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:05 INFO - 'PWD': '/builds/slave/test', 12:13:05 INFO - 'SHELL': '/bin/bash', 12:13:05 INFO - 'SHLVL': '1', 12:13:05 INFO - 'TERM': 'linux', 12:13:05 INFO - 'TMOUT': '86400', 12:13:05 INFO - 'USER': 'cltbld', 12:13:05 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:05 INFO - '_': '/tools/buildbot/bin/python'} 12:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:07 INFO - Downloading docopt-0.6.1.tar.gz 12:13:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:08 INFO - Running setup.py install for blobuploader 12:13:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:08 INFO - Running setup.py install for requests 12:13:08 INFO - Running setup.py install for docopt 12:13:08 INFO - Successfully installed blobuploader requests docopt 12:13:08 INFO - Cleaning up... 12:13:08 INFO - Return code: 0 12:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:13:08 INFO - Using env: {'DISPLAY': ':0', 12:13:08 INFO - 'HOME': '/home/cltbld', 12:13:08 INFO - 'LANG': 'en_US.UTF-8', 12:13:08 INFO - 'LANGUAGE': 'en_US:en', 12:13:08 INFO - 'LOGNAME': 'cltbld', 12:13:08 INFO - 'MAIL': '/var/mail/cltbld', 12:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:08 INFO - 'MOZ_NO_REMOTE': '1', 12:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:08 INFO - 'NO_EM_RESTART': '1', 12:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:08 INFO - 'PWD': '/builds/slave/test', 12:13:08 INFO - 'SHELL': '/bin/bash', 12:13:08 INFO - 'SHLVL': '1', 12:13:08 INFO - 'TERM': 'linux', 12:13:08 INFO - 'TMOUT': '86400', 12:13:08 INFO - 'USER': 'cltbld', 12:13:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:08 INFO - '_': '/tools/buildbot/bin/python'} 12:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:08 INFO - Running setup.py (path:/tmp/pip-5LZDzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:08 INFO - Running setup.py (path:/tmp/pip-hPP8XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:08 INFO - Running setup.py (path:/tmp/pip-X7h2Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:09 INFO - Running setup.py (path:/tmp/pip-_csYa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:09 INFO - Running setup.py (path:/tmp/pip-2T7EmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:09 INFO - Running setup.py (path:/tmp/pip-Fg1MEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:09 INFO - Running setup.py (path:/tmp/pip-omicwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:09 INFO - Running setup.py (path:/tmp/pip-OjvYU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:09 INFO - Running setup.py (path:/tmp/pip-aT7YCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:09 INFO - Running setup.py (path:/tmp/pip-IvGDN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:09 INFO - Running setup.py (path:/tmp/pip-jytXdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:09 INFO - Running setup.py (path:/tmp/pip-Who_Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:09 INFO - Running setup.py (path:/tmp/pip-W1EJK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:09 INFO - Running setup.py (path:/tmp/pip-7bYAGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:09 INFO - Running setup.py (path:/tmp/pip-W_yqsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:09 INFO - Running setup.py (path:/tmp/pip-xcOwD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:09 INFO - Running setup.py (path:/tmp/pip-drl2Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:10 INFO - Running setup.py install for manifestparser 12:13:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Running setup.py install for mozcrash 12:13:10 INFO - Running setup.py install for mozdebug 12:13:10 INFO - Running setup.py install for mozdevice 12:13:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Running setup.py install for mozfile 12:13:10 INFO - Running setup.py install for mozhttpd 12:13:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Running setup.py install for mozinfo 12:13:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Running setup.py install for mozInstall 12:13:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:10 INFO - Running setup.py install for mozleak 12:13:10 INFO - Running setup.py install for mozlog 12:13:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Running setup.py install for moznetwork 12:13:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Running setup.py install for mozprocess 12:13:11 INFO - Running setup.py install for mozprofile 12:13:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Running setup.py install for mozrunner 12:13:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Running setup.py install for mozscreenshot 12:13:11 INFO - Running setup.py install for moztest 12:13:11 INFO - Running setup.py install for mozversion 12:13:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:11 INFO - Cleaning up... 12:13:11 INFO - Return code: 0 12:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:13:11 INFO - Using env: {'DISPLAY': ':0', 12:13:11 INFO - 'HOME': '/home/cltbld', 12:13:11 INFO - 'LANG': 'en_US.UTF-8', 12:13:11 INFO - 'LANGUAGE': 'en_US:en', 12:13:11 INFO - 'LOGNAME': 'cltbld', 12:13:11 INFO - 'MAIL': '/var/mail/cltbld', 12:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:11 INFO - 'MOZ_NO_REMOTE': '1', 12:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:11 INFO - 'NO_EM_RESTART': '1', 12:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:11 INFO - 'PWD': '/builds/slave/test', 12:13:11 INFO - 'SHELL': '/bin/bash', 12:13:11 INFO - 'SHLVL': '1', 12:13:11 INFO - 'TERM': 'linux', 12:13:11 INFO - 'TMOUT': '86400', 12:13:11 INFO - 'USER': 'cltbld', 12:13:11 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:11 INFO - '_': '/tools/buildbot/bin/python'} 12:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:12 INFO - Running setup.py (path:/tmp/pip-M6rMMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:12 INFO - Running setup.py (path:/tmp/pip-PknS8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:12 INFO - Running setup.py (path:/tmp/pip-iMTp5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:12 INFO - Running setup.py (path:/tmp/pip-g7gTgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:12 INFO - Running setup.py (path:/tmp/pip-A_9rcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:12 INFO - Running setup.py (path:/tmp/pip-TgdOZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:12 INFO - Running setup.py (path:/tmp/pip-6QfTIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:12 INFO - Running setup.py (path:/tmp/pip-j__eN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:12 INFO - Running setup.py (path:/tmp/pip-z0rq7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:12 INFO - Running setup.py (path:/tmp/pip-DfUpub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:12 INFO - Running setup.py (path:/tmp/pip-0gp8FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:12 INFO - Running setup.py (path:/tmp/pip-kvWXDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:12 INFO - Running setup.py (path:/tmp/pip-BYD5xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:13 INFO - Running setup.py (path:/tmp/pip-cvKmhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:13 INFO - Running setup.py (path:/tmp/pip-QUnnT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:13 INFO - Running setup.py (path:/tmp/pip-yYWwdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:13 INFO - Running setup.py (path:/tmp/pip-q4__EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:13:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:14 INFO - Downloading blessings-1.5.1.tar.gz 12:13:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:15 INFO - Installing collected packages: blessings 12:13:15 INFO - Running setup.py install for blessings 12:13:15 INFO - Successfully installed blessings 12:13:15 INFO - Cleaning up... 12:13:15 INFO - Return code: 0 12:13:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:15 INFO - Reading from file tmpfile_stdout 12:13:15 INFO - Current package versions: 12:13:15 INFO - argparse == 1.2.1 12:13:15 INFO - blessings == 1.5.1 12:13:15 INFO - blobuploader == 1.2.4 12:13:15 INFO - docopt == 0.6.1 12:13:15 INFO - manifestparser == 1.1 12:13:15 INFO - mozInstall == 1.12 12:13:15 INFO - mozcrash == 0.16 12:13:15 INFO - mozdebug == 0.1 12:13:15 INFO - mozdevice == 0.47 12:13:15 INFO - mozfile == 1.2 12:13:15 INFO - mozhttpd == 0.7 12:13:15 INFO - mozinfo == 0.9 12:13:15 INFO - mozleak == 0.1 12:13:15 INFO - mozlog == 3.1 12:13:15 INFO - moznetwork == 0.27 12:13:15 INFO - mozprocess == 0.22 12:13:15 INFO - mozprofile == 0.27 12:13:15 INFO - mozrunner == 6.11 12:13:15 INFO - mozscreenshot == 0.1 12:13:15 INFO - mozsystemmonitor == 0.0 12:13:15 INFO - moztest == 0.7 12:13:15 INFO - mozversion == 1.4 12:13:15 INFO - psutil == 3.1.1 12:13:15 INFO - requests == 1.2.3 12:13:15 INFO - wsgiref == 0.1.2 12:13:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:13:15 INFO - Using env: {'DISPLAY': ':0', 12:13:15 INFO - 'HOME': '/home/cltbld', 12:13:15 INFO - 'LANG': 'en_US.UTF-8', 12:13:15 INFO - 'LANGUAGE': 'en_US:en', 12:13:15 INFO - 'LOGNAME': 'cltbld', 12:13:15 INFO - 'MAIL': '/var/mail/cltbld', 12:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:15 INFO - 'MOZ_NO_REMOTE': '1', 12:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:15 INFO - 'NO_EM_RESTART': '1', 12:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:15 INFO - 'PWD': '/builds/slave/test', 12:13:15 INFO - 'SHELL': '/bin/bash', 12:13:15 INFO - 'SHLVL': '1', 12:13:15 INFO - 'TERM': 'linux', 12:13:15 INFO - 'TMOUT': '86400', 12:13:15 INFO - 'USER': 'cltbld', 12:13:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:15 INFO - '_': '/tools/buildbot/bin/python'} 12:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:13:15 INFO - Cleaning up... 12:13:15 INFO - Return code: 0 12:13:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:13:15 INFO - Using env: {'DISPLAY': ':0', 12:13:15 INFO - 'HOME': '/home/cltbld', 12:13:15 INFO - 'LANG': 'en_US.UTF-8', 12:13:15 INFO - 'LANGUAGE': 'en_US:en', 12:13:15 INFO - 'LOGNAME': 'cltbld', 12:13:15 INFO - 'MAIL': '/var/mail/cltbld', 12:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:15 INFO - 'MOZ_NO_REMOTE': '1', 12:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:15 INFO - 'NO_EM_RESTART': '1', 12:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:15 INFO - 'PWD': '/builds/slave/test', 12:13:15 INFO - 'SHELL': '/bin/bash', 12:13:15 INFO - 'SHLVL': '1', 12:13:15 INFO - 'TERM': 'linux', 12:13:15 INFO - 'TMOUT': '86400', 12:13:15 INFO - 'USER': 'cltbld', 12:13:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:15 INFO - '_': '/tools/buildbot/bin/python'} 12:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:15 INFO - Downloading/unpacking jsonschema 12:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:13:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 12:13:17 INFO - Downloading/unpacking functools32 (from jsonschema) 12:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:13:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:13:17 INFO - warning: no files found matching '*.txt' 12:13:17 INFO - no previously-included directories found matching 'build' 12:13:17 INFO - no previously-included directories found matching 'dist' 12:13:17 INFO - no previously-included directories found matching '.git*' 12:13:17 INFO - Installing collected packages: jsonschema, functools32 12:13:17 INFO - Running setup.py install for functools32 12:13:17 INFO - warning: no files found matching '*.txt' 12:13:17 INFO - no previously-included directories found matching 'build' 12:13:17 INFO - no previously-included directories found matching 'dist' 12:13:17 INFO - no previously-included directories found matching '.git*' 12:13:17 INFO - Successfully installed jsonschema functools32 12:13:17 INFO - Cleaning up... 12:13:18 INFO - Return code: 0 12:13:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11e5dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:13:18 INFO - Using env: {'DISPLAY': ':0', 12:13:18 INFO - 'HOME': '/home/cltbld', 12:13:18 INFO - 'LANG': 'en_US.UTF-8', 12:13:18 INFO - 'LANGUAGE': 'en_US:en', 12:13:18 INFO - 'LOGNAME': 'cltbld', 12:13:18 INFO - 'MAIL': '/var/mail/cltbld', 12:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:18 INFO - 'MOZ_NO_REMOTE': '1', 12:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:18 INFO - 'NO_EM_RESTART': '1', 12:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:18 INFO - 'PWD': '/builds/slave/test', 12:13:18 INFO - 'SHELL': '/bin/bash', 12:13:18 INFO - 'SHLVL': '1', 12:13:18 INFO - 'TERM': 'linux', 12:13:18 INFO - 'TMOUT': '86400', 12:13:18 INFO - 'USER': 'cltbld', 12:13:18 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:18 INFO - '_': '/tools/buildbot/bin/python'} 12:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:18 INFO - Downloading/unpacking flake8 12:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:13:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 12:13:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:13:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 12:13:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:13:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:20 INFO - no previously-included directories found matching 'docs/_build' 12:13:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:13:20 INFO - Running setup.py install for pep8 12:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:20 INFO - no previously-included directories found matching 'docs/_build' 12:13:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:13:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:13:20 INFO - Cleaning up... 12:13:20 INFO - Return code: 0 12:13:20 INFO - Running post-action listener: _resource_record_post_action 12:13:20 INFO - Running post-action listener: _start_resource_monitoring 12:13:20 INFO - Starting resource monitoring. 12:13:20 INFO - ##### 12:13:20 INFO - ##### Running install step. 12:13:20 INFO - ##### 12:13:20 INFO - Running pre-action listener: _resource_record_pre_action 12:13:20 INFO - Running main action method: install 12:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:21 INFO - Reading from file tmpfile_stdout 12:13:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:21 INFO - Reading from file tmpfile_stdout 12:13:21 INFO - Output received: 12:13:21 INFO - Usage: mozinstall [options] installer 12:13:21 INFO - Options: 12:13:21 INFO - -h, --help show this help message and exit 12:13:21 INFO - -d DEST, --destination=DEST 12:13:21 INFO - Directory to install application into. [default: 12:13:21 INFO - "/builds/slave/test"] 12:13:21 INFO - --app=APP Application being installed. [default: firefox] 12:13:21 INFO - mkdir: /builds/slave/test/build/application 12:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:13:35 INFO - Reading from file tmpfile_stdout 12:13:35 INFO - Output received: 12:13:35 INFO - /builds/slave/test/build/application/firefox/firefox 12:13:35 INFO - Running post-action listener: _resource_record_post_action 12:13:35 INFO - ##### 12:13:35 INFO - ##### Running run-tests step. 12:13:35 INFO - ##### 12:13:35 INFO - Running pre-action listener: _resource_record_pre_action 12:13:35 INFO - Running main action method: run_tests 12:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:35 INFO - Python 2.7.3 12:13:35 INFO - Return code: 0 12:13:35 INFO - grabbing minidump binary from tooltool 12:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183b0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:13:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:13:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:35 INFO - Return code: 0 12:13:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:13:36 INFO - Return code: 0 12:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 12:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 12:13:36 INFO - Using env: {'DISPLAY': ':0', 12:13:36 INFO - 'HOME': '/home/cltbld', 12:13:36 INFO - 'LANG': 'en_US.UTF-8', 12:13:36 INFO - 'LANGUAGE': 'en_US:en', 12:13:36 INFO - 'LOGNAME': 'cltbld', 12:13:36 INFO - 'MAIL': '/var/mail/cltbld', 12:13:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:36 INFO - 'MOZ_NO_REMOTE': '1', 12:13:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:36 INFO - 'NO_EM_RESTART': '1', 12:13:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:36 INFO - 'PWD': '/builds/slave/test', 12:13:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:36 INFO - 'SHELL': '/bin/bash', 12:13:36 INFO - 'SHLVL': '1', 12:13:36 INFO - 'TERM': 'linux', 12:13:36 INFO - 'TMOUT': '86400', 12:13:36 INFO - 'USER': 'cltbld', 12:13:36 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710', 12:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:36 INFO - '_': '/tools/buildbot/bin/python'} 12:13:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 12:13:36 INFO - mozversion INFO | application_buildid: 20151203113227 12:13:36 INFO - mozversion INFO | application_changeset: b8249000cec9855cf25054abe8870a25bf0bbc3c 12:13:36 INFO - mozversion INFO | application_display_name: Nightly 12:13:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:36 INFO - mozversion INFO | application_name: Firefox 12:13:36 INFO - mozversion INFO | application_remotingname: firefox 12:13:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:13:36 INFO - mozversion INFO | application_vendor: Mozilla 12:13:36 INFO - mozversion INFO | application_version: 45.0a1 12:13:36 INFO - mozversion INFO | platform_buildid: 20151203113227 12:13:36 INFO - mozversion INFO | platform_changeset: b8249000cec9855cf25054abe8870a25bf0bbc3c 12:13:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:13:36 INFO - mozversion INFO | platform_version: 45.0a1 12:13:36 INFO - 2015-12-03 12:13:36,807 DEBUG : using testdate: 1449173616 12:13:36 INFO - 2015-12-03 12:13:36,807 DEBUG : actual date: 1449173616 12:13:36 INFO - 2015-12-03 12:13:36,857 INFO : starting webserver on 'localhost:57858' 12:13:36 INFO - 2015-12-03 12:13:36,858 INFO : Starting test suite talos-linux64-ix-027 12:13:36 INFO - 2015-12-03 12:13:36,858 INFO : Starting test dromaeo_css 12:13:36 INFO - 2015-12-03 12:13:36,858 DEBUG : operating with platform_type : linux_ 12:13:36 INFO - 2015-12-03 12:13:36,859 INFO : Initialising browser for dromaeo_css test... 12:13:36 INFO - 2015-12-03 12:13:36,872 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJyy0I1/profile http://localhost:57858/getInfo.html 12:13:41 INFO - 2015-12-03 12:13:41,487 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:13:41 INFO - 2015-12-03 12:13:41,487 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:13:41 INFO - 2015-12-03 12:13:41,487 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:13:41 INFO - 2015-12-03 12:13:41,487 DEBUG : BROWSER_OUTPUT: __metrics 12:13:41 INFO - 2015-12-03 12:13:41,571 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:13:41 INFO - 2015-12-03 12:13:41,781 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:42 INFO - 2015-12-03 12:13:42,743 INFO : Browser initialized. 12:13:42 INFO - 2015-12-03 12:13:42,743 INFO : Running cycle 1/1 for dromaeo_css test... 12:13:42 INFO - 2015-12-03 12:13:42,743 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJyy0I1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:13:54 INFO - 2015-12-03 12:13:54,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 142729216 12:13:54 INFO - 2015-12-03 12:13:54,746 DEBUG : BROWSER_OUTPUT: 12:14:45 INFO - 2015-12-03 12:14:45,894 DEBUG : BROWSER_OUTPUT: 1449173685887 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:16:57 INFO - 2015-12-03 12:16:57,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57858/tests/dromaeo/cssquery-ext.html) 12:16:59 INFO - 2015-12-03 12:16:59,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 266592256 12:16:59 INFO - 2015-12-03 12:16:59,199 DEBUG : BROWSER_OUTPUT: 12:20:01 INFO - 2015-12-03 12:20:01,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-ext.html (next: http://localhost:57858/tests/dromaeo/cssquery-jquery.html) 12:20:02 INFO - 2015-12-03 12:20:02,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 229228544 12:20:02 INFO - 2015-12-03 12:20:02,488 DEBUG : BROWSER_OUTPUT: 12:23:04 INFO - 2015-12-03 12:23:04,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57858/tests/dromaeo/cssquery-mootools.html) 12:23:04 INFO - 2015-12-03 12:23:04,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 227475456 12:23:04 INFO - 2015-12-03 12:23:04,975 DEBUG : BROWSER_OUTPUT: 12:26:06 INFO - 2015-12-03 12:26:06,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57858/tests/dromaeo/cssquery-prototype.html) 12:26:07 INFO - 2015-12-03 12:26:07,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 209039360 12:26:07 INFO - 2015-12-03 12:26:07,522 DEBUG : BROWSER_OUTPUT: 12:29:10 INFO - 2015-12-03 12:29:10,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57858/tests/dromaeo/cssquery-yui.html) 12:29:10 INFO - 2015-12-03 12:29:10,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 212262912 12:29:10 INFO - 2015-12-03 12:29:10,842 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/dromaeo/cssquery-yui.html (next: http://localhost:57858/tests/dromaeo/cssquery-dojo.html) 12:32:13 INFO - 2015-12-03 12:32:13,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 253005824 12:32:13 INFO - 2015-12-03 12:32:13,517 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,518 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:32:13 INFO - 2015-12-03 12:32:13,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:32:13 INFO - 2015-12-03 12:32:13,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:32:13 INFO - 2015-12-03 12:32:13,518 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:32:13 INFO - 2015-12-03 12:32:13,522 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2556.910508132215;2672.3586339278568;2675.5317819381603;2678.785697144228;2682.7719643830274;4410.713303635262;4525.728456292625;4547.590716835484;4589.977050114749;4623.375844261028;4509.639228861692;4589.747563883985;4600.056988317395;4603.953960460402;4610.608098311639;4285.185814695214;4297.376880352347;4305.6124948754605;4325.718828276168;4342.32693932441;4112.753234805907;4377.430933978579;4423.623991960687;4432.091421258634;4437.955620443787;4181.080162364275;4238.364245363189;4286.871393858158;4289.013526888802;4297;4350.1734670412525;4378.452693413324;4381.671374646882;4383.495897971742;4421.624161946238;4367.061081867414;4367.475902891641;4370.497392799837;4388.605025547684;4418.558144185556;4393.1872603568445;4514.751688657123;4522.638188944909;4526.094781043805;4658.138244424758;4975.129352363322;4991.051700176955;4997.175466048097;4997.175466048097;5040.344755181803;5009.998000399934;5015.122353588107;5015.598752099823;5017.297578339036;5029.044481548531;4489.19194544985;4610.585047345755;4611.723296602215;4625.653076019312;4775.5463230993;5105.5149760772665;5140.691558506427;5141.2545180948555;5156.767945442464;5156.845294641167;4918.0901533216465;4941.851744447672;4944.653874228769;4952.2324039773175;4992.076465853756;4728.503507131702;4839.733814640229;4840.7337596432535;4855.393075865517;4981.576565991932;4923.286123512143;4971.552560269593;4975.577075948512;4976.726280054631;5020.924686129711;4917.7786999585105;4919.3604831371695;4920.876978075506;4923.975380123076;4978.875528111754;3984.143409167043;4054.8580799671868;4079.530853951774;4080.9795951020055;4083.1221287423346;3609.314230296235;3626.7461277710836;3651.050726811048;3653.5250417446096;3654.3604869147794;4182.142660754538;4200.3699445082875;4207.305794543866;4274.465691788527;4294.269974104347;4973.577245934136;5011.298418221452;5018.397792264952;5020.924686129711;5072.239164125411;4278.336857787048;4293.8711838644895;4294.6993710439965;4303.182395344875;4337.240982827992;4245.830166793294;4336.067745434747;4345.804438800262;4348.239058164809;4445.466544014675;4727.550882666142;4758.833440829554;4761.452432970253;4763.7141771493825;4798.2082956311815;4987.0524600325825;5014.949850501448;5029.170186919117;5036.773345199402;5036.949630503648;4576.58810707038;4597.195490789165;4711.363965864702;4714.434267887876;4782.354382158364;4923.630727695366;4952.281919121635;4955.6531042826655;4959.826406075915;4998.6750861193905;5003.174476211384;5016.172331565251;5016.924746128738;5022.899542009212;5057.443681195139;4725.243960966229;4747.050589882107;4856.223004319292;4859.246816743411;4896.338994235875;4830.492798256273;4860;4861.465238823655;4871.318015477765;4900.215965445512;4756.476787553297;4757.666963312535;4766;4767.76161191946;4794.256890182028;4652.720836749806;4722.834700785456;4776.450708168466;4780.1873681473535;4810;4818.71087734737;4824.445188803333;4827.179379505422;4828.37231159961;4867.172580661225 12:32:13 INFO - 2015-12-03 12:32:13,523 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.0195663458852;570.5065118672348;580.8983427900116;581.9709014549277;584.225900681597;27010.86494567527;27525.174244772665;35711.28577428453;36278.093047673756;36372.09069773257;38412.80793596028;38605.806970965175;38637.42043869344;38667.80666096666;38686.4197037044;6986.09180806497;7902.0122484689555;8080.272775450208;8101.270885620293;8105.189481051907;7116.395106415935;7251.818704532376;10309.278350515468;10563.207759418035;10601.681949541526;10229.181665466745;10354.534045967912;10365.326253793479;10370.377777333346;10372.948135259314;7212.206657267697;7371.815704607374;10146.949265253701;10222;10288.279820412612;10341.276110672256;10643.84034239487;10653.094486968617;10653.201009924287;10656;35007;35173.29653406917;35468.82265588681;35475.467867982;35498.82250588756;2746.6978632350424;2793.748562629353;3260.6413294537583;3500.562429696288;3501.072215862798;27012.189634311002;27228.863855680596;27297.181084567495;27604.861975689993;27992.30019249535;3264.2002709336366;3498.860045598173;3530.6116327203986;3543.5924868639922;3634.745567810254;208582;211484;211794;212107.93946030326;213090;49676.50323496719;55312.17031744527;55448;55479.28426083747;55561;47089.764551177024;64759;65856.34143658598;65917;65977;12793.872061279268;12997.545085921947;13000.414981325863;13004.479820807252;13005.089643725038;9753.609855605839;9797.118259356692;9803.705888823204;9824.607015719434;9879.110880020833;18794.718079228824;18934.905325473286;19033.333833315766;19059.61880762377;19104.61790764177;7592.582407967615;7736.342410895137;7781.26078022587;7885.1326354101;7909.485883417559;802.3741481644327;809.5142914251402;834.015861283691;880.3925291548811;924.8982611912684;25469.745302547108;25917.74082259191;29063.56404653932;29749.405011900075;30135.246618834706;925.421611492817;944.2210176604328;968.0513097164677;975.512243878061;998.5578596648296;13394.330283485786;13507.459701612022;13541.458341666223;13648.454061837416;13691.726165476834;311346;315778.73770098336;317191;317561;317635;42038.36942445866;42949.570504294556;44388.55611443909;44903;49080;1186.454231053725;1210.03197442046;1221.2001139253803;1230.9076819238594;1236.202649291202;25048;25642;25807.870960645076;26040.609390859532;26103.08639197619;34723.13192170216;35153.64846351504;35228;39422;40084;179304;179773;181235;181326;181630;27637.861810690818;27956.440871182054;28023.859880700467;28043;28070.859645702458;36080;36395.81802091079;37051.62948370482;37192.81403593073;37440;31013;31053;31397.68602314039;32095.197620059684;32568.674313256564;31687.841560792047;31705.682943171196;31846.6815331853;31950.201244969063;32142.517862232555;31461.056168314986;31657.20856978594;31871.52192717065;31969;31971.520427194075;28347.57478637781;28747.8562607194;29800.254993624465;29902;29913.401731964805;22907.541849163255;23697.40756481102;25541.818760505575;26184.73815261823;26359.20922372332 12:32:13 INFO - 2015-12-03 12:32:13,524 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.19684764446214;332.1182261096788;334.4581777520416;337.3691197460749;337.6977605043486;12473.750524989495;12853.228806271607;14814.333354999024;15160;16085;9455.33812633116;9596.56815443305;9707.320487565856;9712.66005689801;9815.607375704963;4545.090981803644;4707.388039554853;4711.0342379812055;4712.363830882839;4712.787924543404;3341.6324204337625;3976.443297938291;4640.327152562876;5266.210068489719;5298.072837253484;5237.004969055867;5243.737813109348;5263.710495922723;5268.078086334876;5286.995470860525;5244.580433565306;5384.3538775346815;5725.885482290372;5732.570057245724;5732.971335143297;5068.189089745623;5075.0357432087785;5080.923786143211;5084.339035925343;5092.694438333712;18768.530786730305;19156;19591.11839967205;19596.80403195964;19602.11790469432;1620.7082725109476;1644.7697322374877;1731.5065206416111;1803.4769916724135;1915.186045930474;8711.433756805787;8830;8870.512121833297;8874.334424918157;8937.687180948635;1680.8907421017716;1708.555775498367;1730.1868121982648;1748.2482532511015;1770.3272756352503;55125.794968201226;57903.420965790225;58217.70891145517;58252.81462156602;58532;9552.713418597314;9688.564014619358;9724.465154416575;9789.608415663437;9811.362261452983;12597.307148106942;12605.747885042249;12607.117501774972;12621.495140194473;12633.873661263453;6737.258901520829;7840.9215907841335;8042.356611471068;8078.596070196584;8241.50550966944;6750.35871592198;6768.187817461838;6828.863422731617;6853.17761868569;6856.211535673362;7389.408847292204;7468.253174682488;7474.514156579805;7509.586972716553;7544;2433.6592876997233;2940.4854150523574;2960.2451374899692;2991.685872983349;2992.7905046646524;722.0468980945207;796.2992566541407;797.2545669798641;807.3339494916718;940.7742141886035;13024.739505210033;14466.638334041523;15957.281922313523;16193.190340483165;16391;811.8822770698216;818.7625588579365;827.9751607451666;841.4643276021286;896.112848280211;8713.041565427799;8937.865932011026;9035.141661542142;9052.094790520896;9190.586423610954;439652;440433;452515;453315;453634;64669.353306467274;68686.65656671685;68978;69176.96234556485;69240.6537967307;935.6631612619316;962.6919385796618;987.4519641598981;991.5290237137302;994.1897353656747;14119.858801411854;14353.282335882956;14375.209363485108;14380.42478300898;14470.782938255725;32973.83513082419;33323.333533329685;33813.15467113243;33923.32153356968;34556.30887382288;41795.28330658498;42317.78841105775;42350.36474452824;43164.784176078916;43583.56416435795;8888.244499217639;8922.197002269826;8998.415103018282;9063.093690630883;9065.229455496357;10637.840432393676;11506.252093613888;14653.560393188221;16069.19654017271;17128.82871171322;12827.679308017001;13075.803862941873;13428.127171733806;13439.731205376032;13482;12954.417051232529;13101.344932753515;13144.737105257651;13646.24945628;13785.931070344985;13162.868371316164;13237;13340.733185336432;13424.127431716906;13816.447342106203;8651.48091114535;8745.825083498421;8984.820303594022;9057.728268151966;9064.456132632064;13329.3335333231;13696.178229306273;13898.861011389758;13958.16251024901;14218.146911185362 12:32:13 INFO - 2015-12-03 12:32:13,528 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1426.8715815576595;1614.20903757159;1621.8540331370175;1640.7456844189148;1682.848543631073;5930.495907847832;6699.531032827698;6857.554258973163;6872.41584465321;6914.58512489251;6639.070530125786;6796.116504854362;6798.694058767355;6806.557573757715;6819.624920629363;1760.683077046131;1790.364420630677;2029.6346657601625;2074.6887966805025;2110.8522403431766;2088.7389076365453;2090.341542414142;2090.707300977864;2095.0886364431444;2095.821855142307;2011.658018136913;2048.8873111978837;2048.9282875099375;2055.8972051397373;2062.886541240231;2004.0881398963436;2038.3782946201402;2039.4799326171806;2067.0388269454775;2069.492974221318;2054.4658388818866;2075.284027010679;2075.792420757927;2077.958440831175;2080.9687854682193;6720.32796720324;6757.763478278286;6772.8984065239065;6778.118844550227;6787.5927444353;3933.547642021147;3977.244323578511;3994.4407782910416;3998.820053097618;4000.5199376074765;2250.3361508355074;2555.8083143764293;2657.2692509559834;2670.719574444675;2688.8386696798257;792.5244853088159;847.4788005376711;857.5497863621648;865.9220670139655;867.869819527076;8703.260222881063;8763.561821908943;8772.078931712205;8779.473231606187;8785.121487851227;3793.791341476245;3818.541774986964;3859.6333348331864;3865.091703449687;3881.7282790204413;7739.110002349802;7746.0317460317465;7749.883751743729;7759.262870027338;7771.067471903295;4044.352903535479;4046.858359957387;4057.9797101014306;4063.7358571693335;4064.288749468831;3687.539057617798;3715;3717.851285948586;3721.702263818888;3723.2739615774663;3415.1462134466383;3421.2473255883665;3427.6572342765526;3452.482127680818;3470.0977745786277;1038.781855810273;1050.4800123938546;1056.746380868586;1057.7831544533353;1063.7340664833791;1097.9615713449991;1107.7895199912152;1127.053275248795;1132.0377678972807;1136.8976792088752;6228.377162283736;6240.469560087444;6249.031400132987;6250.624962502174;6253.593516421509;1088.3919805843602;1109.4397329348628;1117.7093955571447;1124.1681155944705;1125.2573301621055;5025.447200807908;5049.82325618609;5054.82308119214;5066.392032955995;5085.567726743194;7396.704131834666;7647.847043059219;8173.918260817316;8231.34149268057;8446.028706698808;8041.477303975223;8153.551554664432;8166.305864001626;8185.672573097128;8297.211764882326;6503.3496650333645;6517.73929042833;6535.673216339164;6586.604803711793;6592.044153597702;6477.514186435942;6510.869782604226;6525.836854078686;6527.249366322743;6532.41208291256;7242.601656908921;7376.4836461447185;7388.667509961957;7396.667149978156;7514.211007844097;7464.365528930101;7583.734569290048;7592.810179745329;7650.693972241048;7660.846783064196;5793.449622286044;5840.2991641003355;5840.561957853263;5849;5870.178175055581;6630.403263706289;6666.466682665278;6710.765123220664;6727.26000139994;6738.561993470409;6306.936930630635;6362.77730279438;6370.6814659267775;6418;6427.871442571216;5971.701414929149;6034.607750496204;6136.846578835565;6321.936780632135;6361.840953976002;6183.165272688129;6291.653959032297;6331.2085989251345;6331.366863313816;6346.524010699124;5816.73824677882;5841.707914604168;5849.473547380756;5850.444207800252;5853.180554722428;6001.879962400815;6014.36849130835;6018.097285407049;6019.789307374396;6025.969870150797 12:32:13 INFO - 2015-12-03 12:32:13,529 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.917132374259;309.91942095055276;311.954766558849;313.36699866270123;314.889788573999;5134.871628209287;5161.458046905077;5232.7122008289525;5281.498257665516;5351.652142610733;5077.64456488046;5228.424873263938;5250.107481728106;5252.474752524746;5260.605454590902;3883.941740873889;4107.075907920716;4110.547839737626;4111.342185250345;4116.629503344699;3957.5448823385245;3986.7807270600106;4100.835966561334;4103.2409004334295;4123.051698109437;4039.939400908989;4056.1684854604737;4057.026313684724;4065.0447144920918;4072.287349713803;4065.2479291331197;4069.2471892699796;4076.6331030207125;4081;4084.36692312692;3570.2680950405365;3571.2143328467955;3573.5890372607223;3582.802945837978;3587.7847329160336;4883.853484395474;5001;5046.798128074873;5060.620453465968;5060.696358218519;4664.976675116603;4672;4676;4678.69588476748;4679.064187162581;5486.588505862036;5518.613697041209;5523.972380138114;5523.978064058162;5525.613207075507;3686.9815650921573;3778.735488515805;3781.773093614392;3846.788426636534;3880.5343358797127;5750.1949727038245;5809.535237181015;5820.592558520905;5821.592488525805;5825.388334224887;3910.2570511602703;3913.491246137984;3927.293087244266;3931.4495970564144;3954.4661470701085;3968.9603103969166;3971.424143499234;4007.6393124618926;4010.418489319091;4014.799260037045;4432.268675668543;4555.362249285103;4579.084183163381;4614.2617181250835;4614.953850461452;5537.252470916455;5552.666839989613;5555.361133469622;5555.638883472561;5559.444055594489;1400.0549629000384;1426.3795249066688;1428.2073449235565;1428.8785453236592;1429.7783843504274;939.3706216834737;956.4930586789013;961.1829944547219;980.1717548671361;988.4909271725068;4856.4415092264135;4861.343718598015;4865.1485989952325;4869.2939523768855;4872.1473742094995;5748.252727145528;5760.510356619734;5760.683162426023;5761.020626493506;5761.9135712964335;4857.587105096036;4864.343313652612;4864.902701946012;4870.220764677634;4875.171220892456;2893.3056066543877;3030.3787723517066;3075.7078077582596;3082.460569400346;3094.706002929718;4483.955160448419;5405.108157154025;5461.726913654302;5472.76862705888;5481.972590137024;5896.882062358729;5904.1734157218025;5943.435373639497;5952.0476723724;5961.791337303173;5443.5100840923715;5449.591280653967;5452.7546260417585;5456.399796022434;5463.180522921593;5768.365479797303;5771.220885180447;5776.595638305446;5777.104548794943;5781.364049954417;5449.3460784706085;5522.5581953442825;5578.581606379456;5652.604317697722;5663.575231857545;5427.8100266492065;5448.073827449264;5452.182172674131;5459.399466058651;5471.917921231265;3973.046468847398;3974.463447434675;3977.7812220327;3977.880663580097;3980.940285895772;5760.481556659921;5762.827115186551;5765.884682306414;5769.769209231584;5771.047777116729;5396.379416367011;5558.555315574664;5561.249231353715;5561.721913904369;5561.860953476195;5556.694381809039;5559.0827513461445;5559.1661250811085;5565.805196818092;5566.359868615161;5438.945610544002;5439.891202176013;5445.455454454523;5447.754851031634;5448.237246785532;5433.022056029952;5585.16222566602;5601.131824567198;5601.663900166003;5604.803831866028;5451.836444906659;5453.890922181455;5456.454354564512;5457.290552228344;5459.153831156177 12:32:13 INFO - 2015-12-03 12:32:13,530 DEBUG : BROWSER_OUTPUT: |5;yui.html;594.9226600541929;623.5853157650163;678.3013496099016;713.7287830624364;740.8259059121106;11438.370889601068;11743.647690569285;11755.588554400598;11758.823617645721;11807.114466415022;11522.308661480318;11532.423378831067;11647.301161930269;11660.533578656843;11705.882941170586;616.7193926763334;625.0343219725535;775.9961200193991;782.9608519574027;787.7754839870638;787.9487833290817;791.3471386106456;796.040770871099;796.5977181523323;797.214743477674;756.3986630628664;814.0475643497123;838.7609531283586;839.2530647723531;839.5718183726314;643.9034144878259;654.7511945460742;813.6704634622987;831.1563762780783;834.9081601023883;614.6312212672406;614.9661768602725;615.2647586134526;615.4399496458202;615.7290792051483;11645.94177029118;11707.180497365187;11747.295162290204;11753.294802311888;11784.823227651592;10020.198384129251;10176.542055607515;10244.180465562737;10383.376997380181;10489.63286284984;9100.408473449204;9506.904930950672;9555.283353748428;9843;10093.041161089684;3195.0734287056725;3243.140567749548;3319.8174100424467;3322.435186018383;3356.110630682871;36326.091847703756;36599.08502287437;36722.44916326257;36876.446853297224;36944.81527592372;8880.200781929658;9163.219853642931;9165.17513423795;9190.494522801177;9406.153446189739;16861.747073793904;16870.831291686925;17014.914925425295;17034.48896533106;17085.914570427067;6350.68246587678;6449.6130232186215;6456.225252969673;6477.287498375175;6650.900236496456;3552.467129930531;3622.5834029086463;3662.1943172502006;3675.834587443518;3681.631836816297;2739.986300068487;2768.5016696994735;2768.9169324920285;2771.237909574843;2775.153578158681;487.43214155509145;490.8920037591724;493.95554400104163;501.198083067097;501.60623910230294;524.6248932013629;550.6310771782915;556.5436342199357;569.5102212097676;573.6586730895111;7206.891896621555;7270;7461.403087752967;7465.776026719207;7571.810704732316;419.850952911718;513.7123211001851;529.5366554265019;545.5281181777813;585.8271809816115;3182.5067114597273;3304.256542277968;3339.916502087467;3382.678645528671;3412.1810765416617;48565.5143448561;48884;49316.26025609619;49548.50451495511;49579.00841983212;43416;43771;44080.77959610181;44259.02503162032;44340;37993.24013519714;41104.38343424851;41189.588104119175;41590.37614435786;41786.58213417827;7776.222377762178;8089.352851771727;8092.393070519617;8134;8352.331813454788;33065.66934330626;33458;34007.149821254665;34305.14237144091;34376.48435273523;40673.79663101665;41422.1715565681;44156.337654934556;44513.33230001488;45186.32220516629;10315.690529284133;10465.162786977176;10539.473026348805;10579.36523808574;11153.21927465102;10735.516901739284;10890.128789696964;10918.23572349928;10953.83569246446;10958.671239862817;10326.741831453974;10506.422146781695;10578.8942110581;10658.253922225369;11088.390138542458;10644.254902157085;10696.893031069902;10792;10797;11259.887401125883;10390.688279351632;10401.58393664245;10437.217208709226;10584.100351469904;10739;9459.432434053979;9486.193673537826;9559.761005974906;9848.901510984799;9934.105930466292;9122.498262595622;9205.982739407173;9210.447373157633;9238.861417078884;9397.295202859676 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1129 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174733517__endTimestamp 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4592.12 Median:4728.50 stddev:484.94 (10.3%) stddev-sans-first:459.39 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: Values: 2556.9 2672.4 2675.5 2678.8 2682.8 4410.7 4525.7 4547.6 4590.0 4623.4 4509.6 4589.7 4600.1 4604.0 4610.6 4285.2 4297.4 4305.6 4325.7 4342.3 4112.8 4377.4 4423.6 4432.1 4438.0 4181.1 4238.4 4286.9 4289.0 4297.0 4350.2 4378.5 4381.7 4383.5 4421.6 4367.1 4367.5 4370.5 4388.6 4418.6 4393.2 4514.8 4522.6 4526.1 4658.1 4975.1 4991.1 4997.2 4997.2 5040.3 5010.0 5015.1 5015.6 5017.3 5029.0 4489.2 4610.6 4611.7 4625.7 4775.5 5105.5 5140.7 5141.3 5156.8 5156.8 4918.1 4941.9 4944.7 4952.2 4992.1 4728.5 4839.7 4840.7 4855.4 4981.6 4923.3 4971.6 4975.6 4976.7 5020.9 4917.8 4919.4 4920.9 4924.0 4978.9 3984.1 4054.9 4079.5 4081.0 4083.1 3609.3 3626.7 3651.1 3653.5 3654.4 4182.1 4200.4 4207.3 4274.5 4294.3 4973.6 5011.3 5018.4 5020.9 5072.2 4278.3 4293.9 4294.7 4303.2 4337.2 4245.8 4336.1 4345.8 4348.2 4445.5 4727.6 4758.8 4761.5 4763.7 4798.2 4987.1 5014.9 5029.2 5036.8 5036.9 4576.6 4597.2 4711.4 4714.4 4782.4 4923.6 4952.3 4955.7 4959.8 4998.7 5003.2 5016.2 5016.9 5022.9 5057.4 4725.2 4747.1 4856.2 4859.2 4896.3 4830.5 4860.0 4861.5 4871.3 4900.2 4756.5 4757.7 4766.0 4767.8 4794.3 4652.7 4722.8 4776.5 4780.2 4810.0 4818.7 4824.4 4827.2 4828.4 4867.2 12:32:13 INFO - 2015-12-03 12:32:13,531 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,532 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39671.64 Median:317598.00 stddev:63577.75 (20.0%) stddev-sans-first:63688.31 12:32:13 INFO - 2015-12-03 12:32:13,532 DEBUG : BROWSER_OUTPUT: Values: 570.0 570.5 580.9 582.0 584.2 27010.9 27525.2 35711.3 36278.1 36372.1 38412.8 38605.8 38637.4 38667.8 38686.4 6986.1 7902.0 8080.3 8101.3 8105.2 7116.4 7251.8 10309.3 10563.2 10601.7 10229.2 10354.5 10365.3 10370.4 10372.9 7212.2 7371.8 10146.9 10222.0 10288.3 10341.3 10643.8 10653.1 10653.2 10656.0 35007.0 35173.3 35468.8 35475.5 35498.8 2746.7 2793.7 3260.6 3500.6 3501.1 27012.2 27228.9 27297.2 27604.9 27992.3 3264.2 3498.9 3530.6 3543.6 3634.7 208582.0 211484.0 211794.0 212107.9 213090.0 49676.5 55312.2 55448.0 55479.3 55561.0 47089.8 64759.0 65856.3 65917.0 65977.0 12793.9 12997.5 13000.4 13004.5 13005.1 9753.6 9797.1 9803.7 9824.6 9879.1 18794.7 18934.9 19033.3 19059.6 19104.6 7592.6 7736.3 7781.3 7885.1 7909.5 802.4 809.5 834.0 880.4 924.9 25469.7 25917.7 29063.6 29749.4 30135.2 925.4 944.2 968.1 975.5 998.6 13394.3 13507.5 13541.5 13648.5 13691.7 311346.0 315778.7 317191.0 317561.0 317635.0 42038.4 42949.6 44388.6 44903.0 49080.0 1186.5 1210.0 1221.2 1230.9 1236.2 25048.0 25642.0 25807.9 26040.6 26103.1 34723.1 35153.6 35228.0 39422.0 40084.0 179304.0 179773.0 181235.0 181326.0 181630.0 27637.9 27956.4 28023.9 28043.0 28070.9 36080.0 36395.8 37051.6 37192.8 37440.0 31013.0 31053.0 31397.7 32095.2 32568.7 31687.8 31705.7 31846.7 31950.2 32142.5 31461.1 31657.2 31871.5 31969.0 31971.5 28347.6 28747.9 29800.3 29902.0 29913.4 22907.5 23697.4 25541.8 26184.7 26359.2 12:32:13 INFO - 2015-12-03 12:32:13,532 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,532 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25142.99 Median:4711.70 stddev:73185.30 (1553.3%) stddev-sans-first:73366.89 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: Values: 331.2 332.1 334.5 337.4 337.7 12473.8 12853.2 14814.3 15160.0 16085.0 9455.3 9596.6 9707.3 9712.7 9815.6 4545.1 4707.4 4711.0 4712.4 4712.8 3341.6 3976.4 4640.3 5266.2 5298.1 5237.0 5243.7 5263.7 5268.1 5287.0 5244.6 5384.4 5725.9 5732.6 5733.0 5068.2 5075.0 5080.9 5084.3 5092.7 18768.5 19156.0 19591.1 19596.8 19602.1 1620.7 1644.8 1731.5 1803.5 1915.2 8711.4 8830.0 8870.5 8874.3 8937.7 1680.9 1708.6 1730.2 1748.2 1770.3 55125.8 57903.4 58217.7 58252.8 58532.0 9552.7 9688.6 9724.5 9789.6 9811.4 12597.3 12605.7 12607.1 12621.5 12633.9 6737.3 7840.9 8042.4 8078.6 8241.5 6750.4 6768.2 6828.9 6853.2 6856.2 7389.4 7468.3 7474.5 7509.6 7544.0 2433.7 2940.5 2960.2 2991.7 2992.8 722.0 796.3 797.3 807.3 940.8 13024.7 14466.6 15957.3 16193.2 16391.0 811.9 818.8 828.0 841.5 896.1 8713.0 8937.9 9035.1 9052.1 9190.6 439652.0 440433.0 452515.0 453315.0 453634.0 64669.4 68686.7 68978.0 69177.0 69240.7 935.7 962.7 987.5 991.5 994.2 14119.9 14353.3 14375.2 14380.4 14470.8 32973.8 33323.3 33813.2 33923.3 34556.3 41795.3 42317.8 42350.4 43164.8 43583.6 8888.2 8922.2 8998.4 9063.1 9065.2 10637.8 11506.3 14653.6 16069.2 17128.8 12827.7 13075.8 13428.1 13439.7 13482.0 12954.4 13101.3 13144.7 13646.2 13785.9 13162.9 13237.0 13340.7 13424.1 13816.4 8651.5 8745.8 8984.8 9057.7 9064.5 13329.3 13696.2 13898.9 13958.2 14218.1 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4804.26 Median:5951.10 stddev:2417.25 (40.6%) stddev-sans-first:2410.70 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: Values: 1426.9 1614.2 1621.9 1640.7 1682.8 5930.5 6699.5 6857.6 6872.4 6914.6 6639.1 6796.1 6798.7 6806.6 6819.6 1760.7 1790.4 2029.6 2074.7 2110.9 2088.7 2090.3 2090.7 2095.1 2095.8 2011.7 2048.9 2048.9 2055.9 2062.9 2004.1 2038.4 2039.5 2067.0 2069.5 2054.5 2075.3 2075.8 2078.0 2081.0 6720.3 6757.8 6772.9 6778.1 6787.6 3933.5 3977.2 3994.4 3998.8 4000.5 2250.3 2555.8 2657.3 2670.7 2688.8 792.5 847.5 857.5 865.9 867.9 8703.3 8763.6 8772.1 8779.5 8785.1 3793.8 3818.5 3859.6 3865.1 3881.7 7739.1 7746.0 7749.9 7759.3 7771.1 4044.4 4046.9 4058.0 4063.7 4064.3 3687.5 3715.0 3717.9 3721.7 3723.3 3415.1 3421.2 3427.7 3452.5 3470.1 1038.8 1050.5 1056.7 1057.8 1063.7 1098.0 1107.8 1127.1 1132.0 1136.9 6228.4 6240.5 6249.0 6250.6 6253.6 1088.4 1109.4 1117.7 1124.2 1125.3 5025.4 5049.8 5054.8 5066.4 5085.6 7396.7 7647.8 8173.9 8231.3 8446.0 8041.5 8153.6 8166.3 8185.7 8297.2 6503.3 6517.7 6535.7 6586.6 6592.0 6477.5 6510.9 6525.8 6527.2 6532.4 7242.6 7376.5 7388.7 7396.7 7514.2 7464.4 7583.7 7592.8 7650.7 7660.8 5793.4 5840.3 5840.6 5849.0 5870.2 6630.4 6666.5 6710.8 6727.3 6738.6 6306.9 6362.8 6370.7 6418.0 6427.9 5971.7 6034.6 6136.8 6321.9 6361.8 6183.2 6291.7 6331.2 6331.4 6346.5 5816.7 5841.7 5849.5 5850.4 5853.2 6001.9 6014.4 6018.1 6019.8 6026.0 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,533 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4585.52 Median:5241.41 stddev:1353.19 (25.8%) stddev-sans-first:1318.33 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: Values: 306.9 309.9 312.0 313.4 314.9 5134.9 5161.5 5232.7 5281.5 5351.7 5077.6 5228.4 5250.1 5252.5 5260.6 3883.9 4107.1 4110.5 4111.3 4116.6 3957.5 3986.8 4100.8 4103.2 4123.1 4039.9 4056.2 4057.0 4065.0 4072.3 4065.2 4069.2 4076.6 4081.0 4084.4 3570.3 3571.2 3573.6 3582.8 3587.8 4883.9 5001.0 5046.8 5060.6 5060.7 4665.0 4672.0 4676.0 4678.7 4679.1 5486.6 5518.6 5524.0 5524.0 5525.6 3687.0 3778.7 3781.8 3846.8 3880.5 5750.2 5809.5 5820.6 5821.6 5825.4 3910.3 3913.5 3927.3 3931.4 3954.5 3969.0 3971.4 4007.6 4010.4 4014.8 4432.3 4555.4 4579.1 4614.3 4615.0 5537.3 5552.7 5555.4 5555.6 5559.4 1400.1 1426.4 1428.2 1428.9 1429.8 939.4 956.5 961.2 980.2 988.5 4856.4 4861.3 4865.1 4869.3 4872.1 5748.3 5760.5 5760.7 5761.0 5761.9 4857.6 4864.3 4864.9 4870.2 4875.2 2893.3 3030.4 3075.7 3082.5 3094.7 4484.0 5405.1 5461.7 5472.8 5482.0 5896.9 5904.2 5943.4 5952.0 5961.8 5443.5 5449.6 5452.8 5456.4 5463.2 5768.4 5771.2 5776.6 5777.1 5781.4 5449.3 5522.6 5578.6 5652.6 5663.6 5427.8 5448.1 5452.2 5459.4 5471.9 3973.0 3974.5 3977.8 3977.9 3980.9 5760.5 5762.8 5765.9 5769.8 5771.0 5396.4 5558.6 5561.2 5561.7 5561.9 5556.7 5559.1 5559.2 5565.8 5566.4 5438.9 5439.9 5445.5 5447.8 5448.2 5433.0 5585.2 5601.1 5601.7 5604.8 5451.8 5453.9 5456.5 5457.3 5459.2 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12276.70 Median:43925.89 stddev:13870.70 (31.6%) stddev-sans-first:13881.87 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: Values: 594.9 623.6 678.3 713.7 740.8 11438.4 11743.6 11755.6 11758.8 11807.1 11522.3 11532.4 11647.3 11660.5 11705.9 616.7 625.0 776.0 783.0 787.8 787.9 791.3 796.0 796.6 797.2 756.4 814.0 838.8 839.3 839.6 643.9 654.8 813.7 831.2 834.9 614.6 615.0 615.3 615.4 615.7 11645.9 11707.2 11747.3 11753.3 11784.8 10020.2 10176.5 10244.2 10383.4 10489.6 9100.4 9506.9 9555.3 9843.0 10093.0 3195.1 3243.1 3319.8 3322.4 3356.1 36326.1 36599.1 36722.4 36876.4 36944.8 8880.2 9163.2 9165.2 9190.5 9406.2 16861.7 16870.8 17014.9 17034.5 17085.9 6350.7 6449.6 6456.2 6477.3 6650.9 3552.5 3622.6 3662.2 3675.8 3681.6 2740.0 2768.5 2768.9 2771.2 2775.2 487.4 490.9 494.0 501.2 501.6 524.6 550.6 556.5 569.5 573.7 7206.9 7270.0 7461.4 7465.8 7571.8 419.9 513.7 529.5 545.5 585.8 3182.5 3304.3 3339.9 3382.7 3412.2 48565.5 48884.0 49316.3 49548.5 49579.0 43416.0 43771.0 44080.8 44259.0 44340.0 37993.2 41104.4 41189.6 41590.4 41786.6 7776.2 8089.4 8092.4 8134.0 8352.3 33065.7 33458.0 34007.1 34305.1 34376.5 40673.8 41422.2 44156.3 44513.3 45186.3 10315.7 10465.2 10539.5 10579.4 11153.2 10735.5 10890.1 10918.2 10953.8 10958.7 10326.7 10506.4 10578.9 10658.3 11088.4 10644.3 10696.9 10792.0 10797.0 11259.9 10390.7 10401.6 10437.2 10584.1 10739.0 9459.4 9486.2 9559.8 9848.9 9934.1 9122.5 9206.0 9210.4 9238.9 9397.3 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:32:13 INFO - 2015-12-03 12:32:13,535 DEBUG : BROWSER_OUTPUT: 12:32:14 INFO - 2015-12-03 12:32:14,266 INFO : Browser exited with error code: 0 12:32:14 INFO - 2015-12-03 12:32:14,289 INFO : Completed test dromaeo_css (00:18:37) 12:32:14 INFO - 2015-12-03 12:32:14,289 INFO : Starting test kraken 12:32:14 INFO - 2015-12-03 12:32:14,289 DEBUG : operating with platform_type : linux_ 12:32:14 INFO - 2015-12-03 12:32:14,289 INFO : Initialising browser for kraken test... 12:32:14 INFO - 2015-12-03 12:32:14,295 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzwf60B/profile http://localhost:57858/getInfo.html 12:32:18 INFO - 2015-12-03 12:32:18,601 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:32:18 INFO - 2015-12-03 12:32:18,601 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:32:18 INFO - 2015-12-03 12:32:18,601 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:32:18 INFO - 2015-12-03 12:32:18,601 DEBUG : BROWSER_OUTPUT: __metrics 12:32:18 INFO - 2015-12-03 12:32:18,677 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:32:18 INFO - 2015-12-03 12:32:18,733 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:19 INFO - 2015-12-03 12:32:19,965 INFO : Browser initialized. 12:32:19 INFO - 2015-12-03 12:32:19,966 INFO : Running cycle 1/1 for kraken test... 12:32:19 INFO - 2015-12-03 12:32:19,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzwf60B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:32:32 INFO - 2015-12-03 12:32:32,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 143360000 12:32:32 INFO - 2015-12-03 12:32:32,021 DEBUG : BROWSER_OUTPUT: 12:32:34 INFO - 2015-12-03 12:32:34,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57858/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:35 INFO - 2015-12-03 12:32:35,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 181596160 12:32:35 INFO - 2015-12-03 12:32:35,212 DEBUG : BROWSER_OUTPUT: 12:32:37 INFO - 2015-12-03 12:32:37,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57858/tests/kraken/driver.html?testName=audio-dft) 12:32:38 INFO - 2015-12-03 12:32:38,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 168517632 12:32:38 INFO - 2015-12-03 12:32:38,474 DEBUG : BROWSER_OUTPUT: 12:32:41 INFO - 2015-12-03 12:32:41,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57858/tests/kraken/driver.html?testName=audio-fft) 12:32:42 INFO - 2015-12-03 12:32:42,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 153186304 12:32:42 INFO - 2015-12-03 12:32:42,056 DEBUG : BROWSER_OUTPUT: 12:32:44 INFO - 2015-12-03 12:32:44,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57858/tests/kraken/driver.html?testName=audio-oscillator) 12:32:44 INFO - 2015-12-03 12:32:44,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 154906624 12:32:44 INFO - 2015-12-03 12:32:44,679 DEBUG : BROWSER_OUTPUT: 12:32:46 INFO - 2015-12-03 12:32:46,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:32:47 INFO - 2015-12-03 12:32:47,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 158621696 12:32:47 INFO - 2015-12-03 12:32:47,483 DEBUG : BROWSER_OUTPUT: 12:32:50 INFO - 2015-12-03 12:32:50,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57858/tests/kraken/driver.html?testName=imaging-darkroom) 12:32:51 INFO - 2015-12-03 12:32:51,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 157437952 12:32:51 INFO - 2015-12-03 12:32:51,035 DEBUG : BROWSER_OUTPUT: 12:32:54 INFO - 2015-12-03 12:32:54,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57858/tests/kraken/driver.html?testName=imaging-desaturate) 12:32:55 INFO - 2015-12-03 12:32:55,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 159408128 12:32:55 INFO - 2015-12-03 12:32:55,052 DEBUG : BROWSER_OUTPUT: 12:32:57 INFO - 2015-12-03 12:32:57,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57858/tests/kraken/driver.html?testName=json-parse-financial) 12:32:58 INFO - 2015-12-03 12:32:58,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 157761536 12:32:58 INFO - 2015-12-03 12:32:58,466 DEBUG : BROWSER_OUTPUT: 12:33:00 INFO - 2015-12-03 12:33:00,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:33:00 INFO - 2015-12-03 12:33:00,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 168767488 12:33:00 INFO - 2015-12-03 12:33:00,787 DEBUG : BROWSER_OUTPUT: 12:33:02 INFO - 2015-12-03 12:33:02,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:33:03 INFO - 2015-12-03 12:33:03,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 167440384 12:33:03 INFO - 2015-12-03 12:33:03,271 DEBUG : BROWSER_OUTPUT: 12:33:05 INFO - 2015-12-03 12:33:05,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:33:06 INFO - 2015-12-03 12:33:06,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 180076544 12:33:06 INFO - 2015-12-03 12:33:06,052 DEBUG : BROWSER_OUTPUT: 12:33:08 INFO - 2015-12-03 12:33:08,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:33:09 INFO - 2015-12-03 12:33:09,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 186236928 12:33:09 INFO - 2015-12-03 12:33:09,147 DEBUG : BROWSER_OUTPUT: 12:33:11 INFO - 2015-12-03 12:33:11,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:12 INFO - 2015-12-03 12:33:12,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 185524224 12:33:12 INFO - 2015-12-03 12:33:12,316 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57858/tests/kraken/driver.html?testName=ai-astar) 12:33:14 INFO - 2015-12-03 12:33:14,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 243367936 12:33:14 INFO - 2015-12-03 12:33:14,312 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;111;112;112;102;112;111;104 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;129;157;163;128;149;154;129;166;128 12:33:14 INFO - 2015-12-03 12:33:14,316 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;162;160;160;161;161;161;160 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;82;92;72;72;72;96;92;71 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;132;94;94;94;134;95;95;126 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;110 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;147;146;148;147;147 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;95;96;96;95;95 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;71;71;69;70;71;70;70;70;68 12:33:14 INFO - 2015-12-03 12:33:14,317 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;69;68;69;69;68;68;68;68 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;91;84;84;83;85;84;84;85;84 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;121;125;117;125;122;126;126;119 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;143;144;144;144;148;145;145;150;134 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;67;67;67;68;67;68;67;68 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,992 12:33:14 INFO - 2015-12-03 12:33:14,318 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:33:14 INFO - 2015-12-03 12:33:14,319 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174794314__endTimestamp 12:33:14 INFO - 2015-12-03 12:33:14,319 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,322 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:33:14 INFO - 2015-12-03 12:33:14,322 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:33:14 INFO - 2015-12-03 12:33:14,322 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,322 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:4.01 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 111.0 112.0 112.0 102.0 112.0 111.0 104.0 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.30 Median:155.50 stddev:16.00 (10.3%) stddev-sans-first:16.18 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: Values: 160.0 129.0 157.0 163.0 128.0 149.0 154.0 129.0 166.0 128.0 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 162.0 160.0 160.0 161.0 161.0 161.0 160.0 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:77.50 stddev:10.17 (13.1%) stddev-sans-first:10.52 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 82.0 92.0 72.0 72.0 72.0 96.0 92.0 71.0 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,323 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:94.00 stddev:17.62 (18.7%) stddev-sans-first:18.21 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 132.0 94.0 94.0 94.0 134.0 95.0 95.0 126.0 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 148.0 147.0 147.0 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,324 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 71.0 69.0 70.0 71.0 70.0 70.0 70.0 68.0 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.31 (2.8%) stddev-sans-first:2.37 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: Values: 83.0 91.0 84.0 84.0 83.0 85.0 84.0 84.0 85.0 84.0 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:125.00 stddev:3.57 (2.9%) stddev-sans-first:3.39 12:33:14 INFO - 2015-12-03 12:33:14,325 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 121.0 125.0 117.0 125.0 122.0 126.0 126.0 119.0 12:33:14 INFO - 2015-12-03 12:33:14,326 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:144.50 stddev:5.24 (3.6%) stddev-sans-first:4.40 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: Values: 134.0 143.0 144.0 144.0 144.0 148.0 145.0 145.0 150.0 134.0 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 67.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:33:14 INFO - 2015-12-03 12:33:14,327 DEBUG : BROWSER_OUTPUT: 12:33:15 INFO - 2015-12-03 12:33:15,242 INFO : Browser exited with error code: 0 12:33:15 INFO - 2015-12-03 12:33:15,295 INFO : Completed test kraken (00:01:01) 12:33:15 INFO - 2015-12-03 12:33:15,295 INFO : Starting test v8_7 12:33:15 INFO - 2015-12-03 12:33:15,295 DEBUG : operating with platform_type : linux_ 12:33:15 INFO - 2015-12-03 12:33:15,295 INFO : Initialising browser for v8_7 test... 12:33:15 INFO - 2015-12-03 12:33:15,302 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfuSQGZ/profile http://localhost:57858/getInfo.html 12:33:19 INFO - 2015-12-03 12:33:19,601 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:33:19 INFO - 2015-12-03 12:33:19,601 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:33:19 INFO - 2015-12-03 12:33:19,601 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:33:19 INFO - 2015-12-03 12:33:19,601 DEBUG : BROWSER_OUTPUT: __metrics 12:33:19 INFO - 2015-12-03 12:33:19,742 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:33:19 INFO - 2015-12-03 12:33:19,818 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:20 INFO - 2015-12-03 12:33:20,972 INFO : Browser initialized. 12:33:20 INFO - 2015-12-03 12:33:20,973 INFO : Running cycle 1/1 for v8_7 test... 12:33:20 INFO - 2015-12-03 12:33:20,973 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfuSQGZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:33:32 INFO - 2015-12-03 12:33:32,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 142565376 12:33:32 INFO - 2015-12-03 12:33:32,992 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57858/tests/v8_7/run.html (next: http://localhost:57858/tests/v8_7/run.html) 12:33:54 INFO - 2015-12-03 12:33:54,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 461512704 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: |0;Richards;167.5603217158177 12:33:54 INFO - 2015-12-03 12:33:54,656 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 12:33:54 INFO - 2015-12-03 12:33:54,657 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 12:33:54 INFO - 2015-12-03 12:33:54,657 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 12:33:54 INFO - 2015-12-03 12:33:54,657 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2030.4259634888438 12:33:54 INFO - 2015-12-03 12:33:54,657 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 12:33:54 INFO - 2015-12-03 12:33:54,657 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 12:33:54 INFO - 2015-12-03 12:33:54,658 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: |8;Splay;633.7135614702155 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174834655__endTimestamp 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,659 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:33:54 INFO - 2015-12-03 12:33:54,660 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:33:54 INFO - 2015-12-03 12:33:54,660 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,660 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,660 DEBUG : BROWSER_OUTPUT: Values: 167.6 12:33:54 INFO - 2015-12-03 12:33:54,660 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: Values: 186.1 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: Values: 277.9 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,661 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: Values: 5175.3 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2030.43 Median:2030.43 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: Values: 2030.4 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: Values: 781.9 12:33:54 INFO - 2015-12-03 12:33:54,662 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: Values: 12060.2 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: Values: 26921.1 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.71 Median:633.71 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,663 DEBUG : BROWSER_OUTPUT: Values: 633.7 12:33:54 INFO - 2015-12-03 12:33:54,664 DEBUG : BROWSER_OUTPUT: 12:33:54 INFO - 2015-12-03 12:33:54,664 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:33:54 INFO - 2015-12-03 12:33:54,664 DEBUG : BROWSER_OUTPUT: Values: 4830.9 12:33:54 INFO - 2015-12-03 12:33:54,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:33:54 INFO - 2015-12-03 12:33:54,664 DEBUG : BROWSER_OUTPUT: 12:33:55 INFO - 2015-12-03 12:33:55,585 INFO : Browser exited with error code: 0 12:33:55 INFO - 2015-12-03 12:33:55,602 INFO : Completed test v8_7 (00:00:40) 12:33:55 INFO - 2015-12-03 12:33:55,670 INFO : Completed test suite (00:20:18) 12:33:55 INFO - 2015-12-03 12:33:55,670 DEBUG : Working with test: dromaeo_css 12:33:55 INFO - 2015-12-03 12:33:55,671 DEBUG : Generating results file: dromaeo_css 12:33:55 INFO - 2015-12-03 12:33:55,672 DEBUG : Working with test: kraken 12:33:55 INFO - 2015-12-03 12:33:55,672 DEBUG : Generating results file: kraken 12:33:55 INFO - 2015-12-03 12:33:55,672 INFO : javascript benchmark 12:33:55 INFO - 2015-12-03 12:33:55,672 DEBUG : Working with test: v8_7 12:33:55 INFO - 2015-12-03 12:33:55,672 DEBUG : Generating results file: v8_7 12:33:55 INFO - 2015-12-03 12:33:55,673 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:33:55 INFO - 2015-12-03 12:33:55,721 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:33:55 INFO - 2015-12-03 12:33:55,722 DEBUG : process_Request line: dromaeo_css 6260.64 graph.html#tests=[[72,132,35]] 12:33:55 INFO - 2015-12-03 12:33:55,722 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:33:55 INFO - 2015-12-03 12:33:55,749 DEBUG : process_Request line: kraken 1508.20 graph.html#tests=[[232,132,35]] 12:33:55 INFO - 2015-12-03 12:33:55,749 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:33:55 INFO - 2015-12-03 12:33:55,777 DEBUG : process_Request line: v8_7 19699.39 graph.html#tests=[[230,132,35]] 12:33:55 INFO - 2015-12-03 12:33:55,778 INFO : javascript benchmark 12:33:55 INFO - 2015-12-03 12:33:55,782 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2556.910508132215, 2672.3586339278568, 2675.5317819381603, 2678.785697144228, 2682.7719643830274, 4410.713303635262, 4525.728456292625, 4547.590716835484, 4589.977050114749, 4623.375844261028, 4509.639228861692, 4589.747563883985, 4600.056988317395, 4603.953960460402, 4610.608098311639, 4285.185814695214, 4297.376880352347, 4305.6124948754605, 4325.718828276168, 4342.32693932441, 4112.753234805907, 4377.430933978579, 4423.623991960687, 4432.091421258634, 4437.955620443787, 4181.080162364275, 4238.364245363189, 4286.871393858158, 4289.013526888802, 4297.0, 4350.1734670412525, 4378.452693413324, 4381.671374646882, 4383.495897971742, 4421.624161946238, 4367.061081867414, 4367.475902891641, 4370.497392799837, 4388.605025547684, 4418.558144185556, 4393.1872603568445, 4514.751688657123, 4522.638188944909, 4526.094781043805, 4658.138244424758, 4975.129352363322, 4991.051700176955, 4997.175466048097, 4997.175466048097, 5040.344755181803, 5009.998000399934, 5015.122353588107, 5015.598752099823, 5017.297578339036, 5029.044481548531, 4489.19194544985, 4610.585047345755, 4611.723296602215, 4625.653076019312, 4775.5463230993, 5105.5149760772665, 5140.691558506427, 5141.2545180948555, 5156.767945442464, 5156.845294641167, 4918.0901533216465, 4941.851744447672, 4944.653874228769, 4952.2324039773175, 4992.076465853756, 4728.503507131702, 4839.733814640229, 4840.7337596432535, 4855.393075865517, 4981.576565991932, 4923.286123512143, 4971.552560269593, 4975.577075948512, 4976.726280054631, 5020.924686129711, 4917.7786999585105, 4919.3604831371695, 4920.876978075506, 4923.975380123076, 4978.875528111754, 3984.143409167043, 4054.8580799671868, 4079.530853951774, 4080.9795951020055, 4083.1221287423346, 3609.314230296235, 3626.7461277710836, 3651.050726811048, 3653.5250417446096, 3654.3604869147794, 4182.142660754538, 4200.3699445082875, 4207.305794543866, 4274.465691788527, 4294.269974104347, 4973.577245934136, 5011.298418221452, 5018.397792264952, 5020.924686129711, 5072.239164125411, 4278.336857787048, 4293.8711838644895, 4294.6993710439965, 4303.182395344875, 4337.240982827992, 4245.830166793294, 4336.067745434747, 4345.804438800262, 4348.239058164809, 4445.466544014675, 4727.550882666142, 4758.833440829554, 4761.452432970253, 4763.7141771493825, 4798.2082956311815, 4987.0524600325825, 5014.949850501448, 5029.170186919117, 5036.773345199402, 5036.949630503648, 4576.58810707038, 4597.195490789165, 4711.363965864702, 4714.434267887876, 4782.354382158364, 4923.630727695366, 4952.281919121635, 4955.6531042826655, 4959.826406075915, 4998.6750861193905, 5003.174476211384, 5016.172331565251, 5016.924746128738, 5022.899542009212, 5057.443681195139, 4725.243960966229, 4747.050589882107, 4856.223004319292, 4859.246816743411, 4896.338994235875, 4830.492798256273, 4860.0, 4861.465238823655, 4871.318015477765, 4900.215965445512, 4756.476787553297, 4757.666963312535, 4766.0, 4767.76161191946, 4794.256890182028, 4652.720836749806, 4722.834700785456, 4776.450708168466, 4780.1873681473535, 4810.0, 4818.71087734737, 4824.445188803333, 4827.179379505422, 4828.37231159961, 4867.172580661225], "unit": "ms", "name": "dojo.html", "value": 4561.566838959201}, {"lowerIsBetter": false, "replicates": [570.0195663458852, 570.5065118672348, 580.8983427900116, 581.9709014549277, 584.225900681597, 27010.86494567527, 27525.174244772665, 35711.28577428453, 36278.093047673756, 36372.09069773257, 38412.80793596028, 38605.806970965175, 38637.42043869344, 38667.80666096666, 38686.4197037044, 6986.09180806497, 7902.0122484689555, 8080.272775450208, 8101.270885620293, 8105.189481051907, 7116.395106415935, 7251.818704532376, 10309.278350515468, 10563.207759418035, 10601.681949541526, 10229.181665466745, 10354.534045967912, 10365.326253793479, 10370.377777333346, 10372.948135259314, 7212.206657267697, 7371.815704607374, 10146.949265253701, 10222.0, 10288.279820412612, 10341.276110672256, 10643.84034239487, 10653.094486968617, 10653.201009924287, 10656.0, 35007.0, 35173.29653406917, 35468.82265588681, 35475.467867982, 35498.82250588756, 2746.6978632350424, 2793.748562629353, 3260.6413294537583, 3500.562429696288, 3501.072215862798, 27012.189634311002, 27228.863855680596, 27297.181084567495, 27604.861975689993, 27992.30019249535, 3264.2002709336366, 3498.860045598173, 3530.6116327203986, 3543.5924868639922, 3634.745567810254, 208582.0, 211484.0, 211794.0, 212107.93946030326, 213090.0, 49676.50323496719, 55312.17031744527, 55448.0, 55479.28426083747, 55561.0, 47089.764551177024, 64759.0, 65856.34143658598, 65917.0, 65977.0, 12793.872061279268, 12997.545085921947, 13000.414981325863, 13004.479820807252, 13005.089643725038, 9753.609855605839, 9797.118259356692, 9803.705888823204, 9824.607015719434, 9879.110880020833, 18794.718079228824, 18934.905325473286, 19033.333833315766, 19059.61880762377, 19104.61790764177, 7592.582407967615, 7736.342410895137, 7781.26078022587, 7885.1326354101, 7909.485883417559, 802.3741481644327, 809.5142914251402, 834.015861283691, 880.3925291548811, 924.8982611912684, 25469.745302547108, 25917.74082259191, 29063.56404653932, 29749.405011900075, 30135.246618834706, 925.421611492817, 944.2210176604328, 968.0513097164677, 975.512243878061, 998.5578596648296, 13394.330283485786, 13507.459701612022, 13541.458341666223, 13648.454061837416, 13691.726165476834, 311346.0, 315778.73770098336, 317191.0, 317561.0, 317635.0, 42038.36942445866, 42949.570504294556, 44388.55611443909, 44903.0, 49080.0, 1186.454231053725, 1210.03197442046, 1221.2001139253803, 1230.9076819238594, 1236.202649291202, 25048.0, 25642.0, 25807.870960645076, 26040.609390859532, 26103.08639197619, 34723.13192170216, 35153.64846351504, 35228.0, 39422.0, 40084.0, 179304.0, 179773.0, 181235.0, 181326.0, 181630.0, 27637.861810690818, 27956.440871182054, 28023.859880700467, 28043.0, 28070.859645702458, 36080.0, 36395.81802091079, 37051.62948370482, 37192.81403593073, 37440.0, 31013.0, 31053.0, 31397.68602314039, 32095.197620059684, 32568.674313256564, 31687.841560792047, 31705.682943171196, 31846.6815331853, 31950.201244969063, 32142.517862232555, 31461.056168314986, 31657.20856978594, 31871.52192717065, 31969.0, 31971.520427194075, 28347.57478637781, 28747.8562607194, 29800.254993624465, 29902.0, 29913.401731964805, 22907.541849163255, 23697.40756481102, 25541.818760505575, 26184.73815261823, 26359.20922372332], "unit": "ms", "name": "ext.html", "value": 16912.509410827977}, {"lowerIsBetter": false, "replicates": [331.19684764446214, 332.1182261096788, 334.4581777520416, 337.3691197460749, 337.6977605043486, 12473.750524989495, 12853.228806271607, 14814.333354999024, 15160.0, 16085.0, 9455.33812633116, 9596.56815443305, 9707.320487565856, 9712.66005689801, 9815.607375704963, 4545.090981803644, 4707.388039554853, 4711.0342379812055, 4712.363830882839, 4712.787924543404, 3341.6324204337625, 3976.443297938291, 4640.327152562876, 5266.210068489719, 5298.072837253484, 5237.004969055867, 5243.737813109348, 5263.710495922723, 5268.078086334876, 5286.995470860525, 5244.580433565306, 5384.3538775346815, 5725.885482290372, 5732.570057245724, 5732.971335143297, 5068.189089745623, 5075.0357432087785, 5080.923786143211, 5084.339035925343, 5092.694438333712, 18768.530786730305, 19156.0, 19591.11839967205, 19596.80403195964, 19602.11790469432, 1620.7082725109476, 1644.7697322374877, 1731.5065206416111, 1803.4769916724135, 1915.186045930474, 8711.433756805787, 8830.0, 8870.512121833297, 8874.334424918157, 8937.687180948635, 1680.8907421017716, 1708.555775498367, 1730.1868121982648, 1748.2482532511015, 1770.3272756352503, 55125.794968201226, 57903.420965790225, 58217.70891145517, 58252.81462156602, 58532.0, 9552.713418597314, 9688.564014619358, 9724.465154416575, 9789.608415663437, 9811.362261452983, 12597.307148106942, 12605.747885042249, 12607.117501774972, 12621.495140194473, 12633.873661263453, 6737.258901520829, 7840.9215907841335, 8042.356611471068, 8078.596070196584, 8241.50550966944, 6750.35871592198, 6768.187817461838, 6828.863422731617, 6853.17761868569, 6856.211535673362, 7389.408847292204, 7468.253174682488, 7474.514156579805, 7509.586972716553, 7544.0, 2433.6592876997233, 2940.4854150523574, 2960.2451374899692, 2991.685872983349, 2992.7905046646524, 722.0468980945207, 796.2992566541407, 797.2545669798641, 807.3339494916718, 940.7742141886035, 13024.739505210033, 14466.638334041523, 15957.281922313523, 16193.190340483165, 16391.0, 811.8822770698216, 818.7625588579365, 827.9751607451666, 841.4643276021286, 896.112848280211, 8713.041565427799, 8937.865932011026, 9035.141661542142, 9052.094790520896, 9190.586423610954, 439652.0, 440433.0, 452515.0, 453315.0, 453634.0, 64669.353306467274, 68686.65656671685, 68978.0, 69176.96234556485, 69240.6537967307, 935.6631612619316, 962.6919385796618, 987.4519641598981, 991.5290237137302, 994.1897353656747, 14119.858801411854, 14353.282335882956, 14375.209363485108, 14380.42478300898, 14470.782938255725, 32973.83513082419, 33323.333533329685, 33813.15467113243, 33923.32153356968, 34556.30887382288, 41795.28330658498, 42317.78841105775, 42350.36474452824, 43164.784176078916, 43583.56416435795, 8888.244499217639, 8922.197002269826, 8998.415103018282, 9063.093690630883, 9065.229455496357, 10637.840432393676, 11506.252093613888, 14653.560393188221, 16069.19654017271, 17128.82871171322, 12827.679308017001, 13075.803862941873, 13428.127171733806, 13439.731205376032, 13482.0, 12954.417051232529, 13101.344932753515, 13144.737105257651, 13646.24945628, 13785.931070344985, 13162.868371316164, 13237.0, 13340.733185336432, 13424.127431716906, 13816.447342106203, 8651.48091114535, 8745.825083498421, 8984.820303594022, 9057.728268151966, 9064.456132632064, 13329.3335333231, 13696.178229306273, 13898.861011389758, 13958.16251024901, 14218.146911185362], "unit": "ms", "name": "jquery.html", "value": 8306.67527856501}, {"lowerIsBetter": false, "replicates": [1426.8715815576595, 1614.20903757159, 1621.8540331370175, 1640.7456844189148, 1682.848543631073, 5930.495907847832, 6699.531032827698, 6857.554258973163, 6872.41584465321, 6914.58512489251, 6639.070530125786, 6796.116504854362, 6798.694058767355, 6806.557573757715, 6819.624920629363, 1760.683077046131, 1790.364420630677, 2029.6346657601625, 2074.6887966805025, 2110.8522403431766, 2088.7389076365453, 2090.341542414142, 2090.707300977864, 2095.0886364431444, 2095.821855142307, 2011.658018136913, 2048.8873111978837, 2048.9282875099375, 2055.8972051397373, 2062.886541240231, 2004.0881398963436, 2038.3782946201402, 2039.4799326171806, 2067.0388269454775, 2069.492974221318, 2054.4658388818866, 2075.284027010679, 2075.792420757927, 2077.958440831175, 2080.9687854682193, 6720.32796720324, 6757.763478278286, 6772.8984065239065, 6778.118844550227, 6787.5927444353, 3933.547642021147, 3977.244323578511, 3994.4407782910416, 3998.820053097618, 4000.5199376074765, 2250.3361508355074, 2555.8083143764293, 2657.2692509559834, 2670.719574444675, 2688.8386696798257, 792.5244853088159, 847.4788005376711, 857.5497863621648, 865.9220670139655, 867.869819527076, 8703.260222881063, 8763.561821908943, 8772.078931712205, 8779.473231606187, 8785.121487851227, 3793.791341476245, 3818.541774986964, 3859.6333348331864, 3865.091703449687, 3881.7282790204413, 7739.110002349802, 7746.0317460317465, 7749.883751743729, 7759.262870027338, 7771.067471903295, 4044.352903535479, 4046.858359957387, 4057.9797101014306, 4063.7358571693335, 4064.288749468831, 3687.539057617798, 3715.0, 3717.851285948586, 3721.702263818888, 3723.2739615774663, 3415.1462134466383, 3421.2473255883665, 3427.6572342765526, 3452.482127680818, 3470.0977745786277, 1038.781855810273, 1050.4800123938546, 1056.746380868586, 1057.7831544533353, 1063.7340664833791, 1097.9615713449991, 1107.7895199912152, 1127.053275248795, 1132.0377678972807, 1136.8976792088752, 6228.377162283736, 6240.469560087444, 6249.031400132987, 6250.624962502174, 6253.593516421509, 1088.3919805843602, 1109.4397329348628, 1117.7093955571447, 1124.1681155944705, 1125.2573301621055, 5025.447200807908, 5049.82325618609, 5054.82308119214, 5066.392032955995, 5085.567726743194, 7396.704131834666, 7647.847043059219, 8173.918260817316, 8231.34149268057, 8446.028706698808, 8041.477303975223, 8153.551554664432, 8166.305864001626, 8185.672573097128, 8297.211764882326, 6503.3496650333645, 6517.73929042833, 6535.673216339164, 6586.604803711793, 6592.044153597702, 6477.514186435942, 6510.869782604226, 6525.836854078686, 6527.249366322743, 6532.41208291256, 7242.601656908921, 7376.4836461447185, 7388.667509961957, 7396.667149978156, 7514.211007844097, 7464.365528930101, 7583.734569290048, 7592.810179745329, 7650.693972241048, 7660.846783064196, 5793.449622286044, 5840.2991641003355, 5840.561957853263, 5849.0, 5870.178175055581, 6630.403263706289, 6666.466682665278, 6710.765123220664, 6727.26000139994, 6738.561993470409, 6306.936930630635, 6362.77730279438, 6370.6814659267775, 6418.0, 6427.871442571216, 5971.701414929149, 6034.607750496204, 6136.846578835565, 6321.936780632135, 6361.840953976002, 6183.165272688129, 6291.653959032297, 6331.2085989251345, 6331.366863313816, 6346.524010699124, 5816.73824677882, 5841.707914604168, 5849.473547380756, 5850.444207800252, 5853.180554722428, 6001.879962400815, 6014.36849130835, 6018.097285407049, 6019.789307374396, 6025.969870150797], "unit": "ms", "name": "mootools.html", "value": 3993.0837378735846}, {"lowerIsBetter": false, "replicates": [306.917132374259, 309.91942095055276, 311.954766558849, 313.36699866270123, 314.889788573999, 5134.871628209287, 5161.458046905077, 5232.7122008289525, 5281.498257665516, 5351.652142610733, 5077.64456488046, 5228.424873263938, 5250.107481728106, 5252.474752524746, 5260.605454590902, 3883.941740873889, 4107.075907920716, 4110.547839737626, 4111.342185250345, 4116.629503344699, 3957.5448823385245, 3986.7807270600106, 4100.835966561334, 4103.2409004334295, 4123.051698109437, 4039.939400908989, 4056.1684854604737, 4057.026313684724, 4065.0447144920918, 4072.287349713803, 4065.2479291331197, 4069.2471892699796, 4076.6331030207125, 4081.0, 4084.36692312692, 3570.2680950405365, 3571.2143328467955, 3573.5890372607223, 3582.802945837978, 3587.7847329160336, 4883.853484395474, 5001.0, 5046.798128074873, 5060.620453465968, 5060.696358218519, 4664.976675116603, 4672.0, 4676.0, 4678.69588476748, 4679.064187162581, 5486.588505862036, 5518.613697041209, 5523.972380138114, 5523.978064058162, 5525.613207075507, 3686.9815650921573, 3778.735488515805, 3781.773093614392, 3846.788426636534, 3880.5343358797127, 5750.1949727038245, 5809.535237181015, 5820.592558520905, 5821.592488525805, 5825.388334224887, 3910.2570511602703, 3913.491246137984, 3927.293087244266, 3931.4495970564144, 3954.4661470701085, 3968.9603103969166, 3971.424143499234, 4007.6393124618926, 4010.418489319091, 4014.799260037045, 4432.268675668543, 4555.362249285103, 4579.084183163381, 4614.2617181250835, 4614.953850461452, 5537.252470916455, 5552.666839989613, 5555.361133469622, 5555.638883472561, 5559.444055594489, 1400.0549629000384, 1426.3795249066688, 1428.2073449235565, 1428.8785453236592, 1429.7783843504274, 939.3706216834737, 956.4930586789013, 961.1829944547219, 980.1717548671361, 988.4909271725068, 4856.4415092264135, 4861.343718598015, 4865.1485989952325, 4869.2939523768855, 4872.1473742094995, 5748.252727145528, 5760.510356619734, 5760.683162426023, 5761.020626493506, 5761.9135712964335, 4857.587105096036, 4864.343313652612, 4864.902701946012, 4870.220764677634, 4875.171220892456, 2893.3056066543877, 3030.3787723517066, 3075.7078077582596, 3082.460569400346, 3094.706002929718, 4483.955160448419, 5405.108157154025, 5461.726913654302, 5472.76862705888, 5481.972590137024, 5896.882062358729, 5904.1734157218025, 5943.435373639497, 5952.0476723724, 5961.791337303173, 5443.5100840923715, 5449.591280653967, 5452.7546260417585, 5456.399796022434, 5463.180522921593, 5768.365479797303, 5771.220885180447, 5776.595638305446, 5777.104548794943, 5781.364049954417, 5449.3460784706085, 5522.5581953442825, 5578.581606379456, 5652.604317697722, 5663.575231857545, 5427.8100266492065, 5448.073827449264, 5452.182172674131, 5459.399466058651, 5471.917921231265, 3973.046468847398, 3974.463447434675, 3977.7812220327, 3977.880663580097, 3980.940285895772, 5760.481556659921, 5762.827115186551, 5765.884682306414, 5769.769209231584, 5771.047777116729, 5396.379416367011, 5558.555315574664, 5561.249231353715, 5561.721913904369, 5561.860953476195, 5556.694381809039, 5559.0827513461445, 5559.1661250811085, 5565.805196818092, 5566.359868615161, 5438.945610544002, 5439.891202176013, 5445.455454454523, 5447.754851031634, 5448.237246785532, 5433.022056029952, 5585.16222566602, 5601.131824567198, 5601.663900166003, 5604.803831866028, 5451.836444906659, 5453.890922181455, 5456.454354564512, 5457.290552228344, 5459.153831156177], "unit": "ms", "name": "prototype.html", "value": 4155.074607308535}, {"lowerIsBetter": false, "replicates": [594.9226600541929, 623.5853157650163, 678.3013496099016, 713.7287830624364, 740.8259059121106, 11438.370889601068, 11743.647690569285, 11755.588554400598, 11758.823617645721, 11807.114466415022, 11522.308661480318, 11532.423378831067, 11647.301161930269, 11660.533578656843, 11705.882941170586, 616.7193926763334, 625.0343219725535, 775.9961200193991, 782.9608519574027, 787.7754839870638, 787.9487833290817, 791.3471386106456, 796.040770871099, 796.5977181523323, 797.214743477674, 756.3986630628664, 814.0475643497123, 838.7609531283586, 839.2530647723531, 839.5718183726314, 643.9034144878259, 654.7511945460742, 813.6704634622987, 831.1563762780783, 834.9081601023883, 614.6312212672406, 614.9661768602725, 615.2647586134526, 615.4399496458202, 615.7290792051483, 11645.94177029118, 11707.180497365187, 11747.295162290204, 11753.294802311888, 11784.823227651592, 10020.198384129251, 10176.542055607515, 10244.180465562737, 10383.376997380181, 10489.63286284984, 9100.408473449204, 9506.904930950672, 9555.283353748428, 9843.0, 10093.041161089684, 3195.0734287056725, 3243.140567749548, 3319.8174100424467, 3322.435186018383, 3356.110630682871, 36326.091847703756, 36599.08502287437, 36722.44916326257, 36876.446853297224, 36944.81527592372, 8880.200781929658, 9163.219853642931, 9165.17513423795, 9190.494522801177, 9406.153446189739, 16861.747073793904, 16870.831291686925, 17014.914925425295, 17034.48896533106, 17085.914570427067, 6350.68246587678, 6449.6130232186215, 6456.225252969673, 6477.287498375175, 6650.900236496456, 3552.467129930531, 3622.5834029086463, 3662.1943172502006, 3675.834587443518, 3681.631836816297, 2739.986300068487, 2768.5016696994735, 2768.9169324920285, 2771.237909574843, 2775.153578158681, 487.43214155509145, 490.8920037591724, 493.95554400104163, 501.198083067097, 501.60623910230294, 524.6248932013629, 550.6310771782915, 556.5436342199357, 569.5102212097676, 573.6586730895111, 7206.891896621555, 7270.0, 7461.403087752967, 7465.776026719207, 7571.810704732316, 419.850952911718, 513.7123211001851, 529.5366554265019, 545.5281181777813, 585.8271809816115, 3182.5067114597273, 3304.256542277968, 3339.916502087467, 3382.678645528671, 3412.1810765416617, 48565.5143448561, 48884.0, 49316.26025609619, 49548.50451495511, 49579.00841983212, 43416.0, 43771.0, 44080.77959610181, 44259.02503162032, 44340.0, 37993.24013519714, 41104.38343424851, 41189.588104119175, 41590.37614435786, 41786.58213417827, 7776.222377762178, 8089.352851771727, 8092.393070519617, 8134.0, 8352.331813454788, 33065.66934330626, 33458.0, 34007.149821254665, 34305.14237144091, 34376.48435273523, 40673.79663101665, 41422.1715565681, 44156.337654934556, 44513.33230001488, 45186.32220516629, 10315.690529284133, 10465.162786977176, 10539.473026348805, 10579.36523808574, 11153.21927465102, 10735.516901739284, 10890.128789696964, 10918.23572349928, 10953.83569246446, 10958.671239862817, 10326.741831453974, 10506.422146781695, 10578.8942110581, 10658.253922225369, 11088.390138542458, 10644.254902157085, 10696.893031069902, 10792.0, 10797.0, 11259.887401125883, 10390.688279351632, 10401.58393664245, 10437.217208709226, 10584.100351469904, 10739.0, 9459.432434053979, 9486.193673537826, 9559.761005974906, 9848.901510984799, 9934.105930466292, 9122.498262595622, 9205.982739407173, 9210.447373157633, 9238.861417078884, 9397.295202859676], "unit": "ms", "name": "yui.html", "value": 5662.78456973149}], "name": "dromaeo_css", "value": 6260.642734945863}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 111.0, 112.0, 112.0, 102.0, 112.0, 111.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [160.0, 129.0, 157.0, 163.0, 128.0, 149.0, 154.0, 129.0, 166.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 82.0, 92.0, 72.0, 72.0, 72.0, 96.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 132.0, 94.0, 94.0, 94.0, 134.0, 95.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 69.0, 70.0, 71.0, 70.0, 70.0, 70.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 69.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 84.0, 84.0, 83.0, 85.0, 84.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 121.0, 125.0, 117.0, 125.0, 122.0, 126.0, 126.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [134.0, 143.0, 144.0, 144.0, 144.0, 148.0, 145.0, 145.0, 150.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1508.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2030.4259634888438], "unit": "score", "name": "RayTrace", "value": 364.4501268731268}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [633.7135614702155], "unit": "score", "name": "Splay", "value": 128.59279799999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19699.39110128529}]} 12:33:55 INFO - RETURN: dromaeo_css: 6260.64 12:33:55 INFO - RETURN: kraken: 1508.20 12:33:55 INFO - RETURN: v8_7: 19699.39 12:33:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19699.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1508.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6260.64"}}} 12:33:55 INFO - Return code: 0 12:33:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:33:55 INFO - # TBPL SUCCESS # 12:33:55 INFO - Running post-action listener: _resource_record_post_action 12:33:55 INFO - Running post-run listener: _resource_record_post_run 12:33:56 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505339904; Read time: 8; Write time: 473792 12:33:56 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231501824; Read time: 0; Write time: 297348 12:33:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273838080; Read time: 8; Write time: 176444 12:33:56 INFO - Running post-run listener: _upload_blobber_files 12:33:56 INFO - Blob upload gear active. 12:33:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:33:56 INFO - Copying logs to upload dir... 12:33:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.428592 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 12:33:56.892468) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:33:56.896461) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009384 build_url: 'https://queue.taskcluster.net/v1/task/yH7iu4F9STyxwWXV3e5J2w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:33:56.948361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:33:56.948743) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1449173010.510955-1375571710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:33:56.999168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 12:33:56.999519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 12:33:56.999836) ========= ========= Total master_lag: 0.26 =========