builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1450230638.52 results: success (0) buildid: 20151215170908 builduid: cf5cdf9f14704717af1f2b5c1596f719 revision: 66129e10f1166dbda2ff9d6147d3413a063ba315 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.525366) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.525942) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.526601) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006440 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.564780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.565167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.620324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.620663) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.684181) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.684545) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.684955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.685297) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 17:50:38-- 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% 73.1M=0s 2015-12-15 17:50:38 (73.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104286 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.837843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.838178) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022545 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.880038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:38.880459) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 66129e10f1166dbda2ff9d6147d3413a063ba315 --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 66129e10f1166dbda2ff9d6147d3413a063ba315 --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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 17:50:39,125 truncating revision to first 12 chars 2015-12-15 17:50:39,125 Setting DEBUG logging. 2015-12-15 17:50:39,125 attempt 1/10 2015-12-15 17:50:39,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/66129e10f116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 17:50:39,362 unpacking tar archive at: fx-team-66129e10f116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:39.401381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:39.401689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:39.417785) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:39.418119) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:50:39.418578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-15 17:50:39.418952) ========= /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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:50:39 INFO - MultiFileLogger online at 20151215 17:50:39 in /builds/slave/test 17:50: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 17:50:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:50:39 INFO - {'append_to_log': False, 17:50:39 INFO - 'base_work_dir': '/builds/slave/test', 17:50:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:50:39 INFO - 'branch': 'Fx-Team-Non-PGO', 17:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:50:39 INFO - 'config_files': ('talos/linux_config.py',), 17:50:39 INFO - 'default_actions': ('clobber', 17:50:39 INFO - 'read-buildbot-config', 17:50:39 INFO - 'download-and-extract', 17:50:39 INFO - 'populate-webroot', 17:50:39 INFO - 'create-virtualenv', 17:50:39 INFO - 'install', 17:50:39 INFO - 'run-tests'), 17:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:50:39 INFO - 'download_minidump_stackwalk': True, 17:50:39 INFO - 'download_symbols': 'ondemand', 17:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:50:39 INFO - 'installer_path': 'installer.exe', 17:50:39 INFO - 'log_level': 'info', 17:50:39 INFO - 'log_name': 'talos', 17:50:39 INFO - 'log_to_console': True, 17:50:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:50:39 INFO - 'opt_config_files': (), 17:50:39 INFO - 'pip_index': False, 17:50:39 INFO - 'sps_profile': False, 17:50:39 INFO - 'sps_profile_interval': 0, 17:50:39 INFO - 'suite': 'dromaeojs', 17:50:39 INFO - 'system_bits': '64', 17:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:50:39 INFO - 'title': 'talos-linux64-ix-058', 17:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:50:39 INFO - 'use_talos_json': True, 17:50:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:50:39 INFO - 'work_dir': 'build'} 17:50:39 INFO - ##### 17:50:39 INFO - ##### Running clobber step. 17:50:39 INFO - ##### 17:50:39 INFO - Running pre-action listener: _resource_record_pre_action 17:50:39 INFO - Running main action method: clobber 17:50:39 INFO - rmtree: /builds/slave/test/build 17:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:40 INFO - Running post-action listener: _resource_record_post_action 17:50:40 INFO - ##### 17:50:40 INFO - ##### Running read-buildbot-config step. 17:50:40 INFO - ##### 17:50:40 INFO - Running pre-action listener: _resource_record_pre_action 17:50:40 INFO - Running main action method: read_buildbot_config 17:50:40 INFO - Using buildbot properties: 17:50:40 INFO - { 17:50:40 INFO - "properties": { 17:50:40 INFO - "buildnumber": 2216, 17:50:40 INFO - "product": "firefox", 17:50:40 INFO - "script_repo_revision": "production", 17:50:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:50:40 INFO - "repository": "", 17:50:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:50:40 INFO - "buildid": "20151215170908", 17:50:40 INFO - "slavename": "talos-linux64-ix-058", 17:50:40 INFO - "pgo_build": "False", 17:50:40 INFO - "basedir": "/builds/slave/test", 17:50:40 INFO - "project": "", 17:50:40 INFO - "platform": "ubuntu64_hw", 17:50:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:50:40 INFO - "slavebuilddir": "test", 17:50:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:50:40 INFO - "branch": "fx-team", 17:50:40 INFO - "repo_path": "integration/fx-team", 17:50:40 INFO - "stage_platform": "linux64", 17:50:40 INFO - "builduid": "cf5cdf9f14704717af1f2b5c1596f719", 17:50:40 INFO - "revision": "66129e10f1166dbda2ff9d6147d3413a063ba315" 17:50:40 INFO - }, 17:50:40 INFO - "sourcestamp": { 17:50:40 INFO - "repository": "", 17:50:40 INFO - "hasPatch": false, 17:50:40 INFO - "project": "", 17:50:40 INFO - "branch": "fx-team-linux64-talos", 17:50:40 INFO - "changes": [ 17:50:40 INFO - { 17:50:40 INFO - "category": null, 17:50:40 INFO - "files": [ 17:50:40 INFO - { 17:50:40 INFO - "url": null, 17:50:40 INFO - "name": "https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 17:50:40 INFO - } 17:50:40 INFO - ], 17:50:40 INFO - "repository": "", 17:50:40 INFO - "rev": "66129e10f1166dbda2ff9d6147d3413a063ba315", 17:50:40 INFO - "who": "dwillcoxon@mozilla.com", 17:50:40 INFO - "when": 1450230589, 17:50:40 INFO - "number": 7364488, 17:50:40 INFO - "comments": "Bug 1182783 - Restore search string and selection when selecting an autofilled urlbar popup result. r=mak", 17:50:40 INFO - "project": "", 17:50:40 INFO - "at": "Tue 15 Dec 2015 17:49:49", 17:50:40 INFO - "branch": "fx-team-linux64-talos", 17:50:40 INFO - "revlink": "", 17:50:40 INFO - "properties": [ 17:50:40 INFO - [ 17:50:40 INFO - "buildid", 17:50:40 INFO - "20151215170908", 17:50:40 INFO - "Change" 17:50:40 INFO - ], 17:50:40 INFO - [ 17:50:40 INFO - "builduid", 17:50:40 INFO - "cf5cdf9f14704717af1f2b5c1596f719", 17:50:40 INFO - "Change" 17:50:40 INFO - ], 17:50:40 INFO - [ 17:50:40 INFO - "pgo_build", 17:50:40 INFO - "False", 17:50:40 INFO - "Change" 17:50:40 INFO - ] 17:50:40 INFO - ], 17:50:40 INFO - "revision": "66129e10f1166dbda2ff9d6147d3413a063ba315" 17:50:40 INFO - } 17:50:40 INFO - ], 17:50:40 INFO - "revision": "66129e10f1166dbda2ff9d6147d3413a063ba315" 17:50:40 INFO - } 17:50:40 INFO - } 17:50:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:50:40 INFO - Running post-action listener: _resource_record_post_action 17:50:40 INFO - ##### 17:50:40 INFO - ##### Running download-and-extract step. 17:50:40 INFO - ##### 17:50:40 INFO - Running pre-action listener: _resource_record_pre_action 17:50:40 INFO - Running main action method: download_and_extract 17:50:40 INFO - mkdir: /builds/slave/test/build/tests 17:50: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')]} 17:50:40 INFO - https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/test_packages.json 17:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/test_packages.json 17:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:50:44 INFO - Downloaded 1302 bytes. 17:50:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:50:44 INFO - Using the following test package requirements: 17:50:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:50:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'jsshell-linux-x86_64.zip'], 17:50:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:50:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:50:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:50:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:50:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:50:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:50:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:50:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:50: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')]} 17:50:44 INFO - https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:50:48 INFO - Downloaded 21868751 bytes. 17:50:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:50:49 INFO - Return code: 0 17:50:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:50:49 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')]} 17:50:49 INFO - https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:50:50 INFO - Downloaded 21868751 bytes. 17:50:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:50:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:50:51 INFO - Return code: 0 17:50:51 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')]} 17:50:51 INFO - https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:50:53 INFO - Downloaded 11132052 bytes. 17:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:50:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:50:53 INFO - Return code: 0 17:50: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')]} 17:50:53 INFO - https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:50:57 INFO - Downloaded 57740357 bytes. 17:50:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:50:57 INFO - mkdir: /builds/slave/test/properties 17:50:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:57 INFO - Contents: 17:50:57 INFO - build_url:https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:50:57 INFO - Running post-action listener: _resource_record_post_action 17:50:57 INFO - Running post-action listener: set_extra_try_arguments 17:50:57 INFO - ##### 17:50:57 INFO - ##### Running populate-webroot step. 17:50:57 INFO - ##### 17:50:57 INFO - Running pre-action listener: _resource_record_pre_action 17:50:57 INFO - Running main action method: populate_webroot 17:50:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:50:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:50:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:50:57 INFO - '--tppagecycles', 17:50:57 INFO - '7'], 17:50:57 INFO - 'tests': ['tsvgm']}}, 17:50:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:50:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:50:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'tests': ['damp', 'tps']}, 17:50:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['damp', 'tps']}, 17:50:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:50:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:57 INFO - 'other': {'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'other_l64': {'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'other_nol64': {'tests': ['a11yr', 17:50:57 INFO - 'ts_paint', 17:50:57 INFO - 'tpaint', 17:50:57 INFO - 'sessionrestore', 17:50:57 INFO - 'sessionrestore_no_auto_restore']}, 17:50:57 INFO - 'svgr': {'tests': ['tsvgx', 17:50:57 INFO - 'tsvgr_opacity', 17:50:57 INFO - 'tart', 17:50:57 INFO - 'tscrollx', 17:50:57 INFO - 'cart']}, 17:50:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['tsvgx', 17:50:57 INFO - 'tsvgr_opacity', 17:50:57 INFO - 'tart', 17:50:57 INFO - 'tscrollx', 17:50:57 INFO - 'cart']}, 17:50:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'tests': ['tp5o']}, 17:50:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'talos_options': ['--e10s'], 17:50:57 INFO - 'tests': ['tp5o']}, 17:50:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'talos_options': ['--xperf_path', 17:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:57 INFO - 'tests': ['tp5n']}, 17:50:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:57 INFO - 'talos_options': ['--e10s', 17:50:57 INFO - '--xperf_path', 17:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:57 INFO - 'tests': ['tp5n']}}, 17:50:57 INFO - 'talos.zip': {'path': '', 17:50:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:50:57 INFO - Running post-action listener: _resource_record_post_action 17:50:57 INFO - ##### 17:50:57 INFO - ##### Running create-virtualenv step. 17:50:57 INFO - ##### 17:50:57 INFO - Running pre-action listener: _resource_record_pre_action 17:50:57 INFO - Running main action method: create_virtualenv 17:50:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50: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 17:50:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:57 INFO - Using real prefix '/usr' 17:50:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:51:00 INFO - Installing pip.................done. 17:51:00 INFO - Return code: 0 17:51:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:00 INFO - Using env: {'DISPLAY': ':0', 17:51:00 INFO - 'HOME': '/home/cltbld', 17:51:00 INFO - 'LANG': 'en_US.UTF-8', 17:51:00 INFO - 'LANGUAGE': 'en_US:en', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MAIL': '/var/mail/cltbld', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SHLVL': '1', 17:51:00 INFO - 'TERM': 'linux', 17:51:00 INFO - 'TMOUT': '86400', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - '_': '/tools/buildbot/bin/python'} 17:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51: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 17:51:00 INFO - Cleaning up... 17:51:00 INFO - Return code: 0 17:51:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:00 INFO - Using env: {'DISPLAY': ':0', 17:51:00 INFO - 'HOME': '/home/cltbld', 17:51:00 INFO - 'LANG': 'en_US.UTF-8', 17:51:00 INFO - 'LANGUAGE': 'en_US:en', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MAIL': '/var/mail/cltbld', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SHLVL': '1', 17:51:00 INFO - 'TERM': 'linux', 17:51:00 INFO - 'TMOUT': '86400', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - '_': '/tools/buildbot/bin/python'} 17:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:00 INFO - Downloading/unpacking psutil>=0.7.1 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:02 INFO - Installing collected packages: psutil 17:51:02 INFO - Running setup.py install for psutil 17:51:02 INFO - building 'psutil._psutil_linux' extension 17:51: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 17:51:02 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 17:51:02 INFO - building 'psutil._psutil_posix' extension 17:51:02 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 17:51: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 17:51:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:51:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:51:03 INFO - Successfully installed psutil 17:51:03 INFO - Cleaning up... 17:51:03 INFO - Return code: 0 17:51:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:03 INFO - Using env: {'DISPLAY': ':0', 17:51:03 INFO - 'HOME': '/home/cltbld', 17:51:03 INFO - 'LANG': 'en_US.UTF-8', 17:51:03 INFO - 'LANGUAGE': 'en_US:en', 17:51:03 INFO - 'LOGNAME': 'cltbld', 17:51:03 INFO - 'MAIL': '/var/mail/cltbld', 17:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:03 INFO - 'MOZ_NO_REMOTE': '1', 17:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:03 INFO - 'NO_EM_RESTART': '1', 17:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:03 INFO - 'PWD': '/builds/slave/test', 17:51:03 INFO - 'SHELL': '/bin/bash', 17:51:03 INFO - 'SHLVL': '1', 17:51:03 INFO - 'TERM': 'linux', 17:51:03 INFO - 'TMOUT': '86400', 17:51:03 INFO - 'USER': 'cltbld', 17:51:03 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:03 INFO - '_': '/tools/buildbot/bin/python'} 17:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:51: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) 17:51:05 INFO - Installing collected packages: mozsystemmonitor 17:51:05 INFO - Running setup.py install for mozsystemmonitor 17:51:05 INFO - Successfully installed mozsystemmonitor 17:51:05 INFO - Cleaning up... 17:51:05 INFO - Return code: 0 17:51:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:05 INFO - Using env: {'DISPLAY': ':0', 17:51:05 INFO - 'HOME': '/home/cltbld', 17:51:05 INFO - 'LANG': 'en_US.UTF-8', 17:51:05 INFO - 'LANGUAGE': 'en_US:en', 17:51:05 INFO - 'LOGNAME': 'cltbld', 17:51:05 INFO - 'MAIL': '/var/mail/cltbld', 17:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:05 INFO - 'MOZ_NO_REMOTE': '1', 17:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:05 INFO - 'NO_EM_RESTART': '1', 17:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:05 INFO - 'PWD': '/builds/slave/test', 17:51:05 INFO - 'SHELL': '/bin/bash', 17:51:05 INFO - 'SHLVL': '1', 17:51:05 INFO - 'TERM': 'linux', 17:51:05 INFO - 'TMOUT': '86400', 17:51:05 INFO - 'USER': 'cltbld', 17:51:05 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:05 INFO - '_': '/tools/buildbot/bin/python'} 17:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:07 INFO - Downloading docopt-0.6.1.tar.gz 17:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:07 INFO - Running setup.py install for blobuploader 17:51:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:08 INFO - Running setup.py install for requests 17:51:08 INFO - Running setup.py install for docopt 17:51:08 INFO - Successfully installed blobuploader requests docopt 17:51:08 INFO - Cleaning up... 17:51:08 INFO - Return code: 0 17:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:08 INFO - Using env: {'DISPLAY': ':0', 17:51:08 INFO - 'HOME': '/home/cltbld', 17:51:08 INFO - 'LANG': 'en_US.UTF-8', 17:51:08 INFO - 'LANGUAGE': 'en_US:en', 17:51:08 INFO - 'LOGNAME': 'cltbld', 17:51:08 INFO - 'MAIL': '/var/mail/cltbld', 17:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:08 INFO - 'MOZ_NO_REMOTE': '1', 17:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:08 INFO - 'NO_EM_RESTART': '1', 17:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:08 INFO - 'PWD': '/builds/slave/test', 17:51:08 INFO - 'SHELL': '/bin/bash', 17:51:08 INFO - 'SHLVL': '1', 17:51:08 INFO - 'TERM': 'linux', 17:51:08 INFO - 'TMOUT': '86400', 17:51:08 INFO - 'USER': 'cltbld', 17:51:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:08 INFO - '_': '/tools/buildbot/bin/python'} 17:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:08 INFO - Running setup.py (path:/tmp/pip-_zVOQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:08 INFO - Running setup.py (path:/tmp/pip-klLx9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:08 INFO - Running setup.py (path:/tmp/pip-tO5M0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:08 INFO - Running setup.py (path:/tmp/pip-xiNtqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:09 INFO - Running setup.py (path:/tmp/pip-RNM5mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:09 INFO - Running setup.py (path:/tmp/pip-9ZI8vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:09 INFO - Running setup.py (path:/tmp/pip-7L217K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:09 INFO - Running setup.py (path:/tmp/pip-iMV68s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:09 INFO - Running setup.py (path:/tmp/pip-EQFret-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:09 INFO - Running setup.py (path:/tmp/pip-QlW7D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:09 INFO - Running setup.py (path:/tmp/pip-mh60d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:09 INFO - Running setup.py (path:/tmp/pip-1ZYkw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:09 INFO - Running setup.py (path:/tmp/pip-aSxdfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:09 INFO - Running setup.py (path:/tmp/pip-o00vIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:09 INFO - Running setup.py (path:/tmp/pip-cYF9fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:09 INFO - Running setup.py (path:/tmp/pip-8anFcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:09 INFO - Running setup.py (path:/tmp/pip-CwGsV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:09 INFO - Running setup.py install for manifestparser 17:51:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for mozcrash 17:51:10 INFO - Running setup.py install for mozdebug 17:51:10 INFO - Running setup.py install for mozdevice 17:51:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for mozfile 17:51:10 INFO - Running setup.py install for mozhttpd 17:51:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for mozinfo 17:51:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for mozInstall 17:51:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for mozleak 17:51:10 INFO - Running setup.py install for mozlog 17:51:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:10 INFO - Running setup.py install for moznetwork 17:51:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Running setup.py install for mozprocess 17:51:11 INFO - Running setup.py install for mozprofile 17:51:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Running setup.py install for mozrunner 17:51:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Running setup.py install for mozscreenshot 17:51:11 INFO - Running setup.py install for moztest 17:51:11 INFO - Running setup.py install for mozversion 17:51:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:11 INFO - Cleaning up... 17:51:11 INFO - Return code: 0 17:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:11 INFO - Using env: {'DISPLAY': ':0', 17:51:11 INFO - 'HOME': '/home/cltbld', 17:51:11 INFO - 'LANG': 'en_US.UTF-8', 17:51:11 INFO - 'LANGUAGE': 'en_US:en', 17:51:11 INFO - 'LOGNAME': 'cltbld', 17:51:11 INFO - 'MAIL': '/var/mail/cltbld', 17:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:11 INFO - 'MOZ_NO_REMOTE': '1', 17:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:11 INFO - 'NO_EM_RESTART': '1', 17:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:11 INFO - 'PWD': '/builds/slave/test', 17:51:11 INFO - 'SHELL': '/bin/bash', 17:51:11 INFO - 'SHLVL': '1', 17:51:11 INFO - 'TERM': 'linux', 17:51:11 INFO - 'TMOUT': '86400', 17:51:11 INFO - 'USER': 'cltbld', 17:51:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:11 INFO - '_': '/tools/buildbot/bin/python'} 17:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:11 INFO - Running setup.py (path:/tmp/pip-WoeXGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:12 INFO - Running setup.py (path:/tmp/pip-H5PX_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:12 INFO - Running setup.py (path:/tmp/pip-bsWiew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:12 INFO - Running setup.py (path:/tmp/pip-MXvQA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:12 INFO - Running setup.py (path:/tmp/pip-wInMHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:12 INFO - Running setup.py (path:/tmp/pip-ldJzVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:12 INFO - Running setup.py (path:/tmp/pip-Qolqms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:12 INFO - Running setup.py (path:/tmp/pip-kYR5xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:12 INFO - Running setup.py (path:/tmp/pip-ROwABf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:12 INFO - Running setup.py (path:/tmp/pip-jBDKYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:12 INFO - Running setup.py (path:/tmp/pip-RLoXXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:12 INFO - Running setup.py (path:/tmp/pip-kc8sab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:12 INFO - Running setup.py (path:/tmp/pip-QOMbYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51: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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:12 INFO - Running setup.py (path:/tmp/pip-7WBdl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:12 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)) 17:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:12 INFO - Running setup.py (path:/tmp/pip-4rbkGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51: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)) 17:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:13 INFO - Running setup.py (path:/tmp/pip-MAt73o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51: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)) 17:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:13 INFO - Running setup.py (path:/tmp/pip-SRV3w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:14 INFO - Downloading blessings-1.5.1.tar.gz 17:51: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 17:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:14 INFO - Installing collected packages: blessings 17:51:14 INFO - Running setup.py install for blessings 17:51:15 INFO - Successfully installed blessings 17:51:15 INFO - Cleaning up... 17:51:15 INFO - Return code: 0 17:51:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:15 INFO - Reading from file tmpfile_stdout 17:51:15 INFO - Current package versions: 17:51:15 INFO - argparse == 1.2.1 17:51:15 INFO - blessings == 1.5.1 17:51:15 INFO - blobuploader == 1.2.4 17:51:15 INFO - docopt == 0.6.1 17:51:15 INFO - manifestparser == 1.1 17:51:15 INFO - mozInstall == 1.12 17:51:15 INFO - mozcrash == 0.16 17:51:15 INFO - mozdebug == 0.1 17:51:15 INFO - mozdevice == 0.47 17:51:15 INFO - mozfile == 1.2 17:51:15 INFO - mozhttpd == 0.7 17:51:15 INFO - mozinfo == 0.9 17:51:15 INFO - mozleak == 0.1 17:51:15 INFO - mozlog == 3.1 17:51:15 INFO - moznetwork == 0.27 17:51:15 INFO - mozprocess == 0.22 17:51:15 INFO - mozprofile == 0.27 17:51:15 INFO - mozrunner == 6.11 17:51:15 INFO - mozscreenshot == 0.1 17:51:15 INFO - mozsystemmonitor == 0.0 17:51:15 INFO - moztest == 0.7 17:51:15 INFO - mozversion == 1.4 17:51:15 INFO - psutil == 3.1.1 17:51:15 INFO - requests == 1.2.3 17:51:15 INFO - wsgiref == 0.1.2 17:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:15 INFO - Using env: {'DISPLAY': ':0', 17:51:15 INFO - 'HOME': '/home/cltbld', 17:51:15 INFO - 'LANG': 'en_US.UTF-8', 17:51:15 INFO - 'LANGUAGE': 'en_US:en', 17:51:15 INFO - 'LOGNAME': 'cltbld', 17:51:15 INFO - 'MAIL': '/var/mail/cltbld', 17:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:15 INFO - 'MOZ_NO_REMOTE': '1', 17:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:15 INFO - 'NO_EM_RESTART': '1', 17:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:15 INFO - 'PWD': '/builds/slave/test', 17:51:15 INFO - 'SHELL': '/bin/bash', 17:51:15 INFO - 'SHLVL': '1', 17:51:15 INFO - 'TERM': 'linux', 17:51:15 INFO - 'TMOUT': '86400', 17:51:15 INFO - 'USER': 'cltbld', 17:51:15 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:15 INFO - '_': '/tools/buildbot/bin/python'} 17:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51: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)) 17:51:15 INFO - Cleaning up... 17:51:15 INFO - Return code: 0 17:51:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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')]} 17:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51: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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51: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 17:51: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 17:51:15 INFO - Using env: {'DISPLAY': ':0', 17:51:15 INFO - 'HOME': '/home/cltbld', 17:51:15 INFO - 'LANG': 'en_US.UTF-8', 17:51:15 INFO - 'LANGUAGE': 'en_US:en', 17:51:15 INFO - 'LOGNAME': 'cltbld', 17:51:15 INFO - 'MAIL': '/var/mail/cltbld', 17:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:15 INFO - 'MOZ_NO_REMOTE': '1', 17:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:15 INFO - 'NO_EM_RESTART': '1', 17:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:15 INFO - 'PWD': '/builds/slave/test', 17:51:15 INFO - 'SHELL': '/bin/bash', 17:51:15 INFO - 'SHLVL': '1', 17:51:15 INFO - 'TERM': 'linux', 17:51:15 INFO - 'TMOUT': '86400', 17:51:15 INFO - 'USER': 'cltbld', 17:51:15 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:15 INFO - '_': '/tools/buildbot/bin/python'} 17:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:15 INFO - Downloading/unpacking jsonschema 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:51: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 17:51:17 INFO - Downloading/unpacking functools32 (from jsonschema) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:17 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51: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 17:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:17 INFO - warning: no files found matching '*.txt' 17:51:17 INFO - no previously-included directories found matching 'build' 17:51:17 INFO - no previously-included directories found matching 'dist' 17:51:17 INFO - no previously-included directories found matching '.git*' 17:51:17 INFO - Installing collected packages: jsonschema, functools32 17:51:17 INFO - Running setup.py install for functools32 17:51:17 INFO - warning: no files found matching '*.txt' 17:51:17 INFO - no previously-included directories found matching 'build' 17:51:17 INFO - no previously-included directories found matching 'dist' 17:51:17 INFO - no previously-included directories found matching '.git*' 17:51:17 INFO - Successfully installed jsonschema functools32 17:51:17 INFO - Cleaning up... 17:51:17 INFO - Return code: 0 17:51:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:51:17 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')]} 17:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:17 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')]} 17:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:17 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 0x7ff734358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', '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 17:51:17 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 17:51:17 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 17:51:17 INFO - Using env: {'DISPLAY': ':0', 17:51:17 INFO - 'HOME': '/home/cltbld', 17:51:17 INFO - 'LANG': 'en_US.UTF-8', 17:51:17 INFO - 'LANGUAGE': 'en_US:en', 17:51:17 INFO - 'LOGNAME': 'cltbld', 17:51:17 INFO - 'MAIL': '/var/mail/cltbld', 17:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:17 INFO - 'MOZ_NO_REMOTE': '1', 17:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:17 INFO - 'NO_EM_RESTART': '1', 17:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:17 INFO - 'PWD': '/builds/slave/test', 17:51:17 INFO - 'SHELL': '/bin/bash', 17:51:17 INFO - 'SHLVL': '1', 17:51:17 INFO - 'TERM': 'linux', 17:51:17 INFO - 'TMOUT': '86400', 17:51:17 INFO - 'USER': 'cltbld', 17:51:17 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:17 INFO - '_': '/tools/buildbot/bin/python'} 17:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:18 INFO - Downloading/unpacking flake8 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:51: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 17:51:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:51: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 17:51:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51: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 17:51:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:51:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:51:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:51:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:51:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:51:20 INFO - no previously-included directories found matching 'docs/_build' 17:51:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:51:20 INFO - Running setup.py install for pep8 17:51:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:51:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:51:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:51:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:51:20 INFO - no previously-included directories found matching 'docs/_build' 17:51:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:51:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:51:20 INFO - Cleaning up... 17:51:20 INFO - Return code: 0 17:51:20 INFO - Running post-action listener: _resource_record_post_action 17:51:20 INFO - Running post-action listener: _start_resource_monitoring 17:51:20 INFO - Starting resource monitoring. 17:51:20 INFO - ##### 17:51:20 INFO - ##### Running install step. 17:51:20 INFO - ##### 17:51:20 INFO - Running pre-action listener: _resource_record_pre_action 17:51:20 INFO - Running main action method: install 17:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:20 INFO - Reading from file tmpfile_stdout 17:51:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:21 INFO - Reading from file tmpfile_stdout 17:51:21 INFO - Output received: 17:51:21 INFO - Usage: mozinstall [options] installer 17:51:21 INFO - Options: 17:51:21 INFO - -h, --help show this help message and exit 17:51:21 INFO - -d DEST, --destination=DEST 17:51:21 INFO - Directory to install application into. [default: 17:51:21 INFO - "/builds/slave/test"] 17:51:21 INFO - --app=APP Application being installed. [default: firefox] 17:51:21 INFO - mkdir: /builds/slave/test/build/application 17:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:51:35 INFO - Reading from file tmpfile_stdout 17:51:35 INFO - Output received: 17:51:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:51:35 INFO - Running post-action listener: _resource_record_post_action 17:51:35 INFO - ##### 17:51:35 INFO - ##### Running run-tests step. 17:51:35 INFO - ##### 17:51:35 INFO - Running pre-action listener: _resource_record_pre_action 17:51:35 INFO - Running main action method: run_tests 17:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:35 INFO - Python 2.7.3 17:51:35 INFO - Return code: 0 17:51:35 INFO - grabbing minidump binary from tooltool 17:51: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')]} 17:51: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 0xdaa0b0>, '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 0xdaafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51: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 17:51: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 17:51:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:35 INFO - Return code: 0 17:51:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:51:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:51:36 INFO - Return code: 0 17:51: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/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test/build 17:51: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/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 17:51:36 INFO - Using env: {'DISPLAY': ':0', 17:51:36 INFO - 'HOME': '/home/cltbld', 17:51:36 INFO - 'LANG': 'en_US.UTF-8', 17:51:36 INFO - 'LANGUAGE': 'en_US:en', 17:51:36 INFO - 'LOGNAME': 'cltbld', 17:51:36 INFO - 'MAIL': '/var/mail/cltbld', 17:51:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:36 INFO - 'MOZ_NO_REMOTE': '1', 17:51:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:36 INFO - 'NO_EM_RESTART': '1', 17:51:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:36 INFO - 'PWD': '/builds/slave/test', 17:51:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:36 INFO - 'SHELL': '/bin/bash', 17:51:36 INFO - 'SHLVL': '1', 17:51:36 INFO - 'TERM': 'linux', 17:51:36 INFO - 'TMOUT': '86400', 17:51:36 INFO - 'USER': 'cltbld', 17:51:36 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560', 17:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:36 INFO - '_': '/tools/buildbot/bin/python'} 17:51: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/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 17:51:36 INFO - mozversion INFO | application_buildid: 20151215170908 17:51:36 INFO - mozversion INFO | application_changeset: 66129e10f1166dbda2ff9d6147d3413a063ba315 17:51:36 INFO - mozversion INFO | application_display_name: Nightly 17:51:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:36 INFO - mozversion INFO | application_name: Firefox 17:51:36 INFO - mozversion INFO | application_remotingname: firefox 17:51:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:51:36 INFO - mozversion INFO | application_vendor: Mozilla 17:51:36 INFO - mozversion INFO | application_version: 46.0a1 17:51:36 INFO - mozversion INFO | platform_buildid: 20151215170908 17:51:36 INFO - mozversion INFO | platform_changeset: 66129e10f1166dbda2ff9d6147d3413a063ba315 17:51:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:51:36 INFO - mozversion INFO | platform_version: 46.0a1 17:51:36 INFO - 2015-12-15 17:51:36,820 DEBUG : using testdate: 1450230696 17:51:36 INFO - 2015-12-15 17:51:36,820 DEBUG : actual date: 1450230696 17:51:36 INFO - 2015-12-15 17:51:36,870 INFO : starting webserver on 'localhost:38528' 17:51:36 INFO - 2015-12-15 17:51:36,871 INFO : Starting test suite talos-linux64-ix-058 17:51:36 INFO - 2015-12-15 17:51:36,871 INFO : Starting test dromaeo_css 17:51:36 INFO - 2015-12-15 17:51:36,871 DEBUG : operating with platform_type : linux_ 17:51:36 INFO - 2015-12-15 17:51:36,872 INFO : Initialising browser for dromaeo_css test... 17:51:36 INFO - 2015-12-15 17:51:36,888 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQvo_f/profile http://localhost:38528/getInfo.html 17:51:41 INFO - 2015-12-15 17:51:41,413 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:51:41 INFO - 2015-12-15 17:51:41,414 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:51:41 INFO - 2015-12-15 17:51:41,414 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:51:41 INFO - 2015-12-15 17:51:41,414 DEBUG : BROWSER_OUTPUT: __metrics 17:51:41 INFO - 2015-12-15 17:51:41,490 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] 17:51:41 INFO - 2015-12-15 17:51:41,551 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] 17:51:41 ERROR - 2015-12-15 17:51:41,559 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:51:42 INFO - 2015-12-15 17:51:42,708 INFO : Browser initialized. 17:51:42 INFO - 2015-12-15 17:51:42,709 INFO : Running cycle 1/1 for dromaeo_css test... 17:51:42 INFO - 2015-12-15 17:51:42,709 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQvo_f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:51:54 INFO - 2015-12-15 17:51:54,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 142934016 17:51:54 INFO - 2015-12-15 17:51:54,715 DEBUG : BROWSER_OUTPUT: 17:52:46 INFO - 2015-12-15 17:52:46,039 DEBUG : BROWSER_OUTPUT: 1450230766033 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] 17:54:58 INFO - 2015-12-15 17:54:58,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38528/tests/dromaeo/cssquery-ext.html) 17:54:59 INFO - 2015-12-15 17:54:59,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 261832704 17:54:59 INFO - 2015-12-15 17:54:59,277 DEBUG : BROWSER_OUTPUT: 17:58:01 INFO - 2015-12-15 17:58:01,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-ext.html (next: http://localhost:38528/tests/dromaeo/cssquery-jquery.html) 17:58:02 INFO - 2015-12-15 17:58:02,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 222298112 17:58:02 INFO - 2015-12-15 17:58:02,415 DEBUG : BROWSER_OUTPUT: 18:01:04 INFO - 2015-12-15 18:01:04,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38528/tests/dromaeo/cssquery-mootools.html) 18:01:05 INFO - 2015-12-15 18:01:05,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 223637504 18:01:05 INFO - 2015-12-15 18:01:05,014 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-15 18:04:07,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38528/tests/dromaeo/cssquery-prototype.html) 18:04:07 INFO - 2015-12-15 18:04:07,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 207724544 18:04:07 INFO - 2015-12-15 18:04:07,566 DEBUG : BROWSER_OUTPUT: 18:07:10 INFO - 2015-12-15 18:07:10,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38528/tests/dromaeo/cssquery-yui.html) 18:07:10 INFO - 2015-12-15 18:07:10,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 213008384 18:07:10 INFO - 2015-12-15 18:07:10,849 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-yui.html (next: http://localhost:38528/tests/dromaeo/cssquery-dojo.html) 18:10:13 INFO - 2015-12-15 18:10:13,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 249200640 18:10:13 INFO - 2015-12-15 18:10:13,622 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:10:13 INFO - 2015-12-15 18:10:13,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:10:13 INFO - 2015-12-15 18:10:13,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:10:13 INFO - 2015-12-15 18:10:13,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:10:13 INFO - 2015-12-15 18:10:13,623 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2616.777573906218;2712.674479062513;2730.8666903235157;2731.317170707324;2738.602902579125;4524.253498172806;4686.929696054558;4724.692894961825;4733.455652599952;4745.715257084573;4643;4651.7208967461975;4701.929471057937;4720.197566413709;4747.7388743619085;4238.364245363205;4304.741715497064;4354.063876266602;4433.9778301108445;4457.554244575533;4168.7290326128705;4404.911901761963;4426.911461770763;4488.820447182109;4512.029913568582;4284.957150428519;4326.961529232993;4336.21948049351;4343.804528796211;4360.542143074963;4353.586409291112;4362.563743625644;4363.934540981888;4385.101054283864;4412.05140894706;4188.036751547131;4260.10537787062;4343.4787825460835;4350.847720329805;4405.207062728708;4533.433320834895;4546.363509108727;4632.745199014053;4638.67529272951;4676.298555216711;5033.144365457881;5073.492650734934;5136.512031357015;5136.64043516954;5189.506996835295;4765.118453086156;4871.14754917888;5033.899322013539;5101.15830887903;5103.438621751604;4500.414946057024;4655.25515917455;4736.265878788793;4774.379330686988;4802.51974802517;5147.974260128675;5165.896682066337;5188.377394712583;5199.29809475716;5242.370915490165;4717.198076326964;4829.034193161382;4920.778564964585;4932.654714170046;4942.0363029209675;4928.531789479994;4951.158303088484;4956.578690811321;4979.385503547101;4979.925301120486;4932.556069953722;4932.950670493249;4937.679050861682;4939.160342741742;4990.775415106329;4701.811927522861;4831.541003604652;4914.533119353656;4920.089783390084;4973.577245934064;4084.509858816961;4089.2230476209425;4150.315197992298;4181.770002649883;4225.366195070764;3676.338259113332;3678.1172518595345;3690.2619476104887;3694.353488139565;3702.9259414811554;4197.76912269822;4317.546657600907;4320.9135817284105;4347.043650396908;4368.191884501377;4915.459299477055;4929.260610908321;4988.72562009093;5033.79864805411;5035.018171456604;4307.396964424983;4310.331898555729;4319.827206911688;4346.717463364871;4368.825246990148;4217.810198541011;4444.822207111744;4446.26636604963;4455.376247325377;4474.284114541658;4575.0392417592675;4625.537446255347;4635.629149668019;4669.906601868011;4684.48470668233;4984.22744474607;5069.569086627678;5074;5077.035363280965;5121.7695203715175;4624.838130665546;4797.616190704665;4797.928031079607;4804.543568361;4846.127697014571;4846.491118432514;4891.364122664031;4899.755012249445;4908.435529914105;4969.403671559436;5048.59611231108;5105.92341114891;5110.3356563646485;5111.744412779421;5155.2782610435315;4675.438947326206;4915.7542122893;4933.112039832865;4933.210686290176;4933.396174931249;4801.927971080367;4823.517648235148;4866.95133048665;4954.9752251238515;4970.179920313108;4834.516548345137;4857.781399837087;4864.805407783649;4870.672661852513;4910.754462276944;4725.6219502439035;4969.35398398206;4979.3526841510375;4988.251762235694;5021.6735912165595;4697.224957881911;4741.241401375763;4754.595859351994;4827.927581086356;4855.101806165871 18:10:13 INFO - 2015-12-15 18:10:13,624 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.9084946408574;574.8878968601122;578.1934201788505;581.3575998521634;582.7639805878615;26617.60073598895;35224.82387588062;35928.10179745501;36001.279974400495;36057.459138112885;40218.59781402185;40686.59313406865;40705.185896282055;40741.59258407415;40766.79616601913;7034.155901291852;7163.534370265942;7830.9216907830905;7999.920000799976;8002.839943201133;10113.089821916026;10386.844197337046;10404.323718958281;10419.114375278072;10425.061744442999;9809.313348065638;9903.752406189868;9907.851382229272;9909.058639429242;9920.503974801268;7114.608696521689;7256;7281.854362912712;7282.70869165238;9965.90034099657;10055.748606284902;10307.330023548446;10320.071193592537;10335.121514671262;10339.327943683711;36835.447468287995;36846.63153368459;37120.25759484795;37435.438468422995;37440.43839342412;2993.1619146638977;3025.273934255763;3078.4458797416455;3537.327907697529;3613.6567026132475;28022.579661305095;28471.57292640612;28601.85699071512;28645.28386790326;28848.855755721088;3097.1947293703574;3099.9845000775076;3118.5322201669933;3147.6065491813524;3167.43437815368;204785;205377.99999999852;205500;207258;207334;50568.74715626472;52173.217401739006;54166;55135;55211.171832422544;47905.520944790806;48093.67156955821;48118.75940620274;48356;48426.515734842906;13495.460181592824;13580.913526917822;13585.796213056812;13598.932005340108;13611.25138117413;11391.373474458984;11417.828732569018;11439.256448330832;11496.77006459866;11540.538378464767;18884.33904813325;19006;19072.852979258543;19103.140358683893;19136.330228441937;7113.857722845514;7282.817929551804;7292.854142917218;7361.153467351323;7387.741429049957;827.1976183102502;834.7579202031465;882.9823403532022;1022.749426390539;1053.7312985188728;25857.09500167485;26025.089121880643;26696.733032669814;26732.064377747076;26760.464790704078;921.9723408297762;931.329442801182;970.0445061614304;977.0815433492494;1051.8842927277992;12981.805272920914;14151.221682807338;14788.186649734367;15054.473093441677;15392;255672;257799;259268;259898;260089;46799.29801052987;46980;47131.76434117876;47147.29279060817;47200.52799471961;1116.9776604467866;1188.7919614067503;1207.5471698113208;1222.480445810527;1232.7472868062025;24705.888235029826;26982.460350793266;28637.713622863506;29060.854695726386;29528.704712952596;40659.3901091478;40916.79541602392;40992.385114222714;41025;41043.384349235384;199398;200990.89100198675;227230;231092;327873;27685.30786730348;27773.444531109668;27784.166475004975;27950.16149515518;28215.43569128647;38518.614813851505;38951;39425.80287098546;39471.605283946796;39752.80123599479;33387.499187512694;35125.824370877985;36141.27717445584;36205;36781.26437471289;31743.365132696756;32297.838510808237;32353;32411.837940810146;32664.83667581742;32331.19172020718;32692.182695432806;33212.83393583017;33222.667773321955;33254.50118248277;25406;26937.326566835985;27238;27317.726822732315;27373.178804635892;23297.301080967598;23331.533369332858;23506.88246558756;23515.17696880601;23712.644310335705 18:10:13 INFO - 2015-12-15 18:10:13,626 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.91500209945406;329.231245042825;334.54000748970157;334.8108318799878;336.7272509267494;12473.251604903711;12818;14391.856081439195;15140.545783626496;15884.52346429606;14975.47585834496;15299.868489615621;16024.359025638989;16240.106794126319;16244;5007.699538027712;5011.824586139486;5113.769880355374;5123.333966584339;5127.974360128194;3614;3698.33429982603;5062.26597143414;5575.8606034849045;5763.625364351325;5649.548036157118;5670.461306175906;5695.373508914016;5720.22776925114;5722.084466485363;5670.291213598301;5823.4467725566;5830.416958304157;5831.795887143972;5836.6206196597295;5102;5106.974465127651;5110.514501122388;5114.3095682083185;5122.257272695476;18964.14661340243;19229.807701922942;19406.902965485224;19439.80560194408;19679.508012299662;1908.6373589018042;1913.3494611832043;1983.345495986321;1984.335247692025;2028.148177765342;12710.364481775874;12724;12835.165714228546;13010.349482525837;13170.143940643828;1753.898930210896;1761.806201317854;1765.48800847754;1815.1650240889207;1820.2718912435;51678.22482662763;53408;54292.45707542953;54883.45116548823;55297.44702552963;9086.863697044417;9214.078592140866;9395.436273823592;9480.194183494343;9532.95233523828;12008.219465734874;12008.399580020963;12014.819777703342;12015.879841201477;12020;6889.242183359826;6894.793156205322;6968.198657154391;7014.754483593049;7052.435805135577;6680.699368528428;6688.632125233159;6733.595984240961;6748.763793267212;6756.763513277012;5685.03866166172;5730.799422020209;5744.885102297931;5755.424457554295;5786.103154011135;1547.6130967258187;1578.1556867076058;1608.750643650236;1630.07650971852;1632.0778760000562;853.6030745703277;855.5294587976588;867.9696210632598;881.1584936385736;958.6980101268078;15658.138802365751;15767.921160394355;15921.283542240628;16225.837741622669;16442.588935276475;793.7539362797552;852.1138016462809;901.553730903194;908.6728777640044;933.1834644685899;6572.572782769201;8812.8678069829;8943.821123577492;8969.416987895765;9006.324525660602;427238;435164;436647;437876;438872;60761.69619151876;61870;62230.37769622336;62413.375866240756;62697.68651156715;897.7665806890255;899.9370044096981;904.8687940248759;911.3392790227165;1090.536521978172;13239.3380330985;13624.411605354218;13774.449022039005;13862.861371386158;13884.652883677989;28418.43163136767;28469.857650711612;28728.856355718086;28885.85557072201;29053.837846485905;44133.33799992938;44893.77553112213;45032;46440.30339544842;52026.47973520368;12511.249325040526;13654.86345136536;13696.52062177819;13741.03812733099;14440.350184241945;17803;17836.91081544584;18140;18538.536536586154;18668.533286667942;14712.485063022743;14730.26348682583;14850.628734281729;14955.10269383797;15251.389944402543;14509.782353264498;14601;14695.779563306345;14704.41182352694;15297.847021529642;14864.256787160815;15228.77156842626;15350.846491534941;15432.302446730626;15600.765988510408;13664.385102670205;13745;13900.860991389956;13901.37443815051;13901.791473128114;14245.21651309188;14494.63763405881;14733.852661473247;14801.777973330623;14815.33331000086 18:10:13 INFO - 2015-12-15 18:10:13,626 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1443.1485423600075;1596.353476841879;1667.4164042585094;1674.2047527424475;1726.6891959447294;6071.241094863142;6973.721051157954;7122.750703725371;7130.786076417703;7137.286271372866;6605.83485412865;6803.693833777479;6804.591724496534;6808.706345794296;6809.216940051895;1753.8947663140189;1791.9641607167914;2038.959220815579;2064.194963964055;2073.8859362735043;2099.6010757956014;2106.715593394895;2110.09266015614;2110.3774386555924;2111.2927169398195;1974.4965033916403;1993.8703984240979;2035.236786205173;2036.2974773703122;2036.3178335257633;2039.3474088291753;2057.2799520167896;2078.0129438516733;2085.4994801247744;2085.947851303722;2081.323569839808;2094.7695753467106;2102.4638717127036;2103.0431153825125;2103.568768402474;7196.064511613509;7271.89092163618;7272.4909256352075;7277.89083163753;7291.34377905991;4228.619424251832;4276;4278.144371125787;4283.91432171358;4303.569643035671;2616.1105224223857;2680.932976675579;2688.0457437609757;2696.4741875334316;2713.66079240095;786.626352482572;800.4436916343144;812.8333691593268;814.2305521282391;816.4325793573469;9603.567839447242;9658.56536455854;9728.075832795874;9801.90198098017;9803.215742740564;3773.9245215095543;3857.8263978121054;3900.297946369624;3931.9803400983383;3941.3496773032703;8393.53835539039;8397.034341050736;8403.579821009047;8412.621432035574;8426.494410335277;4249.2563801334645;4281.37920001598;4285.935710964338;4289.399484072233;4290.399344091829;3882.495275614152;3886.067343837459;3891.9102651257695;3896.12337224128;3896.688264938855;2844.2320573445054;2951.439226546949;3085.645150807641;3105.4410206163107;3320.750943679234;1033.0805583031108;1043.9321444106108;1047.9056884880397;1050.2963014780116;1054.4253381906879;910.8724778531011;914.2411798207472;943.6084025129632;969.2100937735722;1213.3629844331797;6709.563878347892;6731.461483081342;6765.898511522331;6766.932330676728;6772.762953296611;1016.9575442505261;1045.5347370420243;1052.1845569683403;1065.5151905882806;1075.8708954925303;5317.946820531823;5362.51737343641;5391.838244852661;5431.37539182999;5434.619576629598;8367.874481882776;8450.281726053354;8506.149385061568;8523.190296921783;8547.358948078794;8382.916170838214;8398.454100483448;8409.537475438787;8421.284190843848;8423.831523369498;6622.503312251601;6666.166729158856;6708.83227919306;6709;6760.459163266927;6779.627120508222;6855.211650660238;6858.279880612464;6958.756443524452;6962.094927659372;7572.280633339824;7816.257455541714;7821.452498325063;7930.722424715107;7931.048274207132;7898.210178982055;8031;8045.356371490384;8156.184381562034;8167.101618821806;6356;6372.490200783834;6388.041793730978;6426.710798014007;6451.161349024596;5654.6324488908085;5754.424557544212;6370.8088757337355;6867.587944723333;6927.376536111573;6295.5907865988565;6336.714847831767;6357.110004599453;6368.4586810121655;6539.901901471577;6294.4964402846745;6326.525510586633;6365.363463653783;6411.4229719325485;6412.236634925246;6477.708503117276;6496.512761542808;6508.642024688687;6514.869702605826;6541.34586541342;5780.450857168562;5833.154192642128;5838.12428135783;5840.2991641003355;5841.1238314253205;5953.880922381615;5986.970065149646;5988.820335389945;5998;6002.309734380602 18:10:13 INFO - 2015-12-15 18:10:13,627 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.7796652510617;299.0684019279944;302.0741427524637;302.57337154612003;304.68312954527283;5250.474952504747;5283.101872681644;5303.867403314919;5317.627766056377;5321.973390133049;4961.503849615036;5054.823081192159;5130.666506677073;5211.661242019276;5226.843194704155;4101.8974525636795;4120.876373708786;4124.505059392877;4124.649404800595;4148.688848336372;3870.8838734838;4120.3201471757275;4122.093139509303;4127.195196936598;4133.545310015896;3915.4714113594587;3964.940525892114;4034.6368826805583;4035.3745169498775;4046.696497762665;4003.4195041718785;4028.053407449247;4037.9798101009455;4045.7977101144825;4054.5742697016685;3540.309639620275;3546.0425685065147;3550.467429885512;3551.5027896094566;3551.94672079919;5037.622178336603;5042.39491261051;5042.940982393665;5046.142155833517;5053.5957123430035;4545.545445455461;4629.583337499607;4650.395448591696;4686.461056978457;4688.578027977498;5502.174673798922;5511.366192887829;5511.448855114497;5518.144687573393;5519.972400137974;3890.396988466792;3897.259520691088;3899;3900.3759398496104;3909.58949310324;5729.9713501432225;5790.7394167262155;5795.3335366432975;5796.478316951495;5796.594238403313;3905.1408690088133;3983.103801644607;3987.860424885173;4003.619656132663;4018.778967156776;4036.011177261531;4043.7978101094827;4045.7977101144825;4046.968023154077;4048.291548978917;4621.7752295641685;4624.28323609841;4624.745638989888;4628.74541900192;4633.166030114544;5507.476789704971;5525.088360420566;5530.419305972815;5541.889162216814;5542.11326187808;1420.898803427352;1431.9856801431852;1442.4879167895456;1462.4661998370518;1465.230753854235;978.5107446276861;1005.5173516712019;1012.3318609717699;1018.8930162332848;1019.0115587879744;4866.562009419169;4877.122118018719;4880.389951256093;4882.8779280517565;4886.413630364308;5733.082706766981;5737.540996720336;5740.454656807597;5741.88516229673;5747.1379293106365;4693.953060469352;4751.382320298409;4793.760311984387;4886.071646387175;4886.413630364308;3044.2845931206148;3083.892063777757;3098.9225269368444;3102.4260511805387;3112.828794416329;5474.069408200616;5476.096444086681;5476.890462190813;5481.643693159932;5481.75332110056;5926;5926.614770039933;5928.555358348141;5928.962431574457;5934.465898069195;5336.0661884170895;5498.752556134984;5506.311711036121;5509.669419834822;5511.311086114236;5805.332386775575;5816.47651711348;5818.127280907897;5819.476247137778;5824.9417505826095;5651.660900345993;5656.151577263443;5661.46216109469;5666.518345940476;5672.971635141798;5317.787288508571;5492.917606235989;5502.504774570308;5503.834884953458;5507.173923911445;3920.2355540669296;3974.165425260612;3979.045029192915;3983.2830090583975;3985.940210896781;5818.156367326798;5818.359980402068;5819.301683797971;5819.359870414166;5820.476157145878;5574.526165275997;5579.191017302387;5582.162675598693;5582.916256256078;5583.162525621027;5400.972995134999;5486.369067557122;5552.361478430033;5577;5577.358603760457;5406.540444062299;5459.099248623933;5480.123180291134;5483.341998960151;5486.1222204447095;5627.746751396279;5635.915461268166;5639.154126881001;5645.9153112702525;5650.180723795109;5377.623566350474;5500.147477141049;5502.889942201054;5507.146392309199;5507.889842203213 18:10:13 INFO - 2015-12-15 18:10:13,628 DEBUG : BROWSER_OUTPUT: |5;yui.html;785.7053604898164;787.5983248543243;794.1740589786618;796.6853093028254;817.9959100204499;10885.401302928336;11146.442677866095;11158.051565616923;11168.497417616207;11204.383758893278;11401.201915865893;11458.541658333657;11460.770784584303;11472.827907581393;11496.080313574916;619.1424876545982;629.0815409502133;629.1286568103187;629.9433051025406;630.6121735132906;792.4848848248656;805.60525342582;806.899137607799;807.9717209897655;808.1877712898529;830.3066939105854;830.887830142929;836.1596595421623;837.476577139288;838.266516797802;825.2531459029587;825.859603867344;826.7850358906668;827.2389401750404;827.9668813247463;481.14836738971826;487.7439344344212;615.9507239420881;616.214326733414;623.2769986815273;11421.31472111676;11573.247738896946;11582.247153934968;11628.825567616492;11660.766784664344;11080.778384432348;11424.657260282205;11576.884231157665;11611.245269057485;12007.3395963222;9139.314551408672;9238.353315267934;9311.161995420445;9467.384619999679;9567.521623918776;3273.623533293654;3288.1122097033667;3355.5637767090366;3364.747643926715;3402.132456223672;39507.20985580301;39518.60481395178;39530.99999999971;39664;39689.60310396888;9017.954910225408;9047.457152570736;9179.0820917909;9384.5307734613;9526.142647161789;17050.573735656708;17067.146642667816;17071.91464042672;17110.14449277531;17160.656786864194;6389.776357827547;6514.456321489041;6528.967355163194;6552.279249282575;6648.66756662165;3488.2849015952174;3503.9124021899656;3514.8242587870504;3648.726345524043;3655.3420384331075;2552.0429838810446;2584.741525847438;2590.9481810363686;2592.844429334246;2599.9480010399684;449.4224920976595;456.30413619230274;457.5653129526963;465.57399979019493;466.25864874848475;432.88744926319384;486.69581511555276;500.7496251874063;510.2117228881387;607.5807692692028;7550.093988721389;8019.198080191934;8710.564471776386;8822.911770882338;8850.513221772735;546.4317110205421;581.7033313010395;582.8397190772572;596.3023262782555;643.7521554201572;3626.1297288650535;3642.3261696585687;3837.2325534893134;3856.36369998947;3866.729328947003;51981.48018519842;52335.73832130815;52540;52559.73720131375;52922.73538632359;41616.79191604022;41793;42048.789756051636;42380.57619423766;44991;35921.28157436837;36403.817980909924;39458.80270598629;39950.60049399527;41183;8147.470414423044;8164.8367032657825;8204.876926846222;8282.627281772455;8292.212239837207;30602;30634.84682576573;30986.53520197154;31792.68207317897;31801.36397271995;35110;40130.1973960525;40400.1919961605;40458.39312410375;40680.79659601683;9867.457289849128;10132.088112069949;10139.008992347128;10211.642592509226;10232.130268927225;11123;11163.274387164809;11243.718907027389;11336.886631133913;11391.715207119889;10781.784364312827;10833.729156771144;10911.563537458731;11213.831792523282;11562;10283.691489255334;10586.841197381891;10729.624463144064;10804.081653059578;11073.667789966314;8139.75580732579;9654.372465789702;10564.207684423545;10779.67660970172;11519.827202592136;9248.722538323862;9260.351775375659;9425.010373910914;9578.377405468622;9765.365251258645;9301.395409298373;9335.953320233355;9633.470159141314;9640.228781697308;9652.420854748738 18:10:13 INFO - 2015-12-15 18:10:13,628 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:10:13 INFO - 2015-12-15 18:10:13,628 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: __startTimestamp1450231813622__endTimestamp 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,629 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4629.30 Median:4741.24 stddev:479.24 (10.1%) stddev-sans-first:453.96 18:10:13 INFO - 2015-12-15 18:10:13,630 DEBUG : BROWSER_OUTPUT: Values: 2616.8 2712.7 2730.9 2731.3 2738.6 4524.3 4686.9 4724.7 4733.5 4745.7 4643.0 4651.7 4701.9 4720.2 4747.7 4238.4 4304.7 4354.1 4434.0 4457.6 4168.7 4404.9 4426.9 4488.8 4512.0 4285.0 4327.0 4336.2 4343.8 4360.5 4353.6 4362.6 4363.9 4385.1 4412.1 4188.0 4260.1 4343.5 4350.8 4405.2 4533.4 4546.4 4632.7 4638.7 4676.3 5033.1 5073.5 5136.5 5136.6 5189.5 4765.1 4871.1 5033.9 5101.2 5103.4 4500.4 4655.3 4736.3 4774.4 4802.5 5148.0 5165.9 5188.4 5199.3 5242.4 4717.2 4829.0 4920.8 4932.7 4942.0 4928.5 4951.2 4956.6 4979.4 4979.9 4932.6 4933.0 4937.7 4939.2 4990.8 4701.8 4831.5 4914.5 4920.1 4973.6 4084.5 4089.2 4150.3 4181.8 4225.4 3676.3 3678.1 3690.3 3694.4 3702.9 4197.8 4317.5 4320.9 4347.0 4368.2 4915.5 4929.3 4988.7 5033.8 5035.0 4307.4 4310.3 4319.8 4346.7 4368.8 4217.8 4444.8 4446.3 4455.4 4474.3 4575.0 4625.5 4635.6 4669.9 4684.5 4984.2 5069.6 5074.0 5077.0 5121.8 4624.8 4797.6 4797.9 4804.5 4846.1 4846.5 4891.4 4899.8 4908.4 4969.4 5048.6 5105.9 5110.3 5111.7 5155.3 4675.4 4915.8 4933.1 4933.2 4933.4 4801.9 4823.5 4867.0 4955.0 4970.2 4834.5 4857.8 4864.8 4870.7 4910.8 4725.6 4969.4 4979.4 4988.3 5021.7 4697.2 4741.2 4754.6 4827.9 4855.1 18:10:13 INFO - 2015-12-15 18:10:13,630 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,630 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39609.30 Median:17455.40 stddev:61475.14 (352.2%) stddev-sans-first:61577.72 18:10:13 INFO - 2015-12-15 18:10:13,631 DEBUG : BROWSER_OUTPUT: Values: 571.9 574.9 578.2 581.4 582.8 26617.6 35224.8 35928.1 36001.3 36057.5 40218.6 40686.6 40705.2 40741.6 40766.8 7034.2 7163.5 7830.9 7999.9 8002.8 10113.1 10386.8 10404.3 10419.1 10425.1 9809.3 9903.8 9907.9 9909.1 9920.5 7114.6 7256.0 7281.9 7282.7 9965.9 10055.7 10307.3 10320.1 10335.1 10339.3 36835.4 36846.6 37120.3 37435.4 37440.4 2993.2 3025.3 3078.4 3537.3 3613.7 28022.6 28471.6 28601.9 28645.3 28848.9 3097.2 3100.0 3118.5 3147.6 3167.4 204785.0 205378.0 205500.0 207258.0 207334.0 50568.7 52173.2 54166.0 55135.0 55211.2 47905.5 48093.7 48118.8 48356.0 48426.5 13495.5 13580.9 13585.8 13598.9 13611.3 11391.4 11417.8 11439.3 11496.8 11540.5 18884.3 19006.0 19072.9 19103.1 19136.3 7113.9 7282.8 7292.9 7361.2 7387.7 827.2 834.8 883.0 1022.7 1053.7 25857.1 26025.1 26696.7 26732.1 26760.5 922.0 931.3 970.0 977.1 1051.9 12981.8 14151.2 14788.2 15054.5 15392.0 255672.0 257799.0 259268.0 259898.0 260089.0 46799.3 46980.0 47131.8 47147.3 47200.5 1117.0 1188.8 1207.5 1222.5 1232.7 24705.9 26982.5 28637.7 29060.9 29528.7 40659.4 40916.8 40992.4 41025.0 41043.4 199398.0 200990.9 227230.0 231092.0 327873.0 27685.3 27773.4 27784.2 27950.2 28215.4 38518.6 38951.0 39425.8 39471.6 39752.8 33387.5 35125.8 36141.3 36205.0 36781.3 31743.4 32297.8 32353.0 32411.8 32664.8 32331.2 32692.2 33212.8 33222.7 33254.5 25406.0 26937.3 27238.0 27317.7 27373.2 23297.3 23331.5 23506.9 23515.2 23712.6 18:10:13 INFO - 2015-12-15 18:10:13,631 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,631 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25203.99 Median:14690.38 stddev:70882.97 (482.5%) stddev-sans-first:71057.20 18:10:13 INFO - 2015-12-15 18:10:13,631 DEBUG : BROWSER_OUTPUT: Values: 326.9 329.2 334.5 334.8 336.7 12473.3 12818.0 14391.9 15140.5 15884.5 14975.5 15299.9 16024.4 16240.1 16244.0 5007.7 5011.8 5113.8 5123.3 5128.0 3614.0 3698.3 5062.3 5575.9 5763.6 5649.5 5670.5 5695.4 5720.2 5722.1 5670.3 5823.4 5830.4 5831.8 5836.6 5102.0 5107.0 5110.5 5114.3 5122.3 18964.1 19229.8 19406.9 19439.8 19679.5 1908.6 1913.3 1983.3 1984.3 2028.1 12710.4 12724.0 12835.2 13010.3 13170.1 1753.9 1761.8 1765.5 1815.2 1820.3 51678.2 53408.0 54292.5 54883.5 55297.4 9086.9 9214.1 9395.4 9480.2 9533.0 12008.2 12008.4 12014.8 12015.9 12020.0 6889.2 6894.8 6968.2 7014.8 7052.4 6680.7 6688.6 6733.6 6748.8 6756.8 5685.0 5730.8 5744.9 5755.4 5786.1 1547.6 1578.2 1608.8 1630.1 1632.1 853.6 855.5 868.0 881.2 958.7 15658.1 15767.9 15921.3 16225.8 16442.6 793.8 852.1 901.6 908.7 933.2 6572.6 8812.9 8943.8 8969.4 9006.3 427238.0 435164.0 436647.0 437876.0 438872.0 60761.7 61870.0 62230.4 62413.4 62697.7 897.8 899.9 904.9 911.3 1090.5 13239.3 13624.4 13774.4 13862.9 13884.7 28418.4 28469.9 28728.9 28885.9 29053.8 44133.3 44893.8 45032.0 46440.3 52026.5 12511.2 13654.9 13696.5 13741.0 14440.4 17803.0 17836.9 18140.0 18538.5 18668.5 14712.5 14730.3 14850.6 14955.1 15251.4 14509.8 14601.0 14695.8 14704.4 15297.8 14864.3 15228.8 15350.8 15432.3 15600.8 13664.4 13745.0 13900.9 13901.4 13901.8 14245.2 14494.6 14733.9 14801.8 14815.3 18:10:13 INFO - 2015-12-15 18:10:13,631 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,632 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4975.13 Median:6311.06 stddev:2593.76 (41.1%) stddev-sans-first:2587.45 18:10:13 INFO - 2015-12-15 18:10:13,632 DEBUG : BROWSER_OUTPUT: Values: 1443.1 1596.4 1667.4 1674.2 1726.7 6071.2 6973.7 7122.8 7130.8 7137.3 6605.8 6803.7 6804.6 6808.7 6809.2 1753.9 1792.0 2039.0 2064.2 2073.9 2099.6 2106.7 2110.1 2110.4 2111.3 1974.5 1993.9 2035.2 2036.3 2036.3 2039.3 2057.3 2078.0 2085.5 2085.9 2081.3 2094.8 2102.5 2103.0 2103.6 7196.1 7271.9 7272.5 7277.9 7291.3 4228.6 4276.0 4278.1 4283.9 4303.6 2616.1 2680.9 2688.0 2696.5 2713.7 786.6 800.4 812.8 814.2 816.4 9603.6 9658.6 9728.1 9801.9 9803.2 3773.9 3857.8 3900.3 3932.0 3941.3 8393.5 8397.0 8403.6 8412.6 8426.5 4249.3 4281.4 4285.9 4289.4 4290.4 3882.5 3886.1 3891.9 3896.1 3896.7 2844.2 2951.4 3085.6 3105.4 3320.8 1033.1 1043.9 1047.9 1050.3 1054.4 910.9 914.2 943.6 969.2 1213.4 6709.6 6731.5 6765.9 6766.9 6772.8 1017.0 1045.5 1052.2 1065.5 1075.9 5317.9 5362.5 5391.8 5431.4 5434.6 8367.9 8450.3 8506.1 8523.2 8547.4 8382.9 8398.5 8409.5 8421.3 8423.8 6622.5 6666.2 6708.8 6709.0 6760.5 6779.6 6855.2 6858.3 6958.8 6962.1 7572.3 7816.3 7821.5 7930.7 7931.0 7898.2 8031.0 8045.4 8156.2 8167.1 6356.0 6372.5 6388.0 6426.7 6451.2 5654.6 5754.4 6370.8 6867.6 6927.4 6295.6 6336.7 6357.1 6368.5 6539.9 6294.5 6326.5 6365.4 6411.4 6412.2 6477.7 6496.5 6508.6 6514.9 6541.3 5780.5 5833.2 5838.1 5840.3 5841.1 5953.9 5987.0 5988.8 5998.0 6002.3 18:10:13 INFO - 2015-12-15 18:10:13,632 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,632 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4605.67 Median:5092.74 stddev:1353.38 (26.6%) stddev-sans-first:1317.91 18:10:13 INFO - 2015-12-15 18:10:13,633 DEBUG : BROWSER_OUTPUT: Values: 293.8 299.1 302.1 302.6 304.7 5250.5 5283.1 5303.9 5317.6 5322.0 4961.5 5054.8 5130.7 5211.7 5226.8 4101.9 4120.9 4124.5 4124.6 4148.7 3870.9 4120.3 4122.1 4127.2 4133.5 3915.5 3964.9 4034.6 4035.4 4046.7 4003.4 4028.1 4038.0 4045.8 4054.6 3540.3 3546.0 3550.5 3551.5 3551.9 5037.6 5042.4 5042.9 5046.1 5053.6 4545.5 4629.6 4650.4 4686.5 4688.6 5502.2 5511.4 5511.4 5518.1 5520.0 3890.4 3897.3 3899.0 3900.4 3909.6 5730.0 5790.7 5795.3 5796.5 5796.6 3905.1 3983.1 3987.9 4003.6 4018.8 4036.0 4043.8 4045.8 4047.0 4048.3 4621.8 4624.3 4624.7 4628.7 4633.2 5507.5 5525.1 5530.4 5541.9 5542.1 1420.9 1432.0 1442.5 1462.5 1465.2 978.5 1005.5 1012.3 1018.9 1019.0 4866.6 4877.1 4880.4 4882.9 4886.4 5733.1 5737.5 5740.5 5741.9 5747.1 4694.0 4751.4 4793.8 4886.1 4886.4 3044.3 3083.9 3098.9 3102.4 3112.8 5474.1 5476.1 5476.9 5481.6 5481.8 5926.0 5926.6 5928.6 5929.0 5934.5 5336.1 5498.8 5506.3 5509.7 5511.3 5805.3 5816.5 5818.1 5819.5 5824.9 5651.7 5656.2 5661.5 5666.5 5673.0 5317.8 5492.9 5502.5 5503.8 5507.2 3920.2 3974.2 3979.0 3983.3 3985.9 5818.2 5818.4 5819.3 5819.4 5820.5 5574.5 5579.2 5582.2 5582.9 5583.2 5401.0 5486.4 5552.4 5577.0 5577.4 5406.5 5459.1 5480.1 5483.3 5486.1 5627.7 5635.9 5639.2 5645.9 5650.2 5377.6 5500.1 5502.9 5507.1 5507.9 18:10:13 INFO - 2015-12-15 18:10:13,633 DEBUG : BROWSER_OUTPUT: 18:10:13 INFO - 2015-12-15 18:10:13,633 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12213.64 Median:21406.73 stddev:13728.20 (64.1%) stddev-sans-first:13739.88 18:10:13 INFO - 2015-12-15 18:10:13,634 DEBUG : BROWSER_OUTPUT: Values: 785.7 787.6 794.2 796.7 818.0 10885.4 11146.4 11158.1 11168.5 11204.4 11401.2 11458.5 11460.8 11472.8 11496.1 619.1 629.1 629.1 629.9 630.6 792.5 805.6 806.9 808.0 808.2 830.3 830.9 836.2 837.5 838.3 825.3 825.9 826.8 827.2 828.0 481.1 487.7 616.0 616.2 623.3 11421.3 11573.2 11582.2 11628.8 11660.8 11080.8 11424.7 11576.9 11611.2 12007.3 9139.3 9238.4 9311.2 9467.4 9567.5 3273.6 3288.1 3355.6 3364.7 3402.1 39507.2 39518.6 39531.0 39664.0 39689.6 9018.0 9047.5 9179.1 9384.5 9526.1 17050.6 17067.1 17071.9 17110.1 17160.7 6389.8 6514.5 6529.0 6552.3 6648.7 3488.3 3503.9 3514.8 3648.7 3655.3 2552.0 2584.7 2590.9 2592.8 2599.9 449.4 456.3 457.6 465.6 466.3 432.9 486.7 500.7 510.2 607.6 7550.1 8019.2 8710.6 8822.9 8850.5 546.4 581.7 582.8 596.3 643.8 3626.1 3642.3 3837.2 3856.4 3866.7 51981.5 52335.7 52540.0 52559.7 52922.7 41616.8 41793.0 42048.8 42380.6 44991.0 35921.3 36403.8 39458.8 39950.6 41183.0 8147.5 8164.8 8204.9 8282.6 8292.2 30602.0 30634.8 30986.5 31792.7 31801.4 35110.0 40130.2 40400.2 40458.4 40680.8 9867.5 10132.1 10139.0 10211.6 10232.1 11123.0 11163.3 11243.7 11336.9 11391.7 10781.8 10833.7 10911.6 11213.8 11562.0 10283.7 10586.8 10729.6 10804.1 11073.7 8139.8 9654.4 10564.2 10779.7 11519.8 9248.7 9260.4 9425.0 9578.4 9765.4 9301.4 9336.0 9633.5 9640.2 9652.4 18:10:13 INFO - 2015-12-15 18:10:13,634 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:10:13 INFO - 2015-12-15 18:10:13,634 DEBUG : BROWSER_OUTPUT: 18:10:14 INFO - 2015-12-15 18:10:14,396 INFO : Browser exited with error code: 0 18:10:14 INFO - 2015-12-15 18:10:14,415 INFO : Completed test dromaeo_css (00:18:37) 18:10:14 INFO - 2015-12-15 18:10:14,415 INFO : Starting test kraken 18:10:14 INFO - 2015-12-15 18:10:14,415 DEBUG : operating with platform_type : linux_ 18:10:14 INFO - 2015-12-15 18:10:14,415 INFO : Initialising browser for kraken test... 18:10:14 INFO - 2015-12-15 18:10:14,421 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZfqB7/profile http://localhost:38528/getInfo.html 18:10:19 INFO - 2015-12-15 18:10:19,020 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:10:19 INFO - 2015-12-15 18:10:19,020 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:10:19 INFO - 2015-12-15 18:10:19,021 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:10:19 INFO - 2015-12-15 18:10:19,021 DEBUG : BROWSER_OUTPUT: __metrics 18:10:19 INFO - 2015-12-15 18:10:19,081 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] 18:10:19 INFO - 2015-12-15 18:10:19,145 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] 18:10:19 ERROR - 2015-12-15 18:10:19,161 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 18:10:19 INFO - 2015-12-15 18:10:19,941 INFO : Browser initialized. 18:10:19 INFO - 2015-12-15 18:10:19,942 INFO : Running cycle 1/1 for kraken test... 18:10:19 INFO - 2015-12-15 18:10:19,942 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZfqB7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:10:31 INFO - 2015-12-15 18:10:31,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 143147008 18:10:31 INFO - 2015-12-15 18:10:31,941 DEBUG : BROWSER_OUTPUT: 18:10:34 INFO - 2015-12-15 18:10:34,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:35 INFO - 2015-12-15 18:10:35,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 179568640 18:10:35 INFO - 2015-12-15 18:10:35,159 DEBUG : BROWSER_OUTPUT: 18:10:37 INFO - 2015-12-15 18:10:37,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-dft) 18:10:38 INFO - 2015-12-15 18:10:38,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 168259584 18:10:38 INFO - 2015-12-15 18:10:38,461 DEBUG : BROWSER_OUTPUT: 18:10:41 INFO - 2015-12-15 18:10:41,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-fft) 18:10:42 INFO - 2015-12-15 18:10:42,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 154013696 18:10:42 INFO - 2015-12-15 18:10:42,035 DEBUG : BROWSER_OUTPUT: 18:10:44 INFO - 2015-12-15 18:10:44,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator) 18:10:44 INFO - 2015-12-15 18:10:44,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 156741632 18:10:44 INFO - 2015-12-15 18:10:44,661 DEBUG : BROWSER_OUTPUT: 18:10:46 INFO - 2015-12-15 18:10:46,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:47 INFO - 2015-12-15 18:10:47,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 156090368 18:10:47 INFO - 2015-12-15 18:10:47,496 DEBUG : BROWSER_OUTPUT: 18:10:50 INFO - 2015-12-15 18:10:50,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:51 INFO - 2015-12-15 18:10:51,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 156590080 18:10:51 INFO - 2015-12-15 18:10:51,105 DEBUG : BROWSER_OUTPUT: 18:10:54 INFO - 2015-12-15 18:10:54,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:55 INFO - 2015-12-15 18:10:55,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 157331456 18:10:55 INFO - 2015-12-15 18:10:55,114 DEBUG : BROWSER_OUTPUT: 18:10:57 INFO - 2015-12-15 18:10:57,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial) 18:10:58 INFO - 2015-12-15 18:10:58,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 159363072 18:10:58 INFO - 2015-12-15 18:10:58,541 DEBUG : BROWSER_OUTPUT: 18:11:00 INFO - 2015-12-15 18:11:00,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:11:00 INFO - 2015-12-15 18:11:00,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 165265408 18:11:00 INFO - 2015-12-15 18:11:00,900 DEBUG : BROWSER_OUTPUT: 18:11:02 INFO - 2015-12-15 18:11:02,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:11:03 INFO - 2015-12-15 18:11:03,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 166170624 18:11:03 INFO - 2015-12-15 18:11:03,359 DEBUG : BROWSER_OUTPUT: 18:11:05 INFO - 2015-12-15 18:11:05,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:06 INFO - 2015-12-15 18:11:06,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 179335168 18:11:06 INFO - 2015-12-15 18:11:06,066 DEBUG : BROWSER_OUTPUT: 18:11:08 INFO - 2015-12-15 18:11:08,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:09 INFO - 2015-12-15 18:11:09,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 182263808 18:11:09 INFO - 2015-12-15 18:11:09,236 DEBUG : BROWSER_OUTPUT: 18:11:11 INFO - 2015-12-15 18:11:11,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:12 INFO - 2015-12-15 18:11:12,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 181125120 18:11:12 INFO - 2015-12-15 18:11:12,419 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38528/tests/kraken/driver.html?testName=ai-astar) 18:11:14 INFO - 2015-12-15 18:11:14,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 238452736 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;106;111;114;113;101;112;112;113 18:11:14 INFO - 2015-12-15 18:11:14,453 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;131;153;170;129;153;156;130;168;137 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;160;160;162;162;162;164 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;84;89;72;72;72;115;94;72 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;130;95;94;95;130;95;95;126 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;112;110;110;110;109 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;146;146;145;146;146;147 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;72;72;73;71;80;70;70 18:11:14 INFO - 2015-12-15 18:11:14,454 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;69;69;68;69;69 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;85;85;82;83;84;93;84;83;85 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;128;125;118;123;136;126;129;124;139 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;149;148;150;148;144;148;151;139;136 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;70;71;70;69;71;72;70;72 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:11:14 INFO - 2015-12-15 18:11:14,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 18:11:14 INFO - 2015-12-15 18:11:14,456 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:11:14 INFO - 2015-12-15 18:11:14,456 DEBUG : BROWSER_OUTPUT: __startTimestamp1450231874448__endTimestamp 18:11:14 INFO - 2015-12-15 18:11:14,456 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:112.50 stddev:4.06 (3.6%) stddev-sans-first:4.28 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 106.0 111.0 114.0 113.0 101.0 112.0 112.0 113.0 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,457 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.00 stddev:15.31 (10.0%) stddev-sans-first:16.16 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 152.0 131.0 153.0 170.0 129.0 153.0 156.0 130.0 168.0 137.0 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 160.0 160.0 162.0 162.0 162.0 164.0 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:73.50 stddev:14.26 (19.4%) stddev-sans-first:14.85 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 84.0 89.0 72.0 72.0 72.0 115.0 94.0 72.0 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:95.00 stddev:16.37 (17.2%) stddev-sans-first:16.96 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 130.0 95.0 94.0 95.0 130.0 95.0 95.0 126.0 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.83 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 112.0 110.0 110.0 110.0 109.0 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:11:14 INFO - 2015-12-15 18:11:14,458 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 147.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:2.87 (4.0%) stddev-sans-first:3.04 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 72.0 72.0 73.0 71.0 80.0 70.0 70.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 69.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:3.27 (3.9%) stddev-sans-first:3.22 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 85.0 82.0 83.0 84.0 93.0 84.0 83.0 85.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.00 stddev:6.47 (5.1%) stddev-sans-first:6.50 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: Values: 121.0 128.0 125.0 118.0 123.0 136.0 126.0 129.0 124.0 139.0 18:11:14 INFO - 2015-12-15 18:11:14,459 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.00 stddev:5.13 (3.5%) stddev-sans-first:5.18 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 148.0 150.0 148.0 144.0 148.0 151.0 139.0 136.0 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 71.0 70.0 69.0 71.0 72.0 70.0 72.0 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:14 INFO - 2015-12-15 18:11:14,460 DEBUG : BROWSER_OUTPUT: 18:11:15 INFO - 2015-12-15 18:11:15,360 INFO : Browser exited with error code: 0 18:11:15 INFO - 2015-12-15 18:11:15,410 INFO : Completed test kraken (00:01:00) 18:11:15 INFO - 2015-12-15 18:11:15,410 INFO : Starting test v8_7 18:11:15 INFO - 2015-12-15 18:11:15,410 DEBUG : operating with platform_type : linux_ 18:11:15 INFO - 2015-12-15 18:11:15,410 INFO : Initialising browser for v8_7 test... 18:11:15 INFO - 2015-12-15 18:11:15,416 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRskDN1/profile http://localhost:38528/getInfo.html 18:11:19 INFO - 2015-12-15 18:11:19,560 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:11:19 INFO - 2015-12-15 18:11:19,560 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:11:19 INFO - 2015-12-15 18:11:19,560 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:11:19 INFO - 2015-12-15 18:11:19,561 DEBUG : BROWSER_OUTPUT: __metrics 18:11:19 INFO - 2015-12-15 18:11:19,710 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] 18:11:19 INFO - 2015-12-15 18:11:19,778 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] 18:11:20 INFO - 2015-12-15 18:11:20,936 INFO : Browser initialized. 18:11:20 INFO - 2015-12-15 18:11:20,937 INFO : Running cycle 1/1 for v8_7 test... 18:11:20 INFO - 2015-12-15 18:11:20,937 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRskDN1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:11:32 INFO - 2015-12-15 18:11:32,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 142176256 18:11:32 INFO - 2015-12-15 18:11:32,921 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38528/tests/v8_7/run.html (next: http://localhost:38528/tests/v8_7/run.html) 18:11:54 INFO - 2015-12-15 18:11:54,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 442593280 18:11:54 INFO - 2015-12-15 18:11:54,556 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:11:54 INFO - 2015-12-15 18:11:54,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |0;Richards;168.74789065136684 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.46280067126608 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 18:11:54 INFO - 2015-12-15 18:11:54,557 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: |8;Splay;611.6207951070336 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 18:11:54 INFO - 2015-12-15 18:11:54,558 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: __startTimestamp1450231914554__endTimestamp 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,559 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.75 Median:168.75 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: Values: 168.7 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.46 Median:186.46 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: Values: 186.5 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,560 DEBUG : BROWSER_OUTPUT: Values: 280.4 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: Values: 5159.8 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: Values: 2010.0 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: Values: 793.7 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: Values: 11964.3 18:11:54 INFO - 2015-12-15 18:11:54,561 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: Values: 26842.1 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.62 Median:611.62 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: Values: 611.6 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: 18:11:54 INFO - 2015-12-15 18:11:54,562 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 18:11:54 INFO - 2015-12-15 18:11:54,563 DEBUG : BROWSER_OUTPUT: Values: 4864.1 18:11:54 INFO - 2015-12-15 18:11:54,563 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:11:54 INFO - 2015-12-15 18:11:54,563 DEBUG : BROWSER_OUTPUT: 18:11:55 INFO - 2015-12-15 18:11:55,473 INFO : Browser exited with error code: 0 18:11:55 INFO - 2015-12-15 18:11:55,487 INFO : Completed test v8_7 (00:00:40) 18:11:55 INFO - 2015-12-15 18:11:55,609 INFO : Completed test suite (00:20:18) 18:11:55 INFO - 2015-12-15 18:11:55,610 DEBUG : Working with test: dromaeo_css 18:11:55 INFO - 2015-12-15 18:11:55,610 DEBUG : Generating results file: dromaeo_css 18:11:55 INFO - 2015-12-15 18:11:55,611 DEBUG : Working with test: kraken 18:11:55 INFO - 2015-12-15 18:11:55,611 DEBUG : Generating results file: kraken 18:11:55 INFO - 2015-12-15 18:11:55,611 INFO : javascript benchmark 18:11:55 INFO - 2015-12-15 18:11:55,611 DEBUG : Working with test: v8_7 18:11:55 INFO - 2015-12-15 18:11:55,612 DEBUG : Generating results file: v8_7 18:11:55 INFO - 2015-12-15 18:11:55,612 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:55 INFO - 2015-12-15 18:11:55,665 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:11:55 INFO - 2015-12-15 18:11:55,666 DEBUG : process_Request line: dromaeo_css 6350.10 graph.html#tests=[[72,132,35]] 18:11:55 INFO - 2015-12-15 18:11:55,666 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:55 INFO - 2015-12-15 18:11:55,693 DEBUG : process_Request line: kraken 1526.30 graph.html#tests=[[232,132,35]] 18:11:55 INFO - 2015-12-15 18:11:55,693 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:11:55 INFO - 2015-12-15 18:11:55,724 DEBUG : process_Request line: v8_7 19737.16 graph.html#tests=[[230,132,35]] 18:11:55 INFO - 2015-12-15 18:11:55,725 INFO : javascript benchmark 18:11:55 INFO - 2015-12-15 18:11:55,729 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.777573906218, 2712.674479062513, 2730.8666903235157, 2731.317170707324, 2738.602902579125, 4524.253498172806, 4686.929696054558, 4724.692894961825, 4733.455652599952, 4745.715257084573, 4643.0, 4651.7208967461975, 4701.929471057937, 4720.197566413709, 4747.7388743619085, 4238.364245363205, 4304.741715497064, 4354.063876266602, 4433.9778301108445, 4457.554244575533, 4168.7290326128705, 4404.911901761963, 4426.911461770763, 4488.820447182109, 4512.029913568582, 4284.957150428519, 4326.961529232993, 4336.21948049351, 4343.804528796211, 4360.542143074963, 4353.586409291112, 4362.563743625644, 4363.934540981888, 4385.101054283864, 4412.05140894706, 4188.036751547131, 4260.10537787062, 4343.4787825460835, 4350.847720329805, 4405.207062728708, 4533.433320834895, 4546.363509108727, 4632.745199014053, 4638.67529272951, 4676.298555216711, 5033.144365457881, 5073.492650734934, 5136.512031357015, 5136.64043516954, 5189.506996835295, 4765.118453086156, 4871.14754917888, 5033.899322013539, 5101.15830887903, 5103.438621751604, 4500.414946057024, 4655.25515917455, 4736.265878788793, 4774.379330686988, 4802.51974802517, 5147.974260128675, 5165.896682066337, 5188.377394712583, 5199.29809475716, 5242.370915490165, 4717.198076326964, 4829.034193161382, 4920.778564964585, 4932.654714170046, 4942.0363029209675, 4928.531789479994, 4951.158303088484, 4956.578690811321, 4979.385503547101, 4979.925301120486, 4932.556069953722, 4932.950670493249, 4937.679050861682, 4939.160342741742, 4990.775415106329, 4701.811927522861, 4831.541003604652, 4914.533119353656, 4920.089783390084, 4973.577245934064, 4084.509858816961, 4089.2230476209425, 4150.315197992298, 4181.770002649883, 4225.366195070764, 3676.338259113332, 3678.1172518595345, 3690.2619476104887, 3694.353488139565, 3702.9259414811554, 4197.76912269822, 4317.546657600907, 4320.9135817284105, 4347.043650396908, 4368.191884501377, 4915.459299477055, 4929.260610908321, 4988.72562009093, 5033.79864805411, 5035.018171456604, 4307.396964424983, 4310.331898555729, 4319.827206911688, 4346.717463364871, 4368.825246990148, 4217.810198541011, 4444.822207111744, 4446.26636604963, 4455.376247325377, 4474.284114541658, 4575.0392417592675, 4625.537446255347, 4635.629149668019, 4669.906601868011, 4684.48470668233, 4984.22744474607, 5069.569086627678, 5074.0, 5077.035363280965, 5121.7695203715175, 4624.838130665546, 4797.616190704665, 4797.928031079607, 4804.543568361, 4846.127697014571, 4846.491118432514, 4891.364122664031, 4899.755012249445, 4908.435529914105, 4969.403671559436, 5048.59611231108, 5105.92341114891, 5110.3356563646485, 5111.744412779421, 5155.2782610435315, 4675.438947326206, 4915.7542122893, 4933.112039832865, 4933.210686290176, 4933.396174931249, 4801.927971080367, 4823.517648235148, 4866.95133048665, 4954.9752251238515, 4970.179920313108, 4834.516548345137, 4857.781399837087, 4864.805407783649, 4870.672661852513, 4910.754462276944, 4725.6219502439035, 4969.35398398206, 4979.3526841510375, 4988.251762235694, 5021.6735912165595, 4697.224957881911, 4741.241401375763, 4754.595859351994, 4827.927581086356, 4855.101806165871], "unit": "score", "name": "dojo.html", "value": 4600.047492113504}, {"lowerIsBetter": false, "replicates": [571.9084946408574, 574.8878968601122, 578.1934201788505, 581.3575998521634, 582.7639805878615, 26617.60073598895, 35224.82387588062, 35928.10179745501, 36001.279974400495, 36057.459138112885, 40218.59781402185, 40686.59313406865, 40705.185896282055, 40741.59258407415, 40766.79616601913, 7034.155901291852, 7163.534370265942, 7830.9216907830905, 7999.920000799976, 8002.839943201133, 10113.089821916026, 10386.844197337046, 10404.323718958281, 10419.114375278072, 10425.061744442999, 9809.313348065638, 9903.752406189868, 9907.851382229272, 9909.058639429242, 9920.503974801268, 7114.608696521689, 7256.0, 7281.854362912712, 7282.70869165238, 9965.90034099657, 10055.748606284902, 10307.330023548446, 10320.071193592537, 10335.121514671262, 10339.327943683711, 36835.447468287995, 36846.63153368459, 37120.25759484795, 37435.438468422995, 37440.43839342412, 2993.1619146638977, 3025.273934255763, 3078.4458797416455, 3537.327907697529, 3613.6567026132475, 28022.579661305095, 28471.57292640612, 28601.85699071512, 28645.28386790326, 28848.855755721088, 3097.1947293703574, 3099.9845000775076, 3118.5322201669933, 3147.6065491813524, 3167.43437815368, 204785.0, 205377.99999999852, 205500.0, 207258.0, 207334.0, 50568.74715626472, 52173.217401739006, 54166.0, 55135.0, 55211.171832422544, 47905.520944790806, 48093.67156955821, 48118.75940620274, 48356.0, 48426.515734842906, 13495.460181592824, 13580.913526917822, 13585.796213056812, 13598.932005340108, 13611.25138117413, 11391.373474458984, 11417.828732569018, 11439.256448330832, 11496.77006459866, 11540.538378464767, 18884.33904813325, 19006.0, 19072.852979258543, 19103.140358683893, 19136.330228441937, 7113.857722845514, 7282.817929551804, 7292.854142917218, 7361.153467351323, 7387.741429049957, 827.1976183102502, 834.7579202031465, 882.9823403532022, 1022.749426390539, 1053.7312985188728, 25857.09500167485, 26025.089121880643, 26696.733032669814, 26732.064377747076, 26760.464790704078, 921.9723408297762, 931.329442801182, 970.0445061614304, 977.0815433492494, 1051.8842927277992, 12981.805272920914, 14151.221682807338, 14788.186649734367, 15054.473093441677, 15392.0, 255672.0, 257799.0, 259268.0, 259898.0, 260089.0, 46799.29801052987, 46980.0, 47131.76434117876, 47147.29279060817, 47200.52799471961, 1116.9776604467866, 1188.7919614067503, 1207.5471698113208, 1222.480445810527, 1232.7472868062025, 24705.888235029826, 26982.460350793266, 28637.713622863506, 29060.854695726386, 29528.704712952596, 40659.3901091478, 40916.79541602392, 40992.385114222714, 41025.0, 41043.384349235384, 199398.0, 200990.89100198675, 227230.0, 231092.0, 327873.0, 27685.30786730348, 27773.444531109668, 27784.166475004975, 27950.16149515518, 28215.43569128647, 38518.614813851505, 38951.0, 39425.80287098546, 39471.605283946796, 39752.80123599479, 33387.499187512694, 35125.824370877985, 36141.27717445584, 36205.0, 36781.26437471289, 31743.365132696756, 32297.838510808237, 32353.0, 32411.837940810146, 32664.83667581742, 32331.19172020718, 32692.182695432806, 33212.83393583017, 33222.667773321955, 33254.50118248277, 25406.0, 26937.326566835985, 27238.0, 27317.726822732315, 27373.178804635892, 23297.301080967598, 23331.533369332858, 23506.88246558756, 23515.17696880601, 23712.644310335705], "unit": "score", "name": "ext.html", "value": 17039.479899286518}, {"lowerIsBetter": false, "replicates": [326.91500209945406, 329.231245042825, 334.54000748970157, 334.8108318799878, 336.7272509267494, 12473.251604903711, 12818.0, 14391.856081439195, 15140.545783626496, 15884.52346429606, 14975.47585834496, 15299.868489615621, 16024.359025638989, 16240.106794126319, 16244.0, 5007.699538027712, 5011.824586139486, 5113.769880355374, 5123.333966584339, 5127.974360128194, 3614.0, 3698.33429982603, 5062.26597143414, 5575.8606034849045, 5763.625364351325, 5649.548036157118, 5670.461306175906, 5695.373508914016, 5720.22776925114, 5722.084466485363, 5670.291213598301, 5823.4467725566, 5830.416958304157, 5831.795887143972, 5836.6206196597295, 5102.0, 5106.974465127651, 5110.514501122388, 5114.3095682083185, 5122.257272695476, 18964.14661340243, 19229.807701922942, 19406.902965485224, 19439.80560194408, 19679.508012299662, 1908.6373589018042, 1913.3494611832043, 1983.345495986321, 1984.335247692025, 2028.148177765342, 12710.364481775874, 12724.0, 12835.165714228546, 13010.349482525837, 13170.143940643828, 1753.898930210896, 1761.806201317854, 1765.48800847754, 1815.1650240889207, 1820.2718912435, 51678.22482662763, 53408.0, 54292.45707542953, 54883.45116548823, 55297.44702552963, 9086.863697044417, 9214.078592140866, 9395.436273823592, 9480.194183494343, 9532.95233523828, 12008.219465734874, 12008.399580020963, 12014.819777703342, 12015.879841201477, 12020.0, 6889.242183359826, 6894.793156205322, 6968.198657154391, 7014.754483593049, 7052.435805135577, 6680.699368528428, 6688.632125233159, 6733.595984240961, 6748.763793267212, 6756.763513277012, 5685.03866166172, 5730.799422020209, 5744.885102297931, 5755.424457554295, 5786.103154011135, 1547.6130967258187, 1578.1556867076058, 1608.750643650236, 1630.07650971852, 1632.0778760000562, 853.6030745703277, 855.5294587976588, 867.9696210632598, 881.1584936385736, 958.6980101268078, 15658.138802365751, 15767.921160394355, 15921.283542240628, 16225.837741622669, 16442.588935276475, 793.7539362797552, 852.1138016462809, 901.553730903194, 908.6728777640044, 933.1834644685899, 6572.572782769201, 8812.8678069829, 8943.821123577492, 8969.416987895765, 9006.324525660602, 427238.0, 435164.0, 436647.0, 437876.0, 438872.0, 60761.69619151876, 61870.0, 62230.37769622336, 62413.375866240756, 62697.68651156715, 897.7665806890255, 899.9370044096981, 904.8687940248759, 911.3392790227165, 1090.536521978172, 13239.3380330985, 13624.411605354218, 13774.449022039005, 13862.861371386158, 13884.652883677989, 28418.43163136767, 28469.857650711612, 28728.856355718086, 28885.85557072201, 29053.837846485905, 44133.33799992938, 44893.77553112213, 45032.0, 46440.30339544842, 52026.47973520368, 12511.249325040526, 13654.86345136536, 13696.52062177819, 13741.03812733099, 14440.350184241945, 17803.0, 17836.91081544584, 18140.0, 18538.536536586154, 18668.533286667942, 14712.485063022743, 14730.26348682583, 14850.628734281729, 14955.10269383797, 15251.389944402543, 14509.782353264498, 14601.0, 14695.779563306345, 14704.41182352694, 15297.847021529642, 14864.256787160815, 15228.77156842626, 15350.846491534941, 15432.302446730626, 15600.765988510408, 13664.385102670205, 13745.0, 13900.860991389956, 13901.37443815051, 13901.791473128114, 14245.21651309188, 14494.63763405881, 14733.852661473247, 14801.777973330623, 14815.33331000086], "unit": "score", "name": "jquery.html", "value": 8660.095644749765}, {"lowerIsBetter": false, "replicates": [1443.1485423600075, 1596.353476841879, 1667.4164042585094, 1674.2047527424475, 1726.6891959447294, 6071.241094863142, 6973.721051157954, 7122.750703725371, 7130.786076417703, 7137.286271372866, 6605.83485412865, 6803.693833777479, 6804.591724496534, 6808.706345794296, 6809.216940051895, 1753.8947663140189, 1791.9641607167914, 2038.959220815579, 2064.194963964055, 2073.8859362735043, 2099.6010757956014, 2106.715593394895, 2110.09266015614, 2110.3774386555924, 2111.2927169398195, 1974.4965033916403, 1993.8703984240979, 2035.236786205173, 2036.2974773703122, 2036.3178335257633, 2039.3474088291753, 2057.2799520167896, 2078.0129438516733, 2085.4994801247744, 2085.947851303722, 2081.323569839808, 2094.7695753467106, 2102.4638717127036, 2103.0431153825125, 2103.568768402474, 7196.064511613509, 7271.89092163618, 7272.4909256352075, 7277.89083163753, 7291.34377905991, 4228.619424251832, 4276.0, 4278.144371125787, 4283.91432171358, 4303.569643035671, 2616.1105224223857, 2680.932976675579, 2688.0457437609757, 2696.4741875334316, 2713.66079240095, 786.626352482572, 800.4436916343144, 812.8333691593268, 814.2305521282391, 816.4325793573469, 9603.567839447242, 9658.56536455854, 9728.075832795874, 9801.90198098017, 9803.215742740564, 3773.9245215095543, 3857.8263978121054, 3900.297946369624, 3931.9803400983383, 3941.3496773032703, 8393.53835539039, 8397.034341050736, 8403.579821009047, 8412.621432035574, 8426.494410335277, 4249.2563801334645, 4281.37920001598, 4285.935710964338, 4289.399484072233, 4290.399344091829, 3882.495275614152, 3886.067343837459, 3891.9102651257695, 3896.12337224128, 3896.688264938855, 2844.2320573445054, 2951.439226546949, 3085.645150807641, 3105.4410206163107, 3320.750943679234, 1033.0805583031108, 1043.9321444106108, 1047.9056884880397, 1050.2963014780116, 1054.4253381906879, 910.8724778531011, 914.2411798207472, 943.6084025129632, 969.2100937735722, 1213.3629844331797, 6709.563878347892, 6731.461483081342, 6765.898511522331, 6766.932330676728, 6772.762953296611, 1016.9575442505261, 1045.5347370420243, 1052.1845569683403, 1065.5151905882806, 1075.8708954925303, 5317.946820531823, 5362.51737343641, 5391.838244852661, 5431.37539182999, 5434.619576629598, 8367.874481882776, 8450.281726053354, 8506.149385061568, 8523.190296921783, 8547.358948078794, 8382.916170838214, 8398.454100483448, 8409.537475438787, 8421.284190843848, 8423.831523369498, 6622.503312251601, 6666.166729158856, 6708.83227919306, 6709.0, 6760.459163266927, 6779.627120508222, 6855.211650660238, 6858.279880612464, 6958.756443524452, 6962.094927659372, 7572.280633339824, 7816.257455541714, 7821.452498325063, 7930.722424715107, 7931.048274207132, 7898.210178982055, 8031.0, 8045.356371490384, 8156.184381562034, 8167.101618821806, 6356.0, 6372.490200783834, 6388.041793730978, 6426.710798014007, 6451.161349024596, 5654.6324488908085, 5754.424557544212, 6370.8088757337355, 6867.587944723333, 6927.376536111573, 6295.5907865988565, 6336.714847831767, 6357.110004599453, 6368.4586810121655, 6539.901901471577, 6294.4964402846745, 6326.525510586633, 6365.363463653783, 6411.4229719325485, 6412.236634925246, 6477.708503117276, 6496.512761542808, 6508.642024688687, 6514.869702605826, 6541.34586541342, 5780.450857168562, 5833.154192642128, 5838.12428135783, 5840.2991641003355, 5841.1238314253205, 5953.880922381615, 5986.970065149646, 5988.820335389945, 5998.0, 6002.309734380602], "unit": "score", "name": "mootools.html", "value": 4071.933837500714}, {"lowerIsBetter": false, "replicates": [293.7796652510617, 299.0684019279944, 302.0741427524637, 302.57337154612003, 304.68312954527283, 5250.474952504747, 5283.101872681644, 5303.867403314919, 5317.627766056377, 5321.973390133049, 4961.503849615036, 5054.823081192159, 5130.666506677073, 5211.661242019276, 5226.843194704155, 4101.8974525636795, 4120.876373708786, 4124.505059392877, 4124.649404800595, 4148.688848336372, 3870.8838734838, 4120.3201471757275, 4122.093139509303, 4127.195196936598, 4133.545310015896, 3915.4714113594587, 3964.940525892114, 4034.6368826805583, 4035.3745169498775, 4046.696497762665, 4003.4195041718785, 4028.053407449247, 4037.9798101009455, 4045.7977101144825, 4054.5742697016685, 3540.309639620275, 3546.0425685065147, 3550.467429885512, 3551.5027896094566, 3551.94672079919, 5037.622178336603, 5042.39491261051, 5042.940982393665, 5046.142155833517, 5053.5957123430035, 4545.545445455461, 4629.583337499607, 4650.395448591696, 4686.461056978457, 4688.578027977498, 5502.174673798922, 5511.366192887829, 5511.448855114497, 5518.144687573393, 5519.972400137974, 3890.396988466792, 3897.259520691088, 3899.0, 3900.3759398496104, 3909.58949310324, 5729.9713501432225, 5790.7394167262155, 5795.3335366432975, 5796.478316951495, 5796.594238403313, 3905.1408690088133, 3983.103801644607, 3987.860424885173, 4003.619656132663, 4018.778967156776, 4036.011177261531, 4043.7978101094827, 4045.7977101144825, 4046.968023154077, 4048.291548978917, 4621.7752295641685, 4624.28323609841, 4624.745638989888, 4628.74541900192, 4633.166030114544, 5507.476789704971, 5525.088360420566, 5530.419305972815, 5541.889162216814, 5542.11326187808, 1420.898803427352, 1431.9856801431852, 1442.4879167895456, 1462.4661998370518, 1465.230753854235, 978.5107446276861, 1005.5173516712019, 1012.3318609717699, 1018.8930162332848, 1019.0115587879744, 4866.562009419169, 4877.122118018719, 4880.389951256093, 4882.8779280517565, 4886.413630364308, 5733.082706766981, 5737.540996720336, 5740.454656807597, 5741.88516229673, 5747.1379293106365, 4693.953060469352, 4751.382320298409, 4793.760311984387, 4886.071646387175, 4886.413630364308, 3044.2845931206148, 3083.892063777757, 3098.9225269368444, 3102.4260511805387, 3112.828794416329, 5474.069408200616, 5476.096444086681, 5476.890462190813, 5481.643693159932, 5481.75332110056, 5926.0, 5926.614770039933, 5928.555358348141, 5928.962431574457, 5934.465898069195, 5336.0661884170895, 5498.752556134984, 5506.311711036121, 5509.669419834822, 5511.311086114236, 5805.332386775575, 5816.47651711348, 5818.127280907897, 5819.476247137778, 5824.9417505826095, 5651.660900345993, 5656.151577263443, 5661.46216109469, 5666.518345940476, 5672.971635141798, 5317.787288508571, 5492.917606235989, 5502.504774570308, 5503.834884953458, 5507.173923911445, 3920.2355540669296, 3974.165425260612, 3979.045029192915, 3983.2830090583975, 3985.940210896781, 5818.156367326798, 5818.359980402068, 5819.301683797971, 5819.359870414166, 5820.476157145878, 5574.526165275997, 5579.191017302387, 5582.162675598693, 5582.916256256078, 5583.162525621027, 5400.972995134999, 5486.369067557122, 5552.361478430033, 5577.0, 5577.358603760457, 5406.540444062299, 5459.099248623933, 5480.123180291134, 5483.341998960151, 5486.1222204447095, 5627.746751396279, 5635.915461268166, 5639.154126881001, 5645.9153112702525, 5650.180723795109, 5377.623566350474, 5500.147477141049, 5502.889942201054, 5507.146392309199, 5507.889842203213], "unit": "score", "name": "prototype.html", "value": 4173.806537205996}, {"lowerIsBetter": false, "replicates": [785.7053604898164, 787.5983248543243, 794.1740589786618, 796.6853093028254, 817.9959100204499, 10885.401302928336, 11146.442677866095, 11158.051565616923, 11168.497417616207, 11204.383758893278, 11401.201915865893, 11458.541658333657, 11460.770784584303, 11472.827907581393, 11496.080313574916, 619.1424876545982, 629.0815409502133, 629.1286568103187, 629.9433051025406, 630.6121735132906, 792.4848848248656, 805.60525342582, 806.899137607799, 807.9717209897655, 808.1877712898529, 830.3066939105854, 830.887830142929, 836.1596595421623, 837.476577139288, 838.266516797802, 825.2531459029587, 825.859603867344, 826.7850358906668, 827.2389401750404, 827.9668813247463, 481.14836738971826, 487.7439344344212, 615.9507239420881, 616.214326733414, 623.2769986815273, 11421.31472111676, 11573.247738896946, 11582.247153934968, 11628.825567616492, 11660.766784664344, 11080.778384432348, 11424.657260282205, 11576.884231157665, 11611.245269057485, 12007.3395963222, 9139.314551408672, 9238.353315267934, 9311.161995420445, 9467.384619999679, 9567.521623918776, 3273.623533293654, 3288.1122097033667, 3355.5637767090366, 3364.747643926715, 3402.132456223672, 39507.20985580301, 39518.60481395178, 39530.99999999971, 39664.0, 39689.60310396888, 9017.954910225408, 9047.457152570736, 9179.0820917909, 9384.5307734613, 9526.142647161789, 17050.573735656708, 17067.146642667816, 17071.91464042672, 17110.14449277531, 17160.656786864194, 6389.776357827547, 6514.456321489041, 6528.967355163194, 6552.279249282575, 6648.66756662165, 3488.2849015952174, 3503.9124021899656, 3514.8242587870504, 3648.726345524043, 3655.3420384331075, 2552.0429838810446, 2584.741525847438, 2590.9481810363686, 2592.844429334246, 2599.9480010399684, 449.4224920976595, 456.30413619230274, 457.5653129526963, 465.57399979019493, 466.25864874848475, 432.88744926319384, 486.69581511555276, 500.7496251874063, 510.2117228881387, 607.5807692692028, 7550.093988721389, 8019.198080191934, 8710.564471776386, 8822.911770882338, 8850.513221772735, 546.4317110205421, 581.7033313010395, 582.8397190772572, 596.3023262782555, 643.7521554201572, 3626.1297288650535, 3642.3261696585687, 3837.2325534893134, 3856.36369998947, 3866.729328947003, 51981.48018519842, 52335.73832130815, 52540.0, 52559.73720131375, 52922.73538632359, 41616.79191604022, 41793.0, 42048.789756051636, 42380.57619423766, 44991.0, 35921.28157436837, 36403.817980909924, 39458.80270598629, 39950.60049399527, 41183.0, 8147.470414423044, 8164.8367032657825, 8204.876926846222, 8282.627281772455, 8292.212239837207, 30602.0, 30634.84682576573, 30986.53520197154, 31792.68207317897, 31801.36397271995, 35110.0, 40130.1973960525, 40400.1919961605, 40458.39312410375, 40680.79659601683, 9867.457289849128, 10132.088112069949, 10139.008992347128, 10211.642592509226, 10232.130268927225, 11123.0, 11163.274387164809, 11243.718907027389, 11336.886631133913, 11391.715207119889, 10781.784364312827, 10833.729156771144, 10911.563537458731, 11213.831792523282, 11562.0, 10283.691489255334, 10586.841197381891, 10729.624463144064, 10804.081653059578, 11073.667789966314, 8139.75580732579, 9654.372465789702, 10564.207684423545, 10779.67660970172, 11519.827202592136, 9248.722538323862, 9260.351775375659, 9425.010373910914, 9578.377405468622, 9765.365251258645, 9301.395409298373, 9335.953320233355, 9633.470159141314, 9640.228781697308, 9652.420854748738], "unit": "score", "name": "yui.html", "value": 5682.765424364136}], "name": "dromaeo_css", "value": 6350.093961615415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 111.0, 114.0, 113.0, 101.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 153.0, 170.0, 129.0, 153.0, 156.0, 130.0, 168.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 84.0, 89.0, 72.0, 72.0, 72.0, 115.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 95.0, 94.0, 95.0, 130.0, 95.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 112.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 72.0, 72.0, 73.0, 71.0, 80.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 85.0, 82.0, 83.0, 84.0, 93.0, 84.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [121.0, 128.0, 125.0, 118.0, 123.0, 136.0, 126.0, 129.0, 124.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 148.0, 150.0, 148.0, 144.0, 148.0, 151.0, 139.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 71.0, 70.0, 69.0, 71.0, 72.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1526.3000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.74789065136684], "unit": "score", "name": "Richards", "value": 209.19965200000001}, {"lowerIsBetter": false, "replicates": [186.46280067126608], "unit": "score", "name": "DeltaBlue", "value": 354.59083400000003}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [2010.0401606425703], "unit": "score", "name": "RayTrace", "value": 368.1463756243757}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [611.6207951070336], "unit": "score", "name": "Splay", "value": 133.23778500000006}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19737.16067742779}]} 18:11:55 INFO - RETURN: dromaeo_css: 6350.10 18:11:55 INFO - RETURN: kraken: 1526.30 18:11:55 INFO - RETURN: v8_7: 19737.16 18:11:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19737.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6350.10"}}} 18:11:55 INFO - Return code: 0 18:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:11:55 ERROR - # TBPL SUCCESS # 18:11:55 INFO - Running post-action listener: _resource_record_post_action 18:11:55 INFO - Running post-run listener: _resource_record_post_run 18:11:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507486208; Read time: 8; Write time: 559568 18:11:56 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231440384; Read time: 0; Write time: 416604 18:11:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275759104; Read time: 8; Write time: 142940 18:11:56 INFO - Running post-run listener: _upload_blobber_files 18:11:56 INFO - Blob upload gear active. 18:11:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:11:56 INFO - Copying logs to upload dir... 18:11:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.357933 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-15 18:11:56.827882) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 18:11:56.832617) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010004 build_url: 'https://queue.taskcluster.net/v1/task/2G48iLnlQa2J4nM2gT8zOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 18:11:56.889027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 18:11:56.889344) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450230012.871621-1657387560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 18:11:56.938832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 18:11:56.939306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 18:11:56.939584) ========= ========= Total master_lag: 0.32 =========