builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1450274913.32 results: success (0) buildid: 20151216053720 builduid: a51b9edb21ff452b80b697adb3ebd586 revision: f8840e2aec5afdebf63216dc219e103b5d4c391a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.322148) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.322679) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.323025) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006325 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.354480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.354800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.414821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.415103) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.479970) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.480298) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.480804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.481124) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 06:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-16 06:08:33 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.666387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.666705) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016742 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.736788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:33.737187) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8840e2aec5afdebf63216dc219e103b5d4c391a --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 f8840e2aec5afdebf63216dc219e103b5d4c391a --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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 06:08:33,858 truncating revision to first 12 chars 2015-12-16 06:08:33,858 Setting DEBUG logging. 2015-12-16 06:08:33,858 attempt 1/10 2015-12-16 06:08:33,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8840e2aec5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 06:08:34,111 unpacking tar archive at: fx-team-f8840e2aec5a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:34.267739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:34.268098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:34.278159) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:34.278469) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:08:34.278902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-16 06:08:34.279232) ========= /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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:08:34 INFO - MultiFileLogger online at 20151216 06:08:34 in /builds/slave/test 06:08:34 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 06:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:34 INFO - {'append_to_log': False, 06:08:34 INFO - 'base_work_dir': '/builds/slave/test', 06:08:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:34 INFO - 'branch': 'Fx-Team-Non-PGO', 06:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:34 INFO - 'config_files': ('talos/linux_config.py',), 06:08:34 INFO - 'default_actions': ('clobber', 06:08:34 INFO - 'read-buildbot-config', 06:08:34 INFO - 'download-and-extract', 06:08:34 INFO - 'populate-webroot', 06:08:34 INFO - 'create-virtualenv', 06:08:34 INFO - 'install', 06:08:34 INFO - 'run-tests'), 06:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:34 INFO - 'download_minidump_stackwalk': True, 06:08:34 INFO - 'download_symbols': 'ondemand', 06:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:34 INFO - 'installer_path': 'installer.exe', 06:08:34 INFO - 'log_level': 'info', 06:08:34 INFO - 'log_name': 'talos', 06:08:34 INFO - 'log_to_console': True, 06:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:08:34 INFO - 'opt_config_files': (), 06:08:34 INFO - 'pip_index': False, 06:08:34 INFO - 'sps_profile': False, 06:08:34 INFO - 'sps_profile_interval': 0, 06:08:34 INFO - 'suite': 'dromaeojs', 06:08:34 INFO - 'system_bits': '64', 06:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:34 INFO - 'title': 'talos-linux64-ix-060', 06:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:34 INFO - 'use_talos_json': True, 06:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:34 INFO - 'work_dir': 'build'} 06:08:34 INFO - ##### 06:08:34 INFO - ##### Running clobber step. 06:08:34 INFO - ##### 06:08:34 INFO - Running pre-action listener: _resource_record_pre_action 06:08:34 INFO - Running main action method: clobber 06:08:34 INFO - rmtree: /builds/slave/test/build 06:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:35 INFO - Running post-action listener: _resource_record_post_action 06:08:35 INFO - ##### 06:08:35 INFO - ##### Running read-buildbot-config step. 06:08:35 INFO - ##### 06:08:35 INFO - Running pre-action listener: _resource_record_pre_action 06:08:35 INFO - Running main action method: read_buildbot_config 06:08:35 INFO - Using buildbot properties: 06:08:35 INFO - { 06:08:35 INFO - "properties": { 06:08:35 INFO - "buildnumber": 1015, 06:08:35 INFO - "product": "firefox", 06:08:35 INFO - "script_repo_revision": "production", 06:08:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:08:35 INFO - "repository": "", 06:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:08:35 INFO - "buildid": "20151216053720", 06:08:35 INFO - "slavename": "talos-linux64-ix-060", 06:08:35 INFO - "pgo_build": "False", 06:08:35 INFO - "basedir": "/builds/slave/test", 06:08:35 INFO - "project": "", 06:08:35 INFO - "platform": "ubuntu64_hw", 06:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:08:35 INFO - "slavebuilddir": "test", 06:08:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:08:35 INFO - "branch": "fx-team", 06:08:35 INFO - "repo_path": "integration/fx-team", 06:08:35 INFO - "stage_platform": "linux64", 06:08:35 INFO - "builduid": "a51b9edb21ff452b80b697adb3ebd586", 06:08:35 INFO - "revision": "f8840e2aec5afdebf63216dc219e103b5d4c391a" 06:08:35 INFO - }, 06:08:35 INFO - "sourcestamp": { 06:08:35 INFO - "repository": "", 06:08:35 INFO - "hasPatch": false, 06:08:35 INFO - "project": "", 06:08:35 INFO - "branch": "fx-team-linux64-talos", 06:08:35 INFO - "changes": [ 06:08:35 INFO - { 06:08:35 INFO - "category": null, 06:08:35 INFO - "files": [ 06:08:35 INFO - { 06:08:35 INFO - "url": null, 06:08:35 INFO - "name": "https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 06:08:35 INFO - } 06:08:35 INFO - ], 06:08:35 INFO - "repository": "", 06:08:35 INFO - "rev": "f8840e2aec5afdebf63216dc219e103b5d4c391a", 06:08:35 INFO - "who": "gijskruitbosch@gmail.com", 06:08:35 INFO - "when": 1450274869, 06:08:35 INFO - "number": 7366237, 06:08:35 INFO - "comments": "Bug 1231114 - fix labels of unnamed groups as well as group ordering on the tab migration page, r=mconley", 06:08:35 INFO - "project": "", 06:08:35 INFO - "at": "Wed 16 Dec 2015 06:07:49", 06:08:35 INFO - "branch": "fx-team-linux64-talos", 06:08:35 INFO - "revlink": "", 06:08:35 INFO - "properties": [ 06:08:35 INFO - [ 06:08:35 INFO - "buildid", 06:08:35 INFO - "20151216053720", 06:08:35 INFO - "Change" 06:08:35 INFO - ], 06:08:35 INFO - [ 06:08:35 INFO - "builduid", 06:08:35 INFO - "a51b9edb21ff452b80b697adb3ebd586", 06:08:35 INFO - "Change" 06:08:35 INFO - ], 06:08:35 INFO - [ 06:08:35 INFO - "pgo_build", 06:08:35 INFO - "False", 06:08:35 INFO - "Change" 06:08:35 INFO - ] 06:08:35 INFO - ], 06:08:35 INFO - "revision": "f8840e2aec5afdebf63216dc219e103b5d4c391a" 06:08:35 INFO - } 06:08:35 INFO - ], 06:08:35 INFO - "revision": "f8840e2aec5afdebf63216dc219e103b5d4c391a" 06:08:35 INFO - } 06:08:35 INFO - } 06:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:08:35 INFO - Running post-action listener: _resource_record_post_action 06:08:35 INFO - ##### 06:08:35 INFO - ##### Running download-and-extract step. 06:08:35 INFO - ##### 06:08:35 INFO - Running pre-action listener: _resource_record_pre_action 06:08:35 INFO - Running main action method: download_and_extract 06:08:35 INFO - mkdir: /builds/slave/test/build/tests 06:08: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')]} 06:08:35 INFO - https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/test_packages.json 06:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/test_packages.json 06:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:08:44 INFO - Downloaded 1302 bytes. 06:08:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:08:44 INFO - Using the following test package requirements: 06:08:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:08:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'jsshell-linux-x86_64.zip'], 06:08:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:08:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:08:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:08:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:08:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:08:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:08: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')]} 06:08:44 INFO - https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:52 INFO - Downloaded 21869080 bytes. 06:08:52 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 06:08:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:52 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 06:08:53 INFO - Return code: 0 06:08:53 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 06:08: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')]} 06:08:53 INFO - https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:56 INFO - Downloaded 21869080 bytes. 06:08:56 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 06:08:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:08:56 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 06:08:58 INFO - Return code: 0 06:08:58 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')]} 06:08:58 INFO - https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:59 INFO - Downloaded 11132052 bytes. 06:08:59 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 06:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:59 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 06:08:59 INFO - Return code: 0 06:08:59 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')]} 06:08:59 INFO - https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acJ7vidKQDqnHtsJxi4p6w/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 06:09:00 INFO - Downloaded 57742175 bytes. 06:09:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:09:00 INFO - mkdir: /builds/slave/test/properties 06:09:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:09:00 INFO - Writing to file /builds/slave/test/properties/build_url 06:09:00 INFO - Contents: 06:09:00 INFO - build_url:https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:09:00 INFO - Running post-action listener: _resource_record_post_action 06:09:00 INFO - Running post-action listener: set_extra_try_arguments 06:09:00 INFO - ##### 06:09:00 INFO - ##### Running populate-webroot step. 06:09:00 INFO - ##### 06:09:00 INFO - Running pre-action listener: _resource_record_pre_action 06:09:00 INFO - Running main action method: populate_webroot 06:09:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:09:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:09:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:09:00 INFO - '--tppagecycles', 06:09:00 INFO - '7'], 06:09:00 INFO - 'tests': ['tsvgm']}}, 06:09:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:09:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:09:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:09:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:09:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'tests': ['damp', 'tps']}, 06:09:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['damp', 'tps']}, 06:09:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:09:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:09:00 INFO - 'other': {'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'other_l64': {'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'other_nol64': {'tests': ['a11yr', 06:09:00 INFO - 'ts_paint', 06:09:00 INFO - 'tpaint', 06:09:00 INFO - 'sessionrestore', 06:09:00 INFO - 'sessionrestore_no_auto_restore']}, 06:09:00 INFO - 'svgr': {'tests': ['tsvgx', 06:09:00 INFO - 'tsvgr_opacity', 06:09:00 INFO - 'tart', 06:09:00 INFO - 'tscrollx', 06:09:00 INFO - 'cart']}, 06:09:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['tsvgx', 06:09:00 INFO - 'tsvgr_opacity', 06:09:00 INFO - 'tart', 06:09:00 INFO - 'tscrollx', 06:09:00 INFO - 'cart']}, 06:09:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'tests': ['tp5o']}, 06:09:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'talos_options': ['--e10s'], 06:09:00 INFO - 'tests': ['tp5o']}, 06:09:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'talos_options': ['--xperf_path', 06:09:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:00 INFO - 'tests': ['tp5n']}, 06:09:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:00 INFO - 'talos_options': ['--e10s', 06:09:00 INFO - '--xperf_path', 06:09:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:00 INFO - 'tests': ['tp5n']}}, 06:09:00 INFO - 'talos.zip': {'path': '', 06:09:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:09:00 INFO - Running post-action listener: _resource_record_post_action 06:09:00 INFO - ##### 06:09:00 INFO - ##### Running create-virtualenv step. 06:09:00 INFO - ##### 06:09:00 INFO - Running pre-action listener: _resource_record_pre_action 06:09:00 INFO - Running main action method: create_virtualenv 06:09:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:09:00 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 06:09:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:09:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:09:00 INFO - Using real prefix '/usr' 06:09:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:09:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:09:03 INFO - Installing pip.................done. 06:09:03 INFO - Return code: 0 06:09:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09: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', 'pip>=1.5'] in /builds/slave/test/build 06:09: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 pip>=1.5 06:09:03 INFO - Using env: {'DISPLAY': ':0', 06:09:03 INFO - 'HOME': '/home/cltbld', 06:09:03 INFO - 'LANG': 'en_US.UTF-8', 06:09:03 INFO - 'LANGUAGE': 'en_US:en', 06:09:03 INFO - 'LOGNAME': 'cltbld', 06:09:03 INFO - 'MAIL': '/var/mail/cltbld', 06:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:03 INFO - 'MOZ_NO_REMOTE': '1', 06:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:03 INFO - 'NO_EM_RESTART': '1', 06:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:03 INFO - 'PWD': '/builds/slave/test', 06:09:03 INFO - 'SHELL': '/bin/bash', 06:09:03 INFO - 'SHLVL': '1', 06:09:03 INFO - 'TERM': 'linux', 06:09:03 INFO - 'TMOUT': '86400', 06:09:03 INFO - 'USER': 'cltbld', 06:09:03 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:03 INFO - '_': '/tools/buildbot/bin/python'} 06:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:03 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 06:09:03 INFO - Cleaning up... 06:09:03 INFO - Return code: 0 06:09:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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', '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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:09: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 psutil>=0.7.1 06:09:03 INFO - Using env: {'DISPLAY': ':0', 06:09:03 INFO - 'HOME': '/home/cltbld', 06:09:03 INFO - 'LANG': 'en_US.UTF-8', 06:09:03 INFO - 'LANGUAGE': 'en_US:en', 06:09:03 INFO - 'LOGNAME': 'cltbld', 06:09:03 INFO - 'MAIL': '/var/mail/cltbld', 06:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:03 INFO - 'MOZ_NO_REMOTE': '1', 06:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:03 INFO - 'NO_EM_RESTART': '1', 06:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:03 INFO - 'PWD': '/builds/slave/test', 06:09:03 INFO - 'SHELL': '/bin/bash', 06:09:03 INFO - 'SHLVL': '1', 06:09:03 INFO - 'TERM': 'linux', 06:09:03 INFO - 'TMOUT': '86400', 06:09:03 INFO - 'USER': 'cltbld', 06:09:03 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:03 INFO - '_': '/tools/buildbot/bin/python'} 06:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:03 INFO - Downloading/unpacking psutil>=0.7.1 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:09:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:05 INFO - Installing collected packages: psutil 06:09:05 INFO - Running setup.py install for psutil 06:09:05 INFO - building 'psutil._psutil_linux' extension 06:09:05 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 06:09:05 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 06:09:05 INFO - building 'psutil._psutil_posix' extension 06:09:05 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 06:09:05 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 06:09:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:06 INFO - Successfully installed psutil 06:09:06 INFO - Cleaning up... 06:09:06 INFO - Return code: 0 06:09:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:09:06 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')]} 06:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:06 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')]} 06:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:06 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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:06 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 06:09:06 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 06:09:06 INFO - Using env: {'DISPLAY': ':0', 06:09:06 INFO - 'HOME': '/home/cltbld', 06:09:06 INFO - 'LANG': 'en_US.UTF-8', 06:09:06 INFO - 'LANGUAGE': 'en_US:en', 06:09:06 INFO - 'LOGNAME': 'cltbld', 06:09:06 INFO - 'MAIL': '/var/mail/cltbld', 06:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:06 INFO - 'MOZ_NO_REMOTE': '1', 06:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:06 INFO - 'NO_EM_RESTART': '1', 06:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:06 INFO - 'PWD': '/builds/slave/test', 06:09:06 INFO - 'SHELL': '/bin/bash', 06:09:06 INFO - 'SHLVL': '1', 06:09:06 INFO - 'TERM': 'linux', 06:09:06 INFO - 'TMOUT': '86400', 06:09:06 INFO - 'USER': 'cltbld', 06:09:06 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:06 INFO - '_': '/tools/buildbot/bin/python'} 06:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:09:06 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 06:09:06 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 06:09:06 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 06:09:06 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 06:09:06 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 06:09:06 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 06:09:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:09:08 INFO - Installing collected packages: mozsystemmonitor 06:09:08 INFO - Running setup.py install for mozsystemmonitor 06:09:08 INFO - Successfully installed mozsystemmonitor 06:09:08 INFO - Cleaning up... 06:09:08 INFO - Return code: 0 06:09:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:08 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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:08 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 06:09:08 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 06:09:08 INFO - Using env: {'DISPLAY': ':0', 06:09:08 INFO - 'HOME': '/home/cltbld', 06:09:08 INFO - 'LANG': 'en_US.UTF-8', 06:09:08 INFO - 'LANGUAGE': 'en_US:en', 06:09:08 INFO - 'LOGNAME': 'cltbld', 06:09:08 INFO - 'MAIL': '/var/mail/cltbld', 06:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:08 INFO - 'MOZ_NO_REMOTE': '1', 06:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:08 INFO - 'NO_EM_RESTART': '1', 06:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:08 INFO - 'PWD': '/builds/slave/test', 06:09:08 INFO - 'SHELL': '/bin/bash', 06:09:08 INFO - 'SHLVL': '1', 06:09:08 INFO - 'TERM': 'linux', 06:09:08 INFO - 'TMOUT': '86400', 06:09:08 INFO - 'USER': 'cltbld', 06:09:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:08 INFO - '_': '/tools/buildbot/bin/python'} 06:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:08 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 06:09:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:09:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:09:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 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 06:09:10 INFO - Downloading docopt-0.6.1.tar.gz 06:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:09:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:09:10 INFO - Running setup.py install for blobuploader 06:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:09:10 INFO - Running setup.py install for requests 06:09:11 INFO - Running setup.py install for docopt 06:09:11 INFO - Successfully installed blobuploader requests docopt 06:09:11 INFO - Cleaning up... 06:09:11 INFO - Return code: 0 06:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:11 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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:11 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 06:09:11 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 06:09:11 INFO - Using env: {'DISPLAY': ':0', 06:09:11 INFO - 'HOME': '/home/cltbld', 06:09:11 INFO - 'LANG': 'en_US.UTF-8', 06:09:11 INFO - 'LANGUAGE': 'en_US:en', 06:09:11 INFO - 'LOGNAME': 'cltbld', 06:09:11 INFO - 'MAIL': '/var/mail/cltbld', 06:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:11 INFO - 'MOZ_NO_REMOTE': '1', 06:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:11 INFO - 'NO_EM_RESTART': '1', 06:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:11 INFO - 'PWD': '/builds/slave/test', 06:09:11 INFO - 'SHELL': '/bin/bash', 06:09:11 INFO - 'SHLVL': '1', 06:09:11 INFO - 'TERM': 'linux', 06:09:11 INFO - 'TMOUT': '86400', 06:09:11 INFO - 'USER': 'cltbld', 06:09:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:11 INFO - '_': '/tools/buildbot/bin/python'} 06:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:11 INFO - Running setup.py (path:/tmp/pip-yBp3L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:11 INFO - Running setup.py (path:/tmp/pip-pnU55W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:11 INFO - Running setup.py (path:/tmp/pip-m1AA_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:11 INFO - Running setup.py (path:/tmp/pip-kiZQ0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:11 INFO - Running setup.py (path:/tmp/pip-V8Qt8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:12 INFO - Running setup.py (path:/tmp/pip-GJq9bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:12 INFO - Running setup.py (path:/tmp/pip-KVMjJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:12 INFO - Running setup.py (path:/tmp/pip-l06Anz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:12 INFO - Running setup.py (path:/tmp/pip-Sh9_Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:12 INFO - Running setup.py (path:/tmp/pip-ZuOu0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:12 INFO - Running setup.py (path:/tmp/pip-3kE3Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:12 INFO - Running setup.py (path:/tmp/pip-j43gVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:12 INFO - Running setup.py (path:/tmp/pip-io60cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:12 INFO - Running setup.py (path:/tmp/pip-CKMia4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:12 INFO - Running setup.py (path:/tmp/pip-vo5AiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:12 INFO - Running setup.py (path:/tmp/pip-g4kQXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:12 INFO - Running setup.py (path:/tmp/pip-Fwv2No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:09:12 INFO - Running setup.py install for manifestparser 06:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:09:12 INFO - Running setup.py install for mozcrash 06:09:13 INFO - Running setup.py install for mozdebug 06:09:13 INFO - Running setup.py install for mozdevice 06:09:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Running setup.py install for mozfile 06:09:13 INFO - Running setup.py install for mozhttpd 06:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Running setup.py install for mozinfo 06:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Running setup.py install for mozInstall 06:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Running setup.py install for mozleak 06:09:13 INFO - Running setup.py install for mozlog 06:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:09:13 INFO - Running setup.py install for moznetwork 06:09:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Running setup.py install for mozprocess 06:09:14 INFO - Running setup.py install for mozprofile 06:09:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Running setup.py install for mozrunner 06:09:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Running setup.py install for mozscreenshot 06:09:14 INFO - Running setup.py install for moztest 06:09:14 INFO - Running setup.py install for mozversion 06:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:09:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:09:14 INFO - Cleaning up... 06:09:14 INFO - Return code: 0 06:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:14 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')]} 06:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:14 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')]} 06:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:14 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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:14 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 06:09:14 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 06:09:14 INFO - Using env: {'DISPLAY': ':0', 06:09:14 INFO - 'HOME': '/home/cltbld', 06:09:14 INFO - 'LANG': 'en_US.UTF-8', 06:09:14 INFO - 'LANGUAGE': 'en_US:en', 06:09:14 INFO - 'LOGNAME': 'cltbld', 06:09:14 INFO - 'MAIL': '/var/mail/cltbld', 06:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:14 INFO - 'MOZ_NO_REMOTE': '1', 06:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:14 INFO - 'NO_EM_RESTART': '1', 06:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:14 INFO - 'PWD': '/builds/slave/test', 06:09:14 INFO - 'SHELL': '/bin/bash', 06:09:14 INFO - 'SHLVL': '1', 06:09:14 INFO - 'TERM': 'linux', 06:09:14 INFO - 'TMOUT': '86400', 06:09:14 INFO - 'USER': 'cltbld', 06:09:14 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:14 INFO - '_': '/tools/buildbot/bin/python'} 06:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:14 INFO - Running setup.py (path:/tmp/pip-YsjEKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:14 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)) 06:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:14 INFO - Running setup.py (path:/tmp/pip-cZ_sRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:15 INFO - Running setup.py (path:/tmp/pip-l6jZWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:15 INFO - Running setup.py (path:/tmp/pip-Ydowu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:15 INFO - Running setup.py (path:/tmp/pip-l03HFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:15 INFO - Running setup.py (path:/tmp/pip-Cg5pqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:15 INFO - Running setup.py (path:/tmp/pip-Qdfme2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:15 INFO - Running setup.py (path:/tmp/pip-mvxSYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:15 INFO - Running setup.py (path:/tmp/pip-JF5BqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:15 INFO - Running setup.py (path:/tmp/pip-CZQWj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:15 INFO - Running setup.py (path:/tmp/pip-JqUkMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:15 INFO - Running setup.py (path:/tmp/pip-xQBlde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:15 INFO - Running setup.py (path:/tmp/pip-cZjmSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:15 INFO - Running setup.py (path:/tmp/pip-jDwDt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:15 INFO - Running setup.py (path:/tmp/pip-tHoPU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:15 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)) 06:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:15 INFO - Running setup.py (path:/tmp/pip-lybq5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:16 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)) 06:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:16 INFO - Running setup.py (path:/tmp/pip-JmG5bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:16 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)) 06:09:16 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)) 06:09:16 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)) 06:09:16 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)) 06:09:16 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)) 06:09:16 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)) 06:09:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:16 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 06:09:17 INFO - Downloading blessings-1.5.1.tar.gz 06:09:17 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 06:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:09:17 INFO - Installing collected packages: blessings 06:09:17 INFO - Running setup.py install for blessings 06:09:17 INFO - Successfully installed blessings 06:09:17 INFO - Cleaning up... 06:09:18 INFO - Return code: 0 06:09:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:18 INFO - Reading from file tmpfile_stdout 06:09:18 INFO - Current package versions: 06:09:18 INFO - argparse == 1.2.1 06:09:18 INFO - blessings == 1.5.1 06:09:18 INFO - blobuploader == 1.2.4 06:09:18 INFO - docopt == 0.6.1 06:09:18 INFO - manifestparser == 1.1 06:09:18 INFO - mozInstall == 1.12 06:09:18 INFO - mozcrash == 0.16 06:09:18 INFO - mozdebug == 0.1 06:09:18 INFO - mozdevice == 0.47 06:09:18 INFO - mozfile == 1.2 06:09:18 INFO - mozhttpd == 0.7 06:09:18 INFO - mozinfo == 0.9 06:09:18 INFO - mozleak == 0.1 06:09:18 INFO - mozlog == 3.1 06:09:18 INFO - moznetwork == 0.27 06:09:18 INFO - mozprocess == 0.22 06:09:18 INFO - mozprofile == 0.27 06:09:18 INFO - mozrunner == 6.11 06:09:18 INFO - mozscreenshot == 0.1 06:09:18 INFO - mozsystemmonitor == 0.0 06:09:18 INFO - moztest == 0.7 06:09:18 INFO - mozversion == 1.4 06:09:18 INFO - psutil == 3.1.1 06:09:18 INFO - requests == 1.2.3 06:09:18 INFO - wsgiref == 0.1.2 06:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:18 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 06:09:18 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 06:09:18 INFO - Using env: {'DISPLAY': ':0', 06:09:18 INFO - 'HOME': '/home/cltbld', 06:09:18 INFO - 'LANG': 'en_US.UTF-8', 06:09:18 INFO - 'LANGUAGE': 'en_US:en', 06:09:18 INFO - 'LOGNAME': 'cltbld', 06:09:18 INFO - 'MAIL': '/var/mail/cltbld', 06:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:18 INFO - 'MOZ_NO_REMOTE': '1', 06:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:18 INFO - 'NO_EM_RESTART': '1', 06:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:18 INFO - 'PWD': '/builds/slave/test', 06:09:18 INFO - 'SHELL': '/bin/bash', 06:09:18 INFO - 'SHLVL': '1', 06:09:18 INFO - 'TERM': 'linux', 06:09:18 INFO - 'TMOUT': '86400', 06:09:18 INFO - 'USER': 'cltbld', 06:09:18 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:18 INFO - '_': '/tools/buildbot/bin/python'} 06:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 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)) 06:09:18 INFO - Cleaning up... 06:09:18 INFO - Return code: 0 06:09:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:09:18 INFO - Using env: {'DISPLAY': ':0', 06:09:18 INFO - 'HOME': '/home/cltbld', 06:09:18 INFO - 'LANG': 'en_US.UTF-8', 06:09:18 INFO - 'LANGUAGE': 'en_US:en', 06:09:18 INFO - 'LOGNAME': 'cltbld', 06:09:18 INFO - 'MAIL': '/var/mail/cltbld', 06:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:18 INFO - 'MOZ_NO_REMOTE': '1', 06:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:18 INFO - 'NO_EM_RESTART': '1', 06:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:18 INFO - 'PWD': '/builds/slave/test', 06:09:18 INFO - 'SHELL': '/bin/bash', 06:09:18 INFO - 'SHLVL': '1', 06:09:18 INFO - 'TERM': 'linux', 06:09:18 INFO - 'TMOUT': '86400', 06:09:18 INFO - 'USER': 'cltbld', 06:09:18 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:18 INFO - '_': '/tools/buildbot/bin/python'} 06:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:18 INFO - Downloading/unpacking jsonschema 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:09:20 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 06:09:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:09:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:09:20 INFO - warning: no files found matching '*.txt' 06:09:20 INFO - no previously-included directories found matching 'build' 06:09:20 INFO - no previously-included directories found matching 'dist' 06:09:20 INFO - no previously-included directories found matching '.git*' 06:09:20 INFO - Installing collected packages: jsonschema, functools32 06:09:20 INFO - Running setup.py install for functools32 06:09:20 INFO - warning: no files found matching '*.txt' 06:09:20 INFO - no previously-included directories found matching 'build' 06:09:20 INFO - no previously-included directories found matching 'dist' 06:09:20 INFO - no previously-included directories found matching '.git*' 06:09:20 INFO - Successfully installed jsonschema functools32 06:09:20 INFO - Cleaning up... 06:09:20 INFO - Return code: 0 06:09:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:09:20 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')]} 06:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:20 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')]} 06:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:20 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 0x7fcb6603ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', '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 06:09:20 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 06:09:20 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 06:09:20 INFO - Using env: {'DISPLAY': ':0', 06:09:20 INFO - 'HOME': '/home/cltbld', 06:09:20 INFO - 'LANG': 'en_US.UTF-8', 06:09:20 INFO - 'LANGUAGE': 'en_US:en', 06:09:20 INFO - 'LOGNAME': 'cltbld', 06:09:20 INFO - 'MAIL': '/var/mail/cltbld', 06:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:20 INFO - 'MOZ_NO_REMOTE': '1', 06:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:20 INFO - 'NO_EM_RESTART': '1', 06:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:20 INFO - 'PWD': '/builds/slave/test', 06:09:20 INFO - 'SHELL': '/bin/bash', 06:09:20 INFO - 'SHLVL': '1', 06:09:20 INFO - 'TERM': 'linux', 06:09:20 INFO - 'TMOUT': '86400', 06:09:20 INFO - 'USER': 'cltbld', 06:09:20 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:20 INFO - '_': '/tools/buildbot/bin/python'} 06:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:21 INFO - Downloading/unpacking flake8 06:09:21 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 06:09:21 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 06:09:21 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 06:09:21 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 06:09:21 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 06:09:21 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 06:09:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:09:22 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 06:09:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:09:22 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 06:09:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:22 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 06:09:23 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 06:09:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:09:23 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 06:09:23 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 06:09:23 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 06:09:23 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 06:09:23 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 06:09:23 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 06:09:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:23 INFO - no previously-included directories found matching 'docs/_build' 06:09:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:09:23 INFO - Running setup.py install for pep8 06:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:23 INFO - no previously-included directories found matching 'docs/_build' 06:09:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:09:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:09:23 INFO - Cleaning up... 06:09:23 INFO - Return code: 0 06:09:23 INFO - Running post-action listener: _resource_record_post_action 06:09:23 INFO - Running post-action listener: _start_resource_monitoring 06:09:23 INFO - Starting resource monitoring. 06:09:23 INFO - ##### 06:09:23 INFO - ##### Running install step. 06:09:23 INFO - ##### 06:09:23 INFO - Running pre-action listener: _resource_record_pre_action 06:09:23 INFO - Running main action method: install 06:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:23 INFO - Reading from file tmpfile_stdout 06:09:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:09:23 INFO - Reading from file tmpfile_stdout 06:09:23 INFO - Output received: 06:09:23 INFO - Usage: mozinstall [options] installer 06:09:23 INFO - Options: 06:09:23 INFO - -h, --help show this help message and exit 06:09:23 INFO - -d DEST, --destination=DEST 06:09:23 INFO - Directory to install application into. [default: 06:09:23 INFO - "/builds/slave/test"] 06:09:23 INFO - --app=APP Application being installed. [default: firefox] 06:09:23 INFO - mkdir: /builds/slave/test/build/application 06:09:23 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'] 06:09:23 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 06:09:38 INFO - Reading from file tmpfile_stdout 06:09:38 INFO - Output received: 06:09:38 INFO - /builds/slave/test/build/application/firefox/firefox 06:09:38 INFO - Running post-action listener: _resource_record_post_action 06:09:38 INFO - ##### 06:09:38 INFO - ##### Running run-tests step. 06:09:38 INFO - ##### 06:09:38 INFO - Running pre-action listener: _resource_record_pre_action 06:09:38 INFO - Running main action method: run_tests 06:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:38 INFO - Python 2.7.3 06:09:38 INFO - Return code: 0 06:09:38 INFO - grabbing minidump binary from tooltool 06:09:38 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')]} 06:09:38 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 0x1efc0b0>, '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 0x1efcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:38 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 06:09:38 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 06:09:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:38 INFO - Return code: 0 06:09:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:39 INFO - Return code: 0 06:09:39 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/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test/build 06:09:39 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/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 06:09:39 INFO - Using env: {'DISPLAY': ':0', 06:09:39 INFO - 'HOME': '/home/cltbld', 06:09:39 INFO - 'LANG': 'en_US.UTF-8', 06:09:39 INFO - 'LANGUAGE': 'en_US:en', 06:09:39 INFO - 'LOGNAME': 'cltbld', 06:09:39 INFO - 'MAIL': '/var/mail/cltbld', 06:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:39 INFO - 'MOZ_NO_REMOTE': '1', 06:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:39 INFO - 'NO_EM_RESTART': '1', 06:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:39 INFO - 'PWD': '/builds/slave/test', 06:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:39 INFO - 'SHELL': '/bin/bash', 06:09:39 INFO - 'SHLVL': '1', 06:09:39 INFO - 'TERM': 'linux', 06:09:39 INFO - 'TMOUT': '86400', 06:09:39 INFO - 'USER': 'cltbld', 06:09:39 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925', 06:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:39 INFO - '_': '/tools/buildbot/bin/python'} 06:09:39 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/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 06:09:39 INFO - mozversion INFO | application_buildid: 20151216053720 06:09:39 INFO - mozversion INFO | application_changeset: f8840e2aec5afdebf63216dc219e103b5d4c391a 06:09:39 INFO - mozversion INFO | application_display_name: Nightly 06:09:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:39 INFO - mozversion INFO | application_name: Firefox 06:09:39 INFO - mozversion INFO | application_remotingname: firefox 06:09:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:09:39 INFO - mozversion INFO | application_vendor: Mozilla 06:09:39 INFO - mozversion INFO | application_version: 46.0a1 06:09:39 INFO - mozversion INFO | platform_buildid: 20151216053720 06:09:39 INFO - mozversion INFO | platform_changeset: f8840e2aec5afdebf63216dc219e103b5d4c391a 06:09:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:09:39 INFO - mozversion INFO | platform_version: 46.0a1 06:09:39 INFO - 2015-12-16 06:09:39,642 DEBUG : using testdate: 1450274979 06:09:39 INFO - 2015-12-16 06:09:39,642 DEBUG : actual date: 1450274979 06:09:39 INFO - 2015-12-16 06:09:39,651 INFO : starting webserver on 'localhost:36649' 06:09:39 INFO - 2015-12-16 06:09:39,652 INFO : Starting test suite talos-linux64-ix-060 06:09:39 INFO - 2015-12-16 06:09:39,652 INFO : Starting test dromaeo_css 06:09:39 INFO - 2015-12-16 06:09:39,652 DEBUG : operating with platform_type : linux_ 06:09:39 INFO - 2015-12-16 06:09:39,653 INFO : Initialising browser for dromaeo_css test... 06:09:39 INFO - 2015-12-16 06:09:39,669 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDnXeZm/profile http://localhost:36649/getInfo.html 06:09:43 INFO - 2015-12-16 06:09:43,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:09:43 INFO - 2015-12-16 06:09:43,636 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:09:43 INFO - 2015-12-16 06:09:43,636 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:09:43 INFO - 2015-12-16 06:09:43,636 DEBUG : BROWSER_OUTPUT: __metrics 06:09:43 INFO - 2015-12-16 06:09:43,765 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] 06:09:43 INFO - 2015-12-16 06:09:43,841 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] 06:09:45 INFO - 2015-12-16 06:09:45,039 INFO : Browser initialized. 06:09:45 INFO - 2015-12-16 06:09:45,039 INFO : Running cycle 1/1 for dromaeo_css test... 06:09:45 INFO - 2015-12-16 06:09:45,039 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDnXeZm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:09:57 INFO - 2015-12-16 06:09:57,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 142094336 06:09:57 INFO - 2015-12-16 06:09:57,019 DEBUG : BROWSER_OUTPUT: 06:10:48 INFO - 2015-12-16 06:10:48,466 DEBUG : BROWSER_OUTPUT: 1450275048465 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] 06:13:00 INFO - 2015-12-16 06:13:00,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36649/tests/dromaeo/cssquery-ext.html) 06:13:01 INFO - 2015-12-16 06:13:01,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 263127040 06:13:01 INFO - 2015-12-16 06:13:01,535 DEBUG : BROWSER_OUTPUT: 06:16:04 INFO - 2015-12-16 06:16:04,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-ext.html (next: http://localhost:36649/tests/dromaeo/cssquery-jquery.html) 06:16:04 INFO - 2015-12-16 06:16:04,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 219779072 06:16:04 INFO - 2015-12-16 06:16:04,754 DEBUG : BROWSER_OUTPUT: 06:19:06 INFO - 2015-12-16 06:19:06,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36649/tests/dromaeo/cssquery-mootools.html) 06:19:07 INFO - 2015-12-16 06:19:07,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 218628096 06:19:07 INFO - 2015-12-16 06:19:07,397 DEBUG : BROWSER_OUTPUT: 06:22:09 INFO - 2015-12-16 06:22:09,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36649/tests/dromaeo/cssquery-prototype.html) 06:22:09 INFO - 2015-12-16 06:22:09,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 204304384 06:22:09 INFO - 2015-12-16 06:22:09,953 DEBUG : BROWSER_OUTPUT: 06:25:12 INFO - 2015-12-16 06:25:12,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36649/tests/dromaeo/cssquery-yui.html) 06:25:13 INFO - 2015-12-16 06:25:13,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 210341888 06:25:13 INFO - 2015-12-16 06:25:13,393 DEBUG : BROWSER_OUTPUT: 06:28:15 INFO - 2015-12-16 06:28:15,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/dromaeo/cssquery-yui.html (next: http://localhost:36649/tests/dromaeo/cssquery-dojo.html) 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 255614976 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:28:16 INFO - 2015-12-16 06:28:16,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:28:16 INFO - 2015-12-16 06:28:16,188 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2635.907743228987;2712.9864350678245;2729.113038262565;2741.28726531102;2760.4203117345355;4546.249868771657;4696.718196908188;4721.244600863863;4755.429348478183;4792.305115758218;4685.531446855312;4708.152532544141;4818.975905120469;4831.975840120804;4842.685225460343;4269.252880745865;4296.806643701041;4322.827086916535;4376.737395756265;4380.846670366538;4438.533953934839;4513.864584062467;4522.428018352457;4522.796474158671;4526.004279058602;4156.605122513387;4270.359446083081;4278.2940814765525;4429.11417716458;4475.5748203920575;4391.231534481485;4429.667774916862;4438.911221775578;4443.178012067778;4472.910541789146;4393.648508119375;4400.603945644907;4404.163208990281;4404.537523560044;4440.933385999213;4419.712718673276;4536.591706746376;4543.363929049936;4552.157850797613;4743.335932969387;5093.974530127326;5114.718690472023;5147.202183661501;5151.278820965068;5157.58739300855;5114.718690472023;5115;5119.641625086246;5127.846164615067;5164.1220992431;4539.182947069559;4663.044075964419;4740.028294199681;4747.169245382044;4762.428508578958;5115.411727651293;5152;5168.767405466688;5188.014277287379;5229.849433124707;4944;4990.151674215392;5003.174476211457;5003.74981250936;5026.070177017264;4838.540338667821;5079.8984020319385;5085.440601533828;5094.159463688524;5145.665531740425;4924.089043526959;4943.406791185009;4981.452040275567;4991.4758950310425;5026.698398096126;5055.570276526463;5057.898842023139;5082.059818933509;5144.7942082316285;5166.173412254021;4214.199302132585;4241.406203131564;4248.468941382327;4274.294741367639;4282.807273672693;3579.534660494119;3673.2469843682516;3674.3018826423427;3739.6260373962386;3746.7189960753053;4299.892502687395;4368.4102646143;4369.825206991748;4391.934120988188;4408.955910440919;5092.976548526696;5155.922661160085;5156.793728250828;5157.58739300855;5192.091384007784;4194.496660400771;4304.332828411601;4424.513303536608;4429.734215947054;4471;4348.499922508889;4396.362527433568;4460.50934397216;4501.279795232747;4512.503624601291;4770.260609605517;4835.2505361669;4835.927461088017;4841.612670986242;4881.48744381849;4873.1471992400475;5061.595072394273;5076.289319495199;5079.3650793650795;5123.154679477844;4777.761111944319;4782.760861956818;4849;4894.804207831647;4943;4999.750012499433;5007.524285192901;5008.899822003613;5010.148274793367;5057.14028615129;5080.847574572621;5082.33929589151;5090.312807770903;5091.312672789274;5136.357955255593;4773.856784296477;4832.63755218353;4905.3623029006;4914.508549145057;4915.778789954389;4989.625778066732;5001.57486613642;5006.549410553068;5009.323741294878;5031.723255220998;4881.731504767272;4898.608111351155;4900.093482705711;4908.5091490852055;4933.284673722362;4673.158831410243;4786.736729479912;4794.952050479451;4867.732274724783;5077.7968881245815;4878.292647566154;4893.070316639827;4898.387701537308;4901.436334821541;4943.134951383421 06:28:16 INFO - 2015-12-16 06:28:16,188 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.4163482430508;571.7770069672828;575.3929604267496;581.6858896196054;582.1239035251945;27529.862350688243;27890.86054569727;32778.18054548634;33006.66993330066;33102;39043.609563904356;39492.60507394925;39507.40738888919;39541.802290988504;39560.802195989054;7938.841223175533;8133.511989280662;8136.064352599438;8136.064352599467;8139.308158806479;7244.492885498017;7420.925790742078;10145.086942175203;10335.793284134314;10367.948160259188;10212.2851400402;10293.536790844393;10301.63944261951;10317.896821031805;10325.070743633072;7176.138863336381;7343.632818359114;10154.746131346701;10269.075783179474;10277.640282590073;10228.795424091551;10437.32157409766;10442;10442.843357349646;10457.84313235302;37062.07344816374;37548.06129846748;37584.81207593972;37653;37746.24507509862;2945.8527073646233;2959.5708622249654;2991.7157870002316;3433.124553238908;3624.3113808376324;28186.295342616395;28304.433911321863;28510.144695659164;28659.57010644842;28852.278693032844;3047.7714171437233;3078.9384212315854;3105.491587229235;3109.6112985876766;3111.9533207001914;208869.11308869143;212043;212575;213023.99999999846;213753;52999;54297;55776;56266.437335626935;58189;49981.50018499768;50060.49939500559;50235.49764502381;50265.497345026815;50360;14399.136051836924;14782.48261310849;14795;14800.925995369955;14818.555443336718;11294.887051129384;11344.943275283571;11346.489407976496;11359.204855660024;11514.596989105508;19146.329878454188;19283;19302.903485482482;19312.61374772525;19336.226550938085;7597.126330471956;7734.961325193338;7894.486858354188;7931.206879312138;7944.364450843918;804.6137853830078;833.7623777223462;886.6187539358009;916.2944532709777;984.9507524623883;23323;25911;27275.934197516726;27575.586366204523;27641.585376219373;993.344492268459;996.6362277768707;999.4053538144792;1069.0271852614085;1102.5204036244259;13462.798058029137;13488.797668034988;13608.319584020759;13652.658683532793;13669.794953075712;250437;252618;253064;253394;254421;46066.30900536494;46198.769006155424;46304.30543541849;46369.76815115903;46382.53617463782;1259.8614152443224;1264.595329494553;1274.464724815561;1275.324078238535;1290.9806352904714;25224.74775252224;25888;26254.4749105013;26297.737022629528;26496.072637457597;37013.62986370102;37596.812015939744;41188.1762364757;41733.37399939064;43854.12291754083;162092;163200;163385;163508;164603;26407.471850563266;26762.866185668947;26784.866075669495;26809;26828.32929176708;30511.542326865558;32941.17647058843;33130;38544.61455385522;38913.2217355657;28699.13902582926;29214.26964325909;29231.123066308046;29568.852155739085;29833.403331932805;29401.264968375963;29652.851735741184;29663.555046674748;29807;29841.701582984762;29774.553381698857;29962.70037299599;33408.33183336271;34237.657623423445;34318.31363372769;25478.490430191665;27198.864005679847;27525;27622.171334859988;27795.888164474003;22707.772922271226;22851.31446056621;22883.31350059501;23017.65473517865;23230 06:28:16 INFO - 2015-12-16 06:28:16,188 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.83975691667996;334.1345914082527;337.6910127233581;337.98141102239396;338.9372966001292;12635.11554191207;13132.73734525309;14941.402343906244;15514.456994005212;17060.914695426505;9615.038496150399;9693.612255509772;9694.709158725249;9803.117719405253;9891.109800117987;4498.190325741357;4622.168009758242;4626.352310676508;4639.072185562884;4644.628429725631;3557.5375201223806;3653.8538458461762;5167.7932882684645;5316;5322.7072511011875;5200.92198617021;5227.921581176285;5229.555487783524;5270.736463176826;5310.336207974004;5700.116481945305;5722.628029178131;5722.713864306809;5730.570207234453;5736.942630573682;4726.338312636233;4996.25056241563;5017.272495488134;5019.974900125512;5037.672551284191;12097.2136811107;12105.878941210563;17878.016709080995;19402.611947761106;19595.608087838307;1803.8376546110783;1847.815218478155;1873.7095750158746;1910.3218357483033;1916.993578371366;8716.389852710312;8958.193762561335;10177.389356638625;12750.10749247553;13024.218546887123;1684.4862316993313;1695.542203605032;1740.7562941188244;1749.9650006999916;1796.793368762596;54860.51394860522;57581.712091439695;58329.416705832824;58851.41148588502;59450.40549594492;9622.845258569016;9881.61657367969;9891.554880030415;9919.40483570988;9944.850827237597;12604.747905042032;12648.177868438523;12649.43077561512;12696.111272211041;12697.682557936125;6778.661066946633;6939.132608423947;7097.503174777716;7107.609081500567;7200.207977122513;6345.238571371465;6662.133922590032;6748.865022699617;6756.290589488033;6768.69540870662;4052.230076285496;4141.79291035453;4162.354835000579;4177.49870015594;4255.76593287366;1500.422337400087;1564.9843501565067;1566.6240102375348;1591.9761203581957;1690.9915450422668;852.2372476633502;885.0087901550177;907.7322189953848;935.9625614975461;956.4978386347084;14603.56189314301;15016.699666006838;15200.467983620742;15411.537653870178;15434.536963891102;852.8294341131799;863.4128792421213;866.445474896067;899.3479727197729;945.6548359848744;8245.917540824636;8584.141585841491;8627.180417860292;8699.173578510032;8760.167784060504;487488;490012;493305;503551;511516;67226.32773672299;70248.29751702417;71556;72972;73222.26777732262;1062.2564205056492;1067.2315932528568;1090.6455401994383;1118.8489553910117;1119.972000699989;14537.127772333693;14625.853741462875;14808.925955370154;14916.328765205808;15089.849101508844;32609;33142.66857331492;33151.83424082864;33297.50053749147;33386.833065834515;41997.1600567993;43829;43900;44211.55788442074;44334;8239.546824924686;8352.749417517483;8359.540225287425;8368.288695460955;8435.156484351515;11278.4724241545;13109.672258193621;16281.18594070268;16306.429274975793;16436.75344869804;10664.733381665521;11091;13701.588952331445;13903;14173.22047287409;12994.220346778846;13041;13414.798778018143;13597.320133993459;13645.522406715718;10980.945095274792;13285.933570332087;13487.527936522174;13621.795673064713;13761.449542018207;8201.95899020501;8281.3788965829;8315.542645154575;8325.333973282002;8351.540665263468;9036;9179.632814687338;12121.575744848888;13270.80093798613;13581.524646637321 06:28:16 INFO - 2015-12-16 06:28:16,189 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1244.129109623264;1397.050005995923;1539.3688587679053;1557.1591340676036;1740.146160297113;5869.35437101919;7060.293970602937;7199.640017999099;7201.3158749918675;7205.567665940047;7140.286331280481;7300.744473943413;7305.853882922338;7319.377852882511;7322.670479828407;1768.6285879965224;1798.3975368251586;1801.7207332863427;2077.1276064053095;2117.2166298469588;1784.4735802938164;2073.8029887160696;2093;2112.049577690038;2115.4182599785104;2041.2753472517265;2062.2885104638876;2066.0186411454515;2070.4099331690472;2071.647819870618;2063.546019875625;2077.9584408311825;2087.7285952826187;2089.8955052247325;2090.5505316356903;2069.1619893942975;2094.1100032486283;2121.5226574020876;2121.6711409731515;2123.458518077896;7194.388476979463;7230.855382892365;7262.237465066145;7270.854582908365;7285.927140728578;4193.077522944947;4233.809478573441;4263.936040959357;4268.594483524092;4304.548022457629;2589.6374507568958;2634.315078079694;2656.176585258576;2722.169738229839;2729.3176705823544;835.4277320035795;837.0206857976121;848.6520526584071;870.3298460185622;886.7295474880159;9428.528573571362;9430.622775088988;9449.574769135406;9451.196648284904;9470.052994700543;3868.6324799144036;3913.2760439318818;3976.324024915771;3981.044549308145;3998.980005099956;8255.669773209005;8272.793180170424;8275.213854683796;8275.379346549033;8286.212809783061;4339.913201735948;4363.890902727458;4364.345348197796;4364.54172311909;4367.67242456817;3929.410588411761;3930.508686414198;3931.6264954829244;3934.15415685629;3935.2326296372507;2984.7313741763346;3470.878519251814;3478.513008178857;3505.2288496530723;3508.7017603503477;971.1696499492832;990.0000998991071;990.153418826907;1111.7609713911547;1134.6766171641043;963.604921981984;972.6936015155203;1019.8827134879435;1065.5524679634573;1204.933728644933;6684.832879177962;6766.815807233715;6769.086173366631;6770.255271920085;6783.3555812197765;1025.646152077547;1039.2361614213546;1048.8688913885765;1055.266589720137;1059.920505962056;5281.207818827206;5375.623706340519;5393.460653934653;5394.811181608703;5398.514133727984;8427.073021967579;8465.365097617703;8732.69435569752;8836.513991730388;8844.911550884537;8615.741527754051;8655.523946182895;8717.128287171232;8730.126987301219;8748;6752.662366881636;6834.043233947252;6889.724411023503;6907.205671347759;6919.654017299215;6611.371919667624;6639;6647.368499992493;6656.900146497709;6667.099941507834;7567.129780075362;7789.221077892392;7803.765887023398;7813;7815.491993020435;7874.448788584744;7979.640916158903;7991.600419978861;8117.269445749911;8131.715389961323;6213.03697926822;6217.191765070512;6227.377262273736;6291.245050593958;6308.621482711052;6912.239653637996;6952.304769523007;6956.965215173892;6963.61700106499;6964.303569642995;6394.4564712;6645.534812563074;6652.301508341748;6687.933120668731;6798.592084474947;5525.806596769094;5643.435656434323;6041.758329666764;6329.556931014785;6546.574472659262;6116.755329786759;6231.314555398993;6374;6413.775517856852;6418.743250269937;6042.516598672008;6074.453299203093;6081.148639190428;6082.2093127893095;6088.908666369919;6036.517078633611;6049.576529642883;6057.666828324484;6064.787732429344;6081.513478921587 06:28:16 INFO - 2015-12-16 06:28:16,192 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.37878901279845;304.1514175450492;305.39379332025925;310.23681742912447;311.9485284927987;5220.92168617471;5344.1182204936185;5353.866153346168;5387.622866399353;5494.2857428534335;5148.665336753108;5316.7873285068645;5324.254604355393;5324.893502129965;5332.493413125757;3917.334053210947;4125.979370103145;4133.834646614132;4134.772587507686;4139.4825646794225;4002.4396584478195;4005.3591425371947;4098.241825262321;4101.220768054075;4101.302778527643;4045.4943132108488;4045.5145382554133;4068.084680946793;4069.47096877407;4075.9796201019103;4064.6138616831354;4069.857554985576;4074.8166332515107;4076.347784354519;4079.102597428561;3550.786952782841;3554.7867127972145;3564.946525802115;3567;3569.1434055826676;4978;5096.51583099605;5105.5149760772665;5120.15517439622;5121.052605268;4668.066386722669;4671.182543054986;4672.345871577982;4675.953240467586;4678.883027924329;5569.721513924328;5578.748956296936;5594.888102237933;5599.888002239933;5600.355959064719;3684.5394325709285;3779.225258821935;3861.1119442528093;3867.8259478323544;3872.5352957645264;5780.393058728815;5883.441073098092;5909;5928.199693041427;5935.792247271324;3949.30887094763;3958.5447673517338;3959.7822119783687;3968.3650615901315;3978.622030907059;4026.4362989181536;4027.194561087794;4033.7176397651883;4042.15114825884;4044.2518134145275;4556.059815513013;4634.930476042862;4646.97676511622;4649;4649.418822647169;5580.051391263414;5599.916001259984;5611.186377975171;5614.63504872182;5621.915671264935;1422.9715405691827;1440.1215258692189;1443.7689969604812;1444.7832825076111;1445.7542217822995;948.818720692742;954.5799848066829;971.062924278075;972.1736523954582;974.449436068619;4912.557869791736;4930.975345123252;4931.679440836334;4932.7533623319405;4935.062338155811;5798.33319168301;5802.680852553066;5804.506616937523;5806.68063256525;5810.593258471867;4904.411470623548;4924.162892308316;4931.18635425158;4938.2839488274;4941;3035.848207589656;3079.6920307969026;3123.640781310178;3132.4361614909535;3134.6081739782526;5516.089845175581;5592.888142237132;5602.915956260659;5604.41153678866;5608.074667679869;6022.066579680069;6024.126501657235;6030.638161710312;6035.456808887221;6062.242219722535;5586;5597.384287728347;5604.719764011783;5605.775768969195;5610.214569960291;5659.066254068032;5775.191473193672;5847.853803654943;5877.794277200277;5892.057270836645;5430.185472179205;5715.657060576213;5717.828465145886;5717.942820571741;5726.599138060295;5402.378726446509;5459.153831156177;5477.698726570077;5481.232627432242;5487.5609951203005;3921.568627450921;3981.323175060189;3992.640662340403;4022.376531637484;4040.2323558523785;5801.883962320814;5802.1296805479515;5808.07070868659;5814.622049566765;5823.213866128019;5479.890402192013;5563.944360556505;5581.7209139543675;5642.294713160855;5648.5481161507805;5658.094704847204;5662.688552129673;5668.03643380618;5671.971640141773;5672.404397538364;5523.309586301712;5525.861853453695;5546.223528706065;5549.1676248563035;5552.666839989613;5567.8886422272135;5709.429057094258;5710.971445142748;5715.171300161536;5722.914156287576;5559.471850174227;5560.5551555876245;5570.359408668055;5570.387257401601;5576.9163462547285 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: |5;yui.html;627.8712863862909;657.8750037492875;700.8388070743728;739.0429393934854;753.1000454456923;11661.883381166186;11684.532618695242;11851.288922664646;11894.286342819427;11923.58267460638;11334;11707.121965852553;11722.648320550397;11724.12069094817;11735;648.8118445650756;809.0372456776432;822.2024636102971;827.4952279109739;827.5365795154703;640.4172203295002;815.3843847894831;827.2513375395276;835.7952301686065;835.9122292159327;861.0872475176302;873.253368370044;874.8075423406872;875.2866413872705;875.3216257400534;662.7812821768805;667.4693618573245;848.2535368875411;865.709987154301;866.9609867555976;632.4339715954242;638.4987784589075;639.1563136659564;639.5874660843776;640.6092283706935;11726.237794543413;11952.103592230531;12025.158238923279;12028.27830330183;12047.759044819142;11263.098952083896;11671.241369311052;11704.946554810109;11724.120690948213;11912.761744765143;9590.67821930088;9685.612575496973;9715.125638692552;9742.512874356325;9773.853392199122;3272.460044092722;3313.684565388759;3348.1294863335706;3348.3972884880714;3354.798712077283;39543.80228098841;39889.20221595552;40115.799421003;40125.79937100325;40167;9276.7680807979;9364.25085993119;9364.438133712;9366.578503967337;9512.1439070484;16600.169991500377;16685;16699.582510437336;16721.498355049367;16746.49760507187;6258.217722784652;6280;6281;6336.334684858116;6428.453581445629;3349.732021438279;3439.9656003440145;3459;3468.6357932417236;3485.5991560970306;2466.21081253997;2499.0628514307136;2502.637117617935;2507.398224426161;2508.460680953567;447.6262320961968;456.67576021025445;459.4830815332751;461.8822200338892;472.6266249662728;558.2826068501955;603.1074010464537;613.5337143770766;629.4020680353682;643.3437893348852;7882.448228624056;8717.30261579072;8803.735887923373;8984.004017641802;9064.184223419923;508.3340823521199;508.8676943994588;516.4964159944025;559.5216090242784;608.6179507545688;3640.508531348287;3741.1021354874633;3817.295253259053;3818.4845045919;3885.669718073995;49863.75068124709;50237.497625024014;50271.49728502741;50465;50687.746561266955;42583;43457.91355216145;43712.78143609325;44009.77995110004;44290.33564496535;40386.39420408696;40422;40896;40919.38620920689;40935.59064409318;7484.101907771103;7554.206808285051;7685.769426917202;7759.146493885555;7780.455368124403;28557.28606784847;29011.984580539578;29795.702042979294;29892.861249569352;31086.067417977498;34337;34411.13972150716;34544.30911381708;34576.654233457346;34829.65170348264;9755.512224388895;9948.293486567361;10046.995936292178;10100.949495252476;10127.18982481385;11069.944650276697;11196.608118715805;11564.537418503165;11668.94165529167;11777.234479758788;11004.669859904216;11058.447077646246;11206.607768728056;11567.190296679151;11571.884281157081;10726.624568140078;10839.891601084204;10849.728756781144;10879.129669626569;11352.602658906899;10550.947245263724;10757.1932105094;10777.51501182433;10786.622468213574;10847.566097356017;8663.26362259215;8793.472391656265;8945.955270223607;9018.594163262538;9322.533873306444;8689.10369155633;9056.230220431336;9084.818303634023;9192.816143676955;9244.029376915327 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1075 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: __startTimestamp1450276096180__endTimestamp 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,193 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4685.40 Median:4835.25 stddev:492.50 (10.2%) stddev-sans-first:467.04 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: Values: 2635.9 2713.0 2729.1 2741.3 2760.4 4546.2 4696.7 4721.2 4755.4 4792.3 4685.5 4708.2 4819.0 4832.0 4842.7 4269.3 4296.8 4322.8 4376.7 4380.8 4438.5 4513.9 4522.4 4522.8 4526.0 4156.6 4270.4 4278.3 4429.1 4475.6 4391.2 4429.7 4438.9 4443.2 4472.9 4393.6 4400.6 4404.2 4404.5 4440.9 4419.7 4536.6 4543.4 4552.2 4743.3 5094.0 5114.7 5147.2 5151.3 5157.6 5114.7 5115.0 5119.6 5127.8 5164.1 4539.2 4663.0 4740.0 4747.2 4762.4 5115.4 5152.0 5168.8 5188.0 5229.8 4944.0 4990.2 5003.2 5003.7 5026.1 4838.5 5079.9 5085.4 5094.2 5145.7 4924.1 4943.4 4981.5 4991.5 5026.7 5055.6 5057.9 5082.1 5144.8 5166.2 4214.2 4241.4 4248.5 4274.3 4282.8 3579.5 3673.2 3674.3 3739.6 3746.7 4299.9 4368.4 4369.8 4391.9 4409.0 5093.0 5155.9 5156.8 5157.6 5192.1 4194.5 4304.3 4424.5 4429.7 4471.0 4348.5 4396.4 4460.5 4501.3 4512.5 4770.3 4835.3 4835.9 4841.6 4881.5 4873.1 5061.6 5076.3 5079.4 5123.2 4777.8 4782.8 4849.0 4894.8 4943.0 4999.8 5007.5 5008.9 5010.1 5057.1 5080.8 5082.3 5090.3 5091.3 5136.4 4773.9 4832.6 4905.4 4914.5 4915.8 4989.6 5001.6 5006.5 5009.3 5031.7 4881.7 4898.6 4900.1 4908.5 4933.3 4673.2 4786.7 4795.0 4867.7 5077.8 4878.3 4893.1 4898.4 4901.4 4943.1 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37104.85 Median:29033.27 stddev:55153.19 (190.0%) stddev-sans-first:55239.68 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: Values: 569.4 571.8 575.4 581.7 582.1 27529.9 27890.9 32778.2 33006.7 33102.0 39043.6 39492.6 39507.4 39541.8 39560.8 7938.8 8133.5 8136.1 8136.1 8139.3 7244.5 7420.9 10145.1 10335.8 10367.9 10212.3 10293.5 10301.6 10317.9 10325.1 7176.1 7343.6 10154.7 10269.1 10277.6 10228.8 10437.3 10442.0 10442.8 10457.8 37062.1 37548.1 37584.8 37653.0 37746.2 2945.9 2959.6 2991.7 3433.1 3624.3 28186.3 28304.4 28510.1 28659.6 28852.3 3047.8 3078.9 3105.5 3109.6 3112.0 208869.1 212043.0 212575.0 213024.0 213753.0 52999.0 54297.0 55776.0 56266.4 58189.0 49981.5 50060.5 50235.5 50265.5 50360.0 14399.1 14782.5 14795.0 14800.9 14818.6 11294.9 11344.9 11346.5 11359.2 11514.6 19146.3 19283.0 19302.9 19312.6 19336.2 7597.1 7735.0 7894.5 7931.2 7944.4 804.6 833.8 886.6 916.3 985.0 23323.0 25911.0 27275.9 27575.6 27641.6 993.3 996.6 999.4 1069.0 1102.5 13462.8 13488.8 13608.3 13652.7 13669.8 250437.0 252618.0 253064.0 253394.0 254421.0 46066.3 46198.8 46304.3 46369.8 46382.5 1259.9 1264.6 1274.5 1275.3 1291.0 25224.7 25888.0 26254.5 26297.7 26496.1 37013.6 37596.8 41188.2 41733.4 43854.1 162092.0 163200.0 163385.0 163508.0 164603.0 26407.5 26762.9 26784.9 26809.0 26828.3 30511.5 32941.2 33130.0 38544.6 38913.2 28699.1 29214.3 29231.1 29568.9 29833.4 29401.3 29652.9 29663.6 29807.0 29841.7 29774.6 29962.7 33408.3 34237.7 34318.3 25478.5 27198.9 27525.0 27622.2 27795.9 22707.8 22851.3 22883.3 23017.7 23230.0 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,195 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26344.26 Median:44055.78 stddev:81264.55 (184.5%) stddev-sans-first:81469.05 06:28:16 INFO - 2015-12-16 06:28:16,196 DEBUG : BROWSER_OUTPUT: Values: 333.8 334.1 337.7 338.0 338.9 12635.1 13132.7 14941.4 15514.5 17060.9 9615.0 9693.6 9694.7 9803.1 9891.1 4498.2 4622.2 4626.4 4639.1 4644.6 3557.5 3653.9 5167.8 5316.0 5322.7 5200.9 5227.9 5229.6 5270.7 5310.3 5700.1 5722.6 5722.7 5730.6 5736.9 4726.3 4996.3 5017.3 5020.0 5037.7 12097.2 12105.9 17878.0 19402.6 19595.6 1803.8 1847.8 1873.7 1910.3 1917.0 8716.4 8958.2 10177.4 12750.1 13024.2 1684.5 1695.5 1740.8 1750.0 1796.8 54860.5 57581.7 58329.4 58851.4 59450.4 9622.8 9881.6 9891.6 9919.4 9944.9 12604.7 12648.2 12649.4 12696.1 12697.7 6778.7 6939.1 7097.5 7107.6 7200.2 6345.2 6662.1 6748.9 6756.3 6768.7 4052.2 4141.8 4162.4 4177.5 4255.8 1500.4 1565.0 1566.6 1592.0 1691.0 852.2 885.0 907.7 936.0 956.5 14603.6 15016.7 15200.5 15411.5 15434.5 852.8 863.4 866.4 899.3 945.7 8245.9 8584.1 8627.2 8699.2 8760.2 487488.0 490012.0 493305.0 503551.0 511516.0 67226.3 70248.3 71556.0 72972.0 73222.3 1062.3 1067.2 1090.6 1118.8 1120.0 14537.1 14625.9 14808.9 14916.3 15089.8 32609.0 33142.7 33151.8 33297.5 33386.8 41997.2 43829.0 43900.0 44211.6 44334.0 8239.5 8352.7 8359.5 8368.3 8435.2 11278.5 13109.7 16281.2 16306.4 16436.8 10664.7 11091.0 13701.6 13903.0 14173.2 12994.2 13041.0 13414.8 13597.3 13645.5 10980.9 13285.9 13487.5 13621.8 13761.4 8202.0 8281.4 8315.5 8325.3 8351.5 9036.0 9179.6 12121.6 13270.8 13581.5 06:28:16 INFO - 2015-12-16 06:28:16,196 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5012.20 Median:6215.11 stddev:2603.92 (41.9%) stddev-sans-first:2595.82 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: Values: 1244.1 1397.1 1539.4 1557.2 1740.1 5869.4 7060.3 7199.6 7201.3 7205.6 7140.3 7300.7 7305.9 7319.4 7322.7 1768.6 1798.4 1801.7 2077.1 2117.2 1784.5 2073.8 2093.0 2112.0 2115.4 2041.3 2062.3 2066.0 2070.4 2071.6 2063.5 2078.0 2087.7 2089.9 2090.6 2069.2 2094.1 2121.5 2121.7 2123.5 7194.4 7230.9 7262.2 7270.9 7285.9 4193.1 4233.8 4263.9 4268.6 4304.5 2589.6 2634.3 2656.2 2722.2 2729.3 835.4 837.0 848.7 870.3 886.7 9428.5 9430.6 9449.6 9451.2 9470.1 3868.6 3913.3 3976.3 3981.0 3999.0 8255.7 8272.8 8275.2 8275.4 8286.2 4339.9 4363.9 4364.3 4364.5 4367.7 3929.4 3930.5 3931.6 3934.2 3935.2 2984.7 3470.9 3478.5 3505.2 3508.7 971.2 990.0 990.2 1111.8 1134.7 963.6 972.7 1019.9 1065.6 1204.9 6684.8 6766.8 6769.1 6770.3 6783.4 1025.6 1039.2 1048.9 1055.3 1059.9 5281.2 5375.6 5393.5 5394.8 5398.5 8427.1 8465.4 8732.7 8836.5 8844.9 8615.7 8655.5 8717.1 8730.1 8748.0 6752.7 6834.0 6889.7 6907.2 6919.7 6611.4 6639.0 6647.4 6656.9 6667.1 7567.1 7789.2 7803.8 7813.0 7815.5 7874.4 7979.6 7991.6 8117.3 8131.7 6213.0 6217.2 6227.4 6291.2 6308.6 6912.2 6952.3 6957.0 6963.6 6964.3 6394.5 6645.5 6652.3 6687.9 6798.6 5525.8 5643.4 6041.8 6329.6 6546.6 6116.8 6231.3 6374.0 6413.8 6418.7 6042.5 6074.5 6081.1 6082.2 6088.9 6036.5 6049.6 6057.7 6064.8 6081.5 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4645.67 Median:5338.31 stddev:1381.58 (25.9%) stddev-sans-first:1346.39 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: Values: 299.4 304.2 305.4 310.2 311.9 5220.9 5344.1 5353.9 5387.6 5494.3 5148.7 5316.8 5324.3 5324.9 5332.5 3917.3 4126.0 4133.8 4134.8 4139.5 4002.4 4005.4 4098.2 4101.2 4101.3 4045.5 4045.5 4068.1 4069.5 4076.0 4064.6 4069.9 4074.8 4076.3 4079.1 3550.8 3554.8 3564.9 3567.0 3569.1 4978.0 5096.5 5105.5 5120.2 5121.1 4668.1 4671.2 4672.3 4676.0 4678.9 5569.7 5578.7 5594.9 5599.9 5600.4 3684.5 3779.2 3861.1 3867.8 3872.5 5780.4 5883.4 5909.0 5928.2 5935.8 3949.3 3958.5 3959.8 3968.4 3978.6 4026.4 4027.2 4033.7 4042.2 4044.3 4556.1 4634.9 4647.0 4649.0 4649.4 5580.1 5599.9 5611.2 5614.6 5621.9 1423.0 1440.1 1443.8 1444.8 1445.8 948.8 954.6 971.1 972.2 974.4 4912.6 4931.0 4931.7 4932.8 4935.1 5798.3 5802.7 5804.5 5806.7 5810.6 4904.4 4924.2 4931.2 4938.3 4941.0 3035.8 3079.7 3123.6 3132.4 3134.6 5516.1 5592.9 5602.9 5604.4 5608.1 6022.1 6024.1 6030.6 6035.5 6062.2 5586.0 5597.4 5604.7 5605.8 5610.2 5659.1 5775.2 5847.9 5877.8 5892.1 5430.2 5715.7 5717.8 5717.9 5726.6 5402.4 5459.2 5477.7 5481.2 5487.6 3921.6 3981.3 3992.6 4022.4 4040.2 5801.9 5802.1 5808.1 5814.6 5823.2 5479.9 5563.9 5581.7 5642.3 5648.5 5658.1 5662.7 5668.0 5672.0 5672.4 5523.3 5525.9 5546.2 5549.2 5552.7 5567.9 5709.4 5711.0 5715.2 5722.9 5559.5 5560.6 5570.4 5570.4 5576.9 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,197 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12108.94 Median:43861.28 stddev:13449.19 (30.7%) stddev-sans-first:13459.28 06:28:16 INFO - 2015-12-16 06:28:16,198 DEBUG : BROWSER_OUTPUT: Values: 627.9 657.9 700.8 739.0 753.1 11661.9 11684.5 11851.3 11894.3 11923.6 11334.0 11707.1 11722.6 11724.1 11735.0 648.8 809.0 822.2 827.5 827.5 640.4 815.4 827.3 835.8 835.9 861.1 873.3 874.8 875.3 875.3 662.8 667.5 848.3 865.7 867.0 632.4 638.5 639.2 639.6 640.6 11726.2 11952.1 12025.2 12028.3 12047.8 11263.1 11671.2 11704.9 11724.1 11912.8 9590.7 9685.6 9715.1 9742.5 9773.9 3272.5 3313.7 3348.1 3348.4 3354.8 39543.8 39889.2 40115.8 40125.8 40167.0 9276.8 9364.3 9364.4 9366.6 9512.1 16600.2 16685.0 16699.6 16721.5 16746.5 6258.2 6280.0 6281.0 6336.3 6428.5 3349.7 3440.0 3459.0 3468.6 3485.6 2466.2 2499.1 2502.6 2507.4 2508.5 447.6 456.7 459.5 461.9 472.6 558.3 603.1 613.5 629.4 643.3 7882.4 8717.3 8803.7 8984.0 9064.2 508.3 508.9 516.5 559.5 608.6 3640.5 3741.1 3817.3 3818.5 3885.7 49863.8 50237.5 50271.5 50465.0 50687.7 42583.0 43457.9 43712.8 44009.8 44290.3 40386.4 40422.0 40896.0 40919.4 40935.6 7484.1 7554.2 7685.8 7759.1 7780.5 28557.3 29012.0 29795.7 29892.9 31086.1 34337.0 34411.1 34544.3 34576.7 34829.7 9755.5 9948.3 10047.0 10100.9 10127.2 11069.9 11196.6 11564.5 11668.9 11777.2 11004.7 11058.4 11206.6 11567.2 11571.9 10726.6 10839.9 10849.7 10879.1 11352.6 10550.9 10757.2 10777.5 10786.6 10847.6 8663.3 8793.5 8946.0 9018.6 9322.5 8689.1 9056.2 9084.8 9192.8 9244.0 06:28:16 INFO - 2015-12-16 06:28:16,199 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:28:16 INFO - 2015-12-16 06:28:16,199 DEBUG : BROWSER_OUTPUT: 06:28:16 INFO - 2015-12-16 06:28:16,897 INFO : Browser exited with error code: 0 06:28:16 INFO - 2015-12-16 06:28:16,921 INFO : Completed test dromaeo_css (00:18:37) 06:28:16 INFO - 2015-12-16 06:28:16,921 INFO : Starting test kraken 06:28:16 INFO - 2015-12-16 06:28:16,921 DEBUG : operating with platform_type : linux_ 06:28:16 INFO - 2015-12-16 06:28:16,921 INFO : Initialising browser for kraken test... 06:28:16 INFO - 2015-12-16 06:28:16,927 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVRdYvV/profile http://localhost:36649/getInfo.html 06:28:20 INFO - 2015-12-16 06:28:20,843 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:28:20 INFO - 2015-12-16 06:28:20,843 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:28:20 INFO - 2015-12-16 06:28:20,843 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:28:20 INFO - 2015-12-16 06:28:20,843 DEBUG : BROWSER_OUTPUT: __metrics 06:28:20 INFO - 2015-12-16 06:28:20,992 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] 06:28:21 INFO - 2015-12-16 06:28:21,060 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] 06:28:22 INFO - 2015-12-16 06:28:22,095 INFO : Browser initialized. 06:28:22 INFO - 2015-12-16 06:28:22,096 INFO : Running cycle 1/1 for kraken test... 06:28:22 INFO - 2015-12-16 06:28:22,096 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVRdYvV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:28:34 INFO - 2015-12-16 06:28:34,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 142954496 06:28:34 INFO - 2015-12-16 06:28:34,088 DEBUG : BROWSER_OUTPUT: 06:28:36 INFO - 2015-12-16 06:28:36,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36649/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:37 INFO - 2015-12-16 06:28:37,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 175788032 06:28:37 INFO - 2015-12-16 06:28:37,302 DEBUG : BROWSER_OUTPUT: 06:28:40 INFO - 2015-12-16 06:28:40,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36649/tests/kraken/driver.html?testName=audio-dft) 06:28:40 INFO - 2015-12-16 06:28:40,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 165855232 06:28:40 INFO - 2015-12-16 06:28:40,618 DEBUG : BROWSER_OUTPUT: 06:28:43 INFO - 2015-12-16 06:28:43,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36649/tests/kraken/driver.html?testName=audio-fft) 06:28:44 INFO - 2015-12-16 06:28:44,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 152981504 06:28:44 INFO - 2015-12-16 06:28:44,212 DEBUG : BROWSER_OUTPUT: 06:28:46 INFO - 2015-12-16 06:28:46,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36649/tests/kraken/driver.html?testName=audio-oscillator) 06:28:46 INFO - 2015-12-16 06:28:46,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 156024832 06:28:46 INFO - 2015-12-16 06:28:46,868 DEBUG : BROWSER_OUTPUT: 06:28:49 INFO - 2015-12-16 06:28:49,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:49 INFO - 2015-12-16 06:28:49,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 156643328 06:28:49 INFO - 2015-12-16 06:28:49,691 DEBUG : BROWSER_OUTPUT: 06:28:52 INFO - 2015-12-16 06:28:52,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36649/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:53 INFO - 2015-12-16 06:28:53,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 157597696 06:28:53 INFO - 2015-12-16 06:28:53,272 DEBUG : BROWSER_OUTPUT: 06:28:56 INFO - 2015-12-16 06:28:56,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36649/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:57 INFO - 2015-12-16 06:28:57,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 158769152 06:28:57 INFO - 2015-12-16 06:28:57,247 DEBUG : BROWSER_OUTPUT: 06:29:00 INFO - 2015-12-16 06:29:00,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36649/tests/kraken/driver.html?testName=json-parse-financial) 06:29:00 INFO - 2015-12-16 06:29:00,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 157671424 06:29:00 INFO - 2015-12-16 06:29:00,659 DEBUG : BROWSER_OUTPUT: 06:29:02 INFO - 2015-12-16 06:29:02,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:29:03 INFO - 2015-12-16 06:29:03,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 165785600 06:29:03 INFO - 2015-12-16 06:29:03,028 DEBUG : BROWSER_OUTPUT: 06:29:04 INFO - 2015-12-16 06:29:04,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:29:05 INFO - 2015-12-16 06:29:05,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 163442688 06:29:05 INFO - 2015-12-16 06:29:05,520 DEBUG : BROWSER_OUTPUT: 06:29:07 INFO - 2015-12-16 06:29:07,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:29:08 INFO - 2015-12-16 06:29:08,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 176918528 06:29:08 INFO - 2015-12-16 06:29:08,239 DEBUG : BROWSER_OUTPUT: 06:29:10 INFO - 2015-12-16 06:29:10,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:29:11 INFO - 2015-12-16 06:29:11,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 184029184 06:29:11 INFO - 2015-12-16 06:29:11,312 DEBUG : BROWSER_OUTPUT: 06:29:13 INFO - 2015-12-16 06:29:13,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:29:14 INFO - 2015-12-16 06:29:14,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 181977088 06:29:14 INFO - 2015-12-16 06:29:14,505 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36649/tests/kraken/driver.html?testName=ai-astar) 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 240640000 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;109;113;114;114;103;114;113;106 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;130;171;166;133;154;162;130;171;131 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;163;164;162;166;163;162;162 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;89;98;73;73;72;110;87;73 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;130;96;97;95;140;96;96;131 06:29:16 INFO - 2015-12-16 06:29:16,517 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;109;109;110;109;111;109;109 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;147;147;147;148;150;147;147 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;95;96;97;95;96;97;97;97 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;74;72;74;72;81;72;71 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;68;68;68;69;69;69 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;87;87;84;84;85;85;86;87 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;126;126;122;120;131;121;122;119;123 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;152;157;150;151;138;149;147;149;139 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;71;68;70;69;69;68;72;69 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: __startTimestamp1450276156512__endTimestamp 06:29:16 INFO - 2015-12-16 06:29:16,518 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,520 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:29:16 INFO - 2015-12-16 06:29:16,520 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:29:16 INFO - 2015-12-16 06:29:16,520 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.50 stddev:3.91 (3.4%) stddev-sans-first:4.14 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 109.0 113.0 114.0 114.0 103.0 114.0 113.0 106.0 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:160.50 stddev:17.71 (11.0%) stddev-sans-first:18.53 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: Values: 159.0 130.0 171.0 166.0 133.0 154.0 162.0 130.0 171.0 131.0 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 163.0 164.0 162.0 166.0 163.0 162.0 162.0 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,521 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:73.50 stddev:13.42 (18.3%) stddev-sans-first:13.91 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 89.0 98.0 73.0 73.0 72.0 110.0 87.0 73.0 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:96.00 stddev:18.39 (19.2%) stddev-sans-first:19.04 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 130.0 96.0 97.0 95.0 140.0 96.0 96.0 131.0 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 109.0 109.0 110.0 109.0 111.0 109.0 109.0 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 150.0 147.0 147.0 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 95.0 96.0 97.0 95.0 96.0 97.0 97.0 97.0 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:73.50 stddev:2.80 (3.8%) stddev-sans-first:2.96 06:29:16 INFO - 2015-12-16 06:29:16,522 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 74.0 72.0 74.0 72.0 81.0 72.0 71.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,523 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 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 87.0 87.0 84.0 84.0 85.0 85.0 86.0 87.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.50 stddev:3.82 (3.1%) stddev-sans-first:3.74 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: Values: 128.0 126.0 126.0 122.0 120.0 131.0 121.0 122.0 119.0 123.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.50 stddev:6.25 (4.2%) stddev-sans-first:6.06 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: Values: 140.0 152.0 157.0 150.0 151.0 138.0 149.0 147.0 149.0 139.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 68.0 70.0 69.0 69.0 68.0 72.0 69.0 06:29:16 INFO - 2015-12-16 06:29:16,523 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:29:16 INFO - 2015-12-16 06:29:16,524 DEBUG : BROWSER_OUTPUT: 06:29:17 INFO - 2015-12-16 06:29:17,437 INFO : Browser exited with error code: 0 06:29:17 INFO - 2015-12-16 06:29:17,490 INFO : Completed test kraken (00:01:00) 06:29:17 INFO - 2015-12-16 06:29:17,490 INFO : Starting test v8_7 06:29:17 INFO - 2015-12-16 06:29:17,491 DEBUG : operating with platform_type : linux_ 06:29:17 INFO - 2015-12-16 06:29:17,491 INFO : Initialising browser for v8_7 test... 06:29:17 INFO - 2015-12-16 06:29:17,497 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89yxlk/profile http://localhost:36649/getInfo.html 06:29:21 INFO - 2015-12-16 06:29:21,510 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:29:21 INFO - 2015-12-16 06:29:21,510 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:29:21 INFO - 2015-12-16 06:29:21,510 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:29:21 INFO - 2015-12-16 06:29:21,510 DEBUG : BROWSER_OUTPUT: __metrics 06:29:21 INFO - 2015-12-16 06:29:21,652 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] 06:29:21 INFO - 2015-12-16 06:29:21,713 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] 06:29:22 INFO - 2015-12-16 06:29:22,816 INFO : Browser initialized. 06:29:22 INFO - 2015-12-16 06:29:22,816 INFO : Running cycle 1/1 for v8_7 test... 06:29:22 INFO - 2015-12-16 06:29:22,817 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89yxlk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:29:34 INFO - 2015-12-16 06:29:34,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 142827520 06:29:34 INFO - 2015-12-16 06:29:34,844 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36649/tests/v8_7/run.html (next: http://localhost:36649/tests/v8_7/run.html) 06:29:56 INFO - 2015-12-16 06:29:56,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 444420096 06:29:56 INFO - 2015-12-16 06:29:56,485 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,485 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.01190476190476 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 06:29:56 INFO - 2015-12-16 06:29:56,486 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1956.9471624266146 06:29:56 INFO - 2015-12-16 06:29:56,487 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 06:29:56 INFO - 2015-12-16 06:29:56,487 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 06:29:56 INFO - 2015-12-16 06:29:56,487 DEBUG : BROWSER_OUTPUT: |7;RegExp;27621.62162162162 06:29:56 INFO - 2015-12-16 06:29:56,487 DEBUG : BROWSER_OUTPUT: |8;Splay;606.4281382656155 06:29:56 INFO - 2015-12-16 06:29:56,487 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: __startTimestamp1450276196484__endTimestamp 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:29:56 INFO - 2015-12-16 06:29:56,488 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: Values: 165.8 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: Values: 186.0 06:29:56 INFO - 2015-12-16 06:29:56,489 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: Values: 278.1 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: Values: 5128.2 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: Values: 1956.9 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: Values: 784.9 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,491 DEBUG : BROWSER_OUTPUT: Values: 12444.4 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27621.62 Median:27621.62 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: Values: 27621.6 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.43 Median:606.43 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: Values: 606.4 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:29:56 INFO - 2015-12-16 06:29:56,492 DEBUG : BROWSER_OUTPUT: 06:29:57 INFO - 2015-12-16 06:29:57,369 INFO : Browser exited with error code: 0 06:29:57 INFO - 2015-12-16 06:29:57,384 INFO : Completed test v8_7 (00:00:39) 06:29:57 INFO - 2015-12-16 06:29:57,529 INFO : Completed test suite (00:20:17) 06:29:57 INFO - 2015-12-16 06:29:57,529 DEBUG : Working with test: dromaeo_css 06:29:57 INFO - 2015-12-16 06:29:57,529 DEBUG : Generating results file: dromaeo_css 06:29:57 INFO - 2015-12-16 06:29:57,530 DEBUG : Working with test: kraken 06:29:57 INFO - 2015-12-16 06:29:57,530 DEBUG : Generating results file: kraken 06:29:57 INFO - 2015-12-16 06:29:57,531 INFO : javascript benchmark 06:29:57 INFO - 2015-12-16 06:29:57,531 DEBUG : Working with test: v8_7 06:29:57 INFO - 2015-12-16 06:29:57,531 DEBUG : Generating results file: v8_7 06:29:57 INFO - 2015-12-16 06:29:57,531 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:29:57 INFO - 2015-12-16 06:29:57,585 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 06:29:57 INFO - 2015-12-16 06:29:57,585 DEBUG : process_Request line: dromaeo_css 6286.38 graph.html#tests=[[72,132,35]] 06:29:57 INFO - 2015-12-16 06:29:57,585 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:29:57 INFO - 2015-12-16 06:29:57,615 DEBUG : process_Request line: kraken 1535.80 graph.html#tests=[[232,132,35]] 06:29:57 INFO - 2015-12-16 06:29:57,615 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:29:57 INFO - 2015-12-16 06:29:57,662 DEBUG : process_Request line: v8_7 19776.62 graph.html#tests=[[230,132,35]] 06:29:57 INFO - 2015-12-16 06:29:57,663 INFO : javascript benchmark 06:29:57 INFO - 2015-12-16 06:29:57,666 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2635.907743228987, 2712.9864350678245, 2729.113038262565, 2741.28726531102, 2760.4203117345355, 4546.249868771657, 4696.718196908188, 4721.244600863863, 4755.429348478183, 4792.305115758218, 4685.531446855312, 4708.152532544141, 4818.975905120469, 4831.975840120804, 4842.685225460343, 4269.252880745865, 4296.806643701041, 4322.827086916535, 4376.737395756265, 4380.846670366538, 4438.533953934839, 4513.864584062467, 4522.428018352457, 4522.796474158671, 4526.004279058602, 4156.605122513387, 4270.359446083081, 4278.2940814765525, 4429.11417716458, 4475.5748203920575, 4391.231534481485, 4429.667774916862, 4438.911221775578, 4443.178012067778, 4472.910541789146, 4393.648508119375, 4400.603945644907, 4404.163208990281, 4404.537523560044, 4440.933385999213, 4419.712718673276, 4536.591706746376, 4543.363929049936, 4552.157850797613, 4743.335932969387, 5093.974530127326, 5114.718690472023, 5147.202183661501, 5151.278820965068, 5157.58739300855, 5114.718690472023, 5115.0, 5119.641625086246, 5127.846164615067, 5164.1220992431, 4539.182947069559, 4663.044075964419, 4740.028294199681, 4747.169245382044, 4762.428508578958, 5115.411727651293, 5152.0, 5168.767405466688, 5188.014277287379, 5229.849433124707, 4944.0, 4990.151674215392, 5003.174476211457, 5003.74981250936, 5026.070177017264, 4838.540338667821, 5079.8984020319385, 5085.440601533828, 5094.159463688524, 5145.665531740425, 4924.089043526959, 4943.406791185009, 4981.452040275567, 4991.4758950310425, 5026.698398096126, 5055.570276526463, 5057.898842023139, 5082.059818933509, 5144.7942082316285, 5166.173412254021, 4214.199302132585, 4241.406203131564, 4248.468941382327, 4274.294741367639, 4282.807273672693, 3579.534660494119, 3673.2469843682516, 3674.3018826423427, 3739.6260373962386, 3746.7189960753053, 4299.892502687395, 4368.4102646143, 4369.825206991748, 4391.934120988188, 4408.955910440919, 5092.976548526696, 5155.922661160085, 5156.793728250828, 5157.58739300855, 5192.091384007784, 4194.496660400771, 4304.332828411601, 4424.513303536608, 4429.734215947054, 4471.0, 4348.499922508889, 4396.362527433568, 4460.50934397216, 4501.279795232747, 4512.503624601291, 4770.260609605517, 4835.2505361669, 4835.927461088017, 4841.612670986242, 4881.48744381849, 4873.1471992400475, 5061.595072394273, 5076.289319495199, 5079.3650793650795, 5123.154679477844, 4777.761111944319, 4782.760861956818, 4849.0, 4894.804207831647, 4943.0, 4999.750012499433, 5007.524285192901, 5008.899822003613, 5010.148274793367, 5057.14028615129, 5080.847574572621, 5082.33929589151, 5090.312807770903, 5091.312672789274, 5136.357955255593, 4773.856784296477, 4832.63755218353, 4905.3623029006, 4914.508549145057, 4915.778789954389, 4989.625778066732, 5001.57486613642, 5006.549410553068, 5009.323741294878, 5031.723255220998, 4881.731504767272, 4898.608111351155, 4900.093482705711, 4908.5091490852055, 4933.284673722362, 4673.158831410243, 4786.736729479912, 4794.952050479451, 4867.732274724783, 5077.7968881245815, 4878.292647566154, 4893.070316639827, 4898.387701537308, 4901.436334821541, 4943.134951383421], "unit": "score", "name": "dojo.html", "value": 4654.619715977631}, {"lowerIsBetter": false, "replicates": [569.4163482430508, 571.7770069672828, 575.3929604267496, 581.6858896196054, 582.1239035251945, 27529.862350688243, 27890.86054569727, 32778.18054548634, 33006.66993330066, 33102.0, 39043.609563904356, 39492.60507394925, 39507.40738888919, 39541.802290988504, 39560.802195989054, 7938.841223175533, 8133.511989280662, 8136.064352599438, 8136.064352599467, 8139.308158806479, 7244.492885498017, 7420.925790742078, 10145.086942175203, 10335.793284134314, 10367.948160259188, 10212.2851400402, 10293.536790844393, 10301.63944261951, 10317.896821031805, 10325.070743633072, 7176.138863336381, 7343.632818359114, 10154.746131346701, 10269.075783179474, 10277.640282590073, 10228.795424091551, 10437.32157409766, 10442.0, 10442.843357349646, 10457.84313235302, 37062.07344816374, 37548.06129846748, 37584.81207593972, 37653.0, 37746.24507509862, 2945.8527073646233, 2959.5708622249654, 2991.7157870002316, 3433.124553238908, 3624.3113808376324, 28186.295342616395, 28304.433911321863, 28510.144695659164, 28659.57010644842, 28852.278693032844, 3047.7714171437233, 3078.9384212315854, 3105.491587229235, 3109.6112985876766, 3111.9533207001914, 208869.11308869143, 212043.0, 212575.0, 213023.99999999846, 213753.0, 52999.0, 54297.0, 55776.0, 56266.437335626935, 58189.0, 49981.50018499768, 50060.49939500559, 50235.49764502381, 50265.497345026815, 50360.0, 14399.136051836924, 14782.48261310849, 14795.0, 14800.925995369955, 14818.555443336718, 11294.887051129384, 11344.943275283571, 11346.489407976496, 11359.204855660024, 11514.596989105508, 19146.329878454188, 19283.0, 19302.903485482482, 19312.61374772525, 19336.226550938085, 7597.126330471956, 7734.961325193338, 7894.486858354188, 7931.206879312138, 7944.364450843918, 804.6137853830078, 833.7623777223462, 886.6187539358009, 916.2944532709777, 984.9507524623883, 23323.0, 25911.0, 27275.934197516726, 27575.586366204523, 27641.585376219373, 993.344492268459, 996.6362277768707, 999.4053538144792, 1069.0271852614085, 1102.5204036244259, 13462.798058029137, 13488.797668034988, 13608.319584020759, 13652.658683532793, 13669.794953075712, 250437.0, 252618.0, 253064.0, 253394.0, 254421.0, 46066.30900536494, 46198.769006155424, 46304.30543541849, 46369.76815115903, 46382.53617463782, 1259.8614152443224, 1264.595329494553, 1274.464724815561, 1275.324078238535, 1290.9806352904714, 25224.74775252224, 25888.0, 26254.4749105013, 26297.737022629528, 26496.072637457597, 37013.62986370102, 37596.812015939744, 41188.1762364757, 41733.37399939064, 43854.12291754083, 162092.0, 163200.0, 163385.0, 163508.0, 164603.0, 26407.471850563266, 26762.866185668947, 26784.866075669495, 26809.0, 26828.32929176708, 30511.542326865558, 32941.17647058843, 33130.0, 38544.61455385522, 38913.2217355657, 28699.13902582926, 29214.26964325909, 29231.123066308046, 29568.852155739085, 29833.403331932805, 29401.264968375963, 29652.851735741184, 29663.555046674748, 29807.0, 29841.701582984762, 29774.553381698857, 29962.70037299599, 33408.33183336271, 34237.657623423445, 34318.31363372769, 25478.490430191665, 27198.864005679847, 27525.0, 27622.171334859988, 27795.888164474003, 22707.772922271226, 22851.31446056621, 22883.31350059501, 23017.65473517865, 23230.0], "unit": "score", "name": "ext.html", "value": 16712.925522877726}, {"lowerIsBetter": false, "replicates": [333.83975691667996, 334.1345914082527, 337.6910127233581, 337.98141102239396, 338.9372966001292, 12635.11554191207, 13132.73734525309, 14941.402343906244, 15514.456994005212, 17060.914695426505, 9615.038496150399, 9693.612255509772, 9694.709158725249, 9803.117719405253, 9891.109800117987, 4498.190325741357, 4622.168009758242, 4626.352310676508, 4639.072185562884, 4644.628429725631, 3557.5375201223806, 3653.8538458461762, 5167.7932882684645, 5316.0, 5322.7072511011875, 5200.92198617021, 5227.921581176285, 5229.555487783524, 5270.736463176826, 5310.336207974004, 5700.116481945305, 5722.628029178131, 5722.713864306809, 5730.570207234453, 5736.942630573682, 4726.338312636233, 4996.25056241563, 5017.272495488134, 5019.974900125512, 5037.672551284191, 12097.2136811107, 12105.878941210563, 17878.016709080995, 19402.611947761106, 19595.608087838307, 1803.8376546110783, 1847.815218478155, 1873.7095750158746, 1910.3218357483033, 1916.993578371366, 8716.389852710312, 8958.193762561335, 10177.389356638625, 12750.10749247553, 13024.218546887123, 1684.4862316993313, 1695.542203605032, 1740.7562941188244, 1749.9650006999916, 1796.793368762596, 54860.51394860522, 57581.712091439695, 58329.416705832824, 58851.41148588502, 59450.40549594492, 9622.845258569016, 9881.61657367969, 9891.554880030415, 9919.40483570988, 9944.850827237597, 12604.747905042032, 12648.177868438523, 12649.43077561512, 12696.111272211041, 12697.682557936125, 6778.661066946633, 6939.132608423947, 7097.503174777716, 7107.609081500567, 7200.207977122513, 6345.238571371465, 6662.133922590032, 6748.865022699617, 6756.290589488033, 6768.69540870662, 4052.230076285496, 4141.79291035453, 4162.354835000579, 4177.49870015594, 4255.76593287366, 1500.422337400087, 1564.9843501565067, 1566.6240102375348, 1591.9761203581957, 1690.9915450422668, 852.2372476633502, 885.0087901550177, 907.7322189953848, 935.9625614975461, 956.4978386347084, 14603.56189314301, 15016.699666006838, 15200.467983620742, 15411.537653870178, 15434.536963891102, 852.8294341131799, 863.4128792421213, 866.445474896067, 899.3479727197729, 945.6548359848744, 8245.917540824636, 8584.141585841491, 8627.180417860292, 8699.173578510032, 8760.167784060504, 487488.0, 490012.0, 493305.0, 503551.0, 511516.0, 67226.32773672299, 70248.29751702417, 71556.0, 72972.0, 73222.26777732262, 1062.2564205056492, 1067.2315932528568, 1090.6455401994383, 1118.8489553910117, 1119.972000699989, 14537.127772333693, 14625.853741462875, 14808.925955370154, 14916.328765205808, 15089.849101508844, 32609.0, 33142.66857331492, 33151.83424082864, 33297.50053749147, 33386.833065834515, 41997.1600567993, 43829.0, 43900.0, 44211.55788442074, 44334.0, 8239.546824924686, 8352.749417517483, 8359.540225287425, 8368.288695460955, 8435.156484351515, 11278.4724241545, 13109.672258193621, 16281.18594070268, 16306.429274975793, 16436.75344869804, 10664.733381665521, 11091.0, 13701.588952331445, 13903.0, 14173.22047287409, 12994.220346778846, 13041.0, 13414.798778018143, 13597.320133993459, 13645.522406715718, 10980.945095274792, 13285.933570332087, 13487.527936522174, 13621.795673064713, 13761.449542018207, 8201.95899020501, 8281.3788965829, 8315.542645154575, 8325.333973282002, 8351.540665263468, 9036.0, 9179.632814687338, 12121.575744848888, 13270.80093798613, 13581.524646637321], "unit": "score", "name": "jquery.html", "value": 8058.929444793637}, {"lowerIsBetter": false, "replicates": [1244.129109623264, 1397.050005995923, 1539.3688587679053, 1557.1591340676036, 1740.146160297113, 5869.35437101919, 7060.293970602937, 7199.640017999099, 7201.3158749918675, 7205.567665940047, 7140.286331280481, 7300.744473943413, 7305.853882922338, 7319.377852882511, 7322.670479828407, 1768.6285879965224, 1798.3975368251586, 1801.7207332863427, 2077.1276064053095, 2117.2166298469588, 1784.4735802938164, 2073.8029887160696, 2093.0, 2112.049577690038, 2115.4182599785104, 2041.2753472517265, 2062.2885104638876, 2066.0186411454515, 2070.4099331690472, 2071.647819870618, 2063.546019875625, 2077.9584408311825, 2087.7285952826187, 2089.8955052247325, 2090.5505316356903, 2069.1619893942975, 2094.1100032486283, 2121.5226574020876, 2121.6711409731515, 2123.458518077896, 7194.388476979463, 7230.855382892365, 7262.237465066145, 7270.854582908365, 7285.927140728578, 4193.077522944947, 4233.809478573441, 4263.936040959357, 4268.594483524092, 4304.548022457629, 2589.6374507568958, 2634.315078079694, 2656.176585258576, 2722.169738229839, 2729.3176705823544, 835.4277320035795, 837.0206857976121, 848.6520526584071, 870.3298460185622, 886.7295474880159, 9428.528573571362, 9430.622775088988, 9449.574769135406, 9451.196648284904, 9470.052994700543, 3868.6324799144036, 3913.2760439318818, 3976.324024915771, 3981.044549308145, 3998.980005099956, 8255.669773209005, 8272.793180170424, 8275.213854683796, 8275.379346549033, 8286.212809783061, 4339.913201735948, 4363.890902727458, 4364.345348197796, 4364.54172311909, 4367.67242456817, 3929.410588411761, 3930.508686414198, 3931.6264954829244, 3934.15415685629, 3935.2326296372507, 2984.7313741763346, 3470.878519251814, 3478.513008178857, 3505.2288496530723, 3508.7017603503477, 971.1696499492832, 990.0000998991071, 990.153418826907, 1111.7609713911547, 1134.6766171641043, 963.604921981984, 972.6936015155203, 1019.8827134879435, 1065.5524679634573, 1204.933728644933, 6684.832879177962, 6766.815807233715, 6769.086173366631, 6770.255271920085, 6783.3555812197765, 1025.646152077547, 1039.2361614213546, 1048.8688913885765, 1055.266589720137, 1059.920505962056, 5281.207818827206, 5375.623706340519, 5393.460653934653, 5394.811181608703, 5398.514133727984, 8427.073021967579, 8465.365097617703, 8732.69435569752, 8836.513991730388, 8844.911550884537, 8615.741527754051, 8655.523946182895, 8717.128287171232, 8730.126987301219, 8748.0, 6752.662366881636, 6834.043233947252, 6889.724411023503, 6907.205671347759, 6919.654017299215, 6611.371919667624, 6639.0, 6647.368499992493, 6656.900146497709, 6667.099941507834, 7567.129780075362, 7789.221077892392, 7803.765887023398, 7813.0, 7815.491993020435, 7874.448788584744, 7979.640916158903, 7991.600419978861, 8117.269445749911, 8131.715389961323, 6213.03697926822, 6217.191765070512, 6227.377262273736, 6291.245050593958, 6308.621482711052, 6912.239653637996, 6952.304769523007, 6956.965215173892, 6963.61700106499, 6964.303569642995, 6394.4564712, 6645.534812563074, 6652.301508341748, 6687.933120668731, 6798.592084474947, 5525.806596769094, 5643.435656434323, 6041.758329666764, 6329.556931014785, 6546.574472659262, 6116.755329786759, 6231.314555398993, 6374.0, 6413.775517856852, 6418.743250269937, 6042.516598672008, 6074.453299203093, 6081.148639190428, 6082.2093127893095, 6088.908666369919, 6036.517078633611, 6049.576529642883, 6057.666828324484, 6064.787732429344, 6081.513478921587], "unit": "score", "name": "mootools.html", "value": 4103.693721103314}, {"lowerIsBetter": false, "replicates": [299.37878901279845, 304.1514175450492, 305.39379332025925, 310.23681742912447, 311.9485284927987, 5220.92168617471, 5344.1182204936185, 5353.866153346168, 5387.622866399353, 5494.2857428534335, 5148.665336753108, 5316.7873285068645, 5324.254604355393, 5324.893502129965, 5332.493413125757, 3917.334053210947, 4125.979370103145, 4133.834646614132, 4134.772587507686, 4139.4825646794225, 4002.4396584478195, 4005.3591425371947, 4098.241825262321, 4101.220768054075, 4101.302778527643, 4045.4943132108488, 4045.5145382554133, 4068.084680946793, 4069.47096877407, 4075.9796201019103, 4064.6138616831354, 4069.857554985576, 4074.8166332515107, 4076.347784354519, 4079.102597428561, 3550.786952782841, 3554.7867127972145, 3564.946525802115, 3567.0, 3569.1434055826676, 4978.0, 5096.51583099605, 5105.5149760772665, 5120.15517439622, 5121.052605268, 4668.066386722669, 4671.182543054986, 4672.345871577982, 4675.953240467586, 4678.883027924329, 5569.721513924328, 5578.748956296936, 5594.888102237933, 5599.888002239933, 5600.355959064719, 3684.5394325709285, 3779.225258821935, 3861.1119442528093, 3867.8259478323544, 3872.5352957645264, 5780.393058728815, 5883.441073098092, 5909.0, 5928.199693041427, 5935.792247271324, 3949.30887094763, 3958.5447673517338, 3959.7822119783687, 3968.3650615901315, 3978.622030907059, 4026.4362989181536, 4027.194561087794, 4033.7176397651883, 4042.15114825884, 4044.2518134145275, 4556.059815513013, 4634.930476042862, 4646.97676511622, 4649.0, 4649.418822647169, 5580.051391263414, 5599.916001259984, 5611.186377975171, 5614.63504872182, 5621.915671264935, 1422.9715405691827, 1440.1215258692189, 1443.7689969604812, 1444.7832825076111, 1445.7542217822995, 948.818720692742, 954.5799848066829, 971.062924278075, 972.1736523954582, 974.449436068619, 4912.557869791736, 4930.975345123252, 4931.679440836334, 4932.7533623319405, 4935.062338155811, 5798.33319168301, 5802.680852553066, 5804.506616937523, 5806.68063256525, 5810.593258471867, 4904.411470623548, 4924.162892308316, 4931.18635425158, 4938.2839488274, 4941.0, 3035.848207589656, 3079.6920307969026, 3123.640781310178, 3132.4361614909535, 3134.6081739782526, 5516.089845175581, 5592.888142237132, 5602.915956260659, 5604.41153678866, 5608.074667679869, 6022.066579680069, 6024.126501657235, 6030.638161710312, 6035.456808887221, 6062.242219722535, 5586.0, 5597.384287728347, 5604.719764011783, 5605.775768969195, 5610.214569960291, 5659.066254068032, 5775.191473193672, 5847.853803654943, 5877.794277200277, 5892.057270836645, 5430.185472179205, 5715.657060576213, 5717.828465145886, 5717.942820571741, 5726.599138060295, 5402.378726446509, 5459.153831156177, 5477.698726570077, 5481.232627432242, 5487.5609951203005, 3921.568627450921, 3981.323175060189, 3992.640662340403, 4022.376531637484, 4040.2323558523785, 5801.883962320814, 5802.1296805479515, 5808.07070868659, 5814.622049566765, 5823.213866128019, 5479.890402192013, 5563.944360556505, 5581.7209139543675, 5642.294713160855, 5648.5481161507805, 5658.094704847204, 5662.688552129673, 5668.03643380618, 5671.971640141773, 5672.404397538364, 5523.309586301712, 5525.861853453695, 5546.223528706065, 5549.1676248563035, 5552.666839989613, 5567.8886422272135, 5709.429057094258, 5710.971445142748, 5715.171300161536, 5722.914156287576, 5559.471850174227, 5560.5551555876245, 5570.359408668055, 5570.387257401601, 5576.9163462547285], "unit": "score", "name": "prototype.html", "value": 4202.3336637175}, {"lowerIsBetter": false, "replicates": [627.8712863862909, 657.8750037492875, 700.8388070743728, 739.0429393934854, 753.1000454456923, 11661.883381166186, 11684.532618695242, 11851.288922664646, 11894.286342819427, 11923.58267460638, 11334.0, 11707.121965852553, 11722.648320550397, 11724.12069094817, 11735.0, 648.8118445650756, 809.0372456776432, 822.2024636102971, 827.4952279109739, 827.5365795154703, 640.4172203295002, 815.3843847894831, 827.2513375395276, 835.7952301686065, 835.9122292159327, 861.0872475176302, 873.253368370044, 874.8075423406872, 875.2866413872705, 875.3216257400534, 662.7812821768805, 667.4693618573245, 848.2535368875411, 865.709987154301, 866.9609867555976, 632.4339715954242, 638.4987784589075, 639.1563136659564, 639.5874660843776, 640.6092283706935, 11726.237794543413, 11952.103592230531, 12025.158238923279, 12028.27830330183, 12047.759044819142, 11263.098952083896, 11671.241369311052, 11704.946554810109, 11724.120690948213, 11912.761744765143, 9590.67821930088, 9685.612575496973, 9715.125638692552, 9742.512874356325, 9773.853392199122, 3272.460044092722, 3313.684565388759, 3348.1294863335706, 3348.3972884880714, 3354.798712077283, 39543.80228098841, 39889.20221595552, 40115.799421003, 40125.79937100325, 40167.0, 9276.7680807979, 9364.25085993119, 9364.438133712, 9366.578503967337, 9512.1439070484, 16600.169991500377, 16685.0, 16699.582510437336, 16721.498355049367, 16746.49760507187, 6258.217722784652, 6280.0, 6281.0, 6336.334684858116, 6428.453581445629, 3349.732021438279, 3439.9656003440145, 3459.0, 3468.6357932417236, 3485.5991560970306, 2466.21081253997, 2499.0628514307136, 2502.637117617935, 2507.398224426161, 2508.460680953567, 447.6262320961968, 456.67576021025445, 459.4830815332751, 461.8822200338892, 472.6266249662728, 558.2826068501955, 603.1074010464537, 613.5337143770766, 629.4020680353682, 643.3437893348852, 7882.448228624056, 8717.30261579072, 8803.735887923373, 8984.004017641802, 9064.184223419923, 508.3340823521199, 508.8676943994588, 516.4964159944025, 559.5216090242784, 608.6179507545688, 3640.508531348287, 3741.1021354874633, 3817.295253259053, 3818.4845045919, 3885.669718073995, 49863.75068124709, 50237.497625024014, 50271.49728502741, 50465.0, 50687.746561266955, 42583.0, 43457.91355216145, 43712.78143609325, 44009.77995110004, 44290.33564496535, 40386.39420408696, 40422.0, 40896.0, 40919.38620920689, 40935.59064409318, 7484.101907771103, 7554.206808285051, 7685.769426917202, 7759.146493885555, 7780.455368124403, 28557.28606784847, 29011.984580539578, 29795.702042979294, 29892.861249569352, 31086.067417977498, 34337.0, 34411.13972150716, 34544.30911381708, 34576.654233457346, 34829.65170348264, 9755.512224388895, 9948.293486567361, 10046.995936292178, 10100.949495252476, 10127.18982481385, 11069.944650276697, 11196.608118715805, 11564.537418503165, 11668.94165529167, 11777.234479758788, 11004.669859904216, 11058.447077646246, 11206.607768728056, 11567.190296679151, 11571.884281157081, 10726.624568140078, 10839.891601084204, 10849.728756781144, 10879.129669626569, 11352.602658906899, 10550.947245263724, 10757.1932105094, 10777.51501182433, 10786.622468213574, 10847.566097356017, 8663.26362259215, 8793.472391656265, 8945.955270223607, 9018.594163262538, 9322.533873306444, 8689.10369155633, 9056.230220431336, 9084.818303634023, 9192.816143676955, 9244.029376915327], "unit": "score", "name": "yui.html", "value": 5707.978608917422}], "name": "dromaeo_css", "value": 6286.384788554839}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 113.0, 114.0, 114.0, 103.0, 114.0, 113.0, 106.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 171.0, 166.0, 133.0, 154.0, 162.0, 130.0, 171.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 163.0, 164.0, 162.0, 166.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 89.0, 98.0, 73.0, 73.0, 72.0, 110.0, 87.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 130.0, 96.0, 97.0, 95.0, 140.0, 96.0, 96.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 111.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 150.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 95.0, 96.0, 97.0, 95.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 74.0, 72.0, 74.0, 72.0, 81.0, 72.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 87.0, 84.0, 84.0, 85.0, 85.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 126.0, 122.0, 120.0, 131.0, 121.0, 122.0, 119.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 157.0, 150.0, 151.0, 138.0, 149.0, 147.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 68.0, 70.0, 69.0, 69.0, 68.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1535.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [186.01190476190476], "unit": "score", "name": "DeltaBlue", "value": 355.4503679999999}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [27621.62162162162], "unit": "score", "name": "RegExp", "value": 32.980865949119355}, {"lowerIsBetter": false, "replicates": [606.4281382656155], "unit": "score", "name": "Splay", "value": 134.37865900000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19776.617121432057}]} 06:29:57 INFO - RETURN: dromaeo_css: 6286.38 06:29:57 INFO - RETURN: kraken: 1535.80 06:29:57 INFO - RETURN: v8_7: 19776.62 06:29:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19776.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1535.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6286.38"}}} 06:29:57 INFO - Return code: 0 06:29:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:57 INFO - # TBPL SUCCESS # 06:29:57 INFO - Running post-action listener: _resource_record_post_action 06:29:57 INFO - Running post-run listener: _resource_record_post_run 06:29:58 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509005824; Read time: 16; Write time: 357980 06:29:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230998016; Read time: 0; Write time: 195192 06:29:58 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277614592; Read time: 16; Write time: 162764 06:29:58 INFO - Running post-run listener: _upload_blobber_files 06:29:58 INFO - Blob upload gear active. 06:29:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:29:58 INFO - Copying logs to upload dir... 06:29:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.554109 ========= master_lag: 1.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-16 06:29:59.962506) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:29:59.966870) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009539 build_url: 'https://queue.taskcluster.net/v1/task/acJ7vidKQDqnHtsJxi4p6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:29:59.997475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:29:59.997936) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450272815.858890-960695925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:30:00.047148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 06:30:00.050529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 06:30:00.050865) ========= ========= Total master_lag: 1.37 =========