builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1449669624.42 results: success (0) buildid: 20151209052340 builduid: 9d4aee8eca744cbeabf30cd3e060d81b revision: 64fc74a36a1606092a3cf23b949773b0518908cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.422975) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.423400) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.423745) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.473277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.473628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.513111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.513410) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.570923) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.571230) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.571626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.571985) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 06:00:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-09 06:00:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171724 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.778915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.779253) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017293 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.833420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.833828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 64fc74a36a1606092a3cf23b949773b0518908cb --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 64fc74a36a1606092a3cf23b949773b0518908cb --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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 06:00:25,170 truncating revision to first 12 chars 2015-12-09 06:00:25,170 Setting DEBUG logging. 2015-12-09 06:00:25,170 attempt 1/10 2015-12-09 06:00:25,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/64fc74a36a16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 06:00:25,418 unpacking tar archive at: fx-team-64fc74a36a16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.382350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.382675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.399509) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.399794) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.400205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-09 06:00:25.403588) ========= /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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:25 INFO - MultiFileLogger online at 20151209 06:00:25 in /builds/slave/test 06:00:25 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:00:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:25 INFO - {'append_to_log': False, 06:00:25 INFO - 'base_work_dir': '/builds/slave/test', 06:00:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:00:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:25 INFO - 'branch': 'Fx-Team-Non-PGO', 06:00:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:25 INFO - 'config_files': ('talos/linux_config.py',), 06:00:25 INFO - 'default_actions': ('clobber', 06:00:25 INFO - 'read-buildbot-config', 06:00:25 INFO - 'download-and-extract', 06:00:25 INFO - 'populate-webroot', 06:00:25 INFO - 'create-virtualenv', 06:00:25 INFO - 'install', 06:00:25 INFO - 'run-tests'), 06:00:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:25 INFO - 'download_minidump_stackwalk': True, 06:00:25 INFO - 'download_symbols': 'ondemand', 06:00:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:25 INFO - 'installer_path': 'installer.exe', 06:00:25 INFO - 'log_level': 'info', 06:00:25 INFO - 'log_name': 'talos', 06:00:25 INFO - 'log_to_console': True, 06:00:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:25 INFO - 'opt_config_files': (), 06:00:25 INFO - 'pip_index': False, 06:00:25 INFO - 'sps_profile': False, 06:00:25 INFO - 'sps_profile_interval': 0, 06:00:25 INFO - 'suite': 'dromaeojs', 06:00:25 INFO - 'system_bits': '64', 06:00:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:25 INFO - 'title': 'talos-linux64-ix-039', 06:00:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:25 INFO - 'use_talos_json': True, 06:00:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:25 INFO - 'work_dir': 'build'} 06:00:25 INFO - ##### 06:00:25 INFO - ##### Running clobber step. 06:00:25 INFO - ##### 06:00:25 INFO - Running pre-action listener: _resource_record_pre_action 06:00:25 INFO - Running main action method: clobber 06:00:25 INFO - rmtree: /builds/slave/test/build 06:00:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:26 INFO - Running post-action listener: _resource_record_post_action 06:00:26 INFO - ##### 06:00:26 INFO - ##### Running read-buildbot-config step. 06:00:26 INFO - ##### 06:00:26 INFO - Running pre-action listener: _resource_record_pre_action 06:00:26 INFO - Running main action method: read_buildbot_config 06:00:26 INFO - Using buildbot properties: 06:00:26 INFO - { 06:00:26 INFO - "properties": { 06:00:26 INFO - "buildnumber": 1185, 06:00:26 INFO - "product": "firefox", 06:00:26 INFO - "script_repo_revision": "production", 06:00:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:00:26 INFO - "repository": "", 06:00:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:00:26 INFO - "buildid": "20151209052340", 06:00:26 INFO - "slavename": "talos-linux64-ix-039", 06:00:26 INFO - "pgo_build": "False", 06:00:26 INFO - "basedir": "/builds/slave/test", 06:00:26 INFO - "project": "", 06:00:26 INFO - "platform": "ubuntu64_hw", 06:00:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:26 INFO - "slavebuilddir": "test", 06:00:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:00:26 INFO - "branch": "fx-team", 06:00:26 INFO - "repo_path": "integration/fx-team", 06:00:26 INFO - "stage_platform": "linux64", 06:00:26 INFO - "builduid": "9d4aee8eca744cbeabf30cd3e060d81b", 06:00:26 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:26 INFO - }, 06:00:26 INFO - "sourcestamp": { 06:00:26 INFO - "repository": "", 06:00:26 INFO - "hasPatch": false, 06:00:26 INFO - "project": "", 06:00:26 INFO - "branch": "fx-team-linux64-talos", 06:00:26 INFO - "changes": [ 06:00:26 INFO - { 06:00:26 INFO - "category": null, 06:00:26 INFO - "files": [ 06:00:26 INFO - { 06:00:26 INFO - "url": null, 06:00:26 INFO - "name": "https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:00:26 INFO - } 06:00:26 INFO - ], 06:00:26 INFO - "repository": "", 06:00:26 INFO - "rev": "64fc74a36a1606092a3cf23b949773b0518908cb", 06:00:26 INFO - "who": "cbook@mozilla.com", 06:00:26 INFO - "when": 1449669523, 06:00:26 INFO - "number": 7153036, 06:00:26 INFO - "comments": "Backed out changeset e2708b9fdadc (bug 1137681) for test failures in browser_ua_emulation.js", 06:00:26 INFO - "project": "", 06:00:26 INFO - "at": "Wed 09 Dec 2015 05:58:43", 06:00:26 INFO - "branch": "fx-team-linux64-talos", 06:00:26 INFO - "revlink": "", 06:00:26 INFO - "properties": [ 06:00:26 INFO - [ 06:00:26 INFO - "buildid", 06:00:26 INFO - "20151209052340", 06:00:26 INFO - "Change" 06:00:26 INFO - ], 06:00:26 INFO - [ 06:00:26 INFO - "builduid", 06:00:26 INFO - "9d4aee8eca744cbeabf30cd3e060d81b", 06:00:26 INFO - "Change" 06:00:26 INFO - ], 06:00:26 INFO - [ 06:00:26 INFO - "pgo_build", 06:00:26 INFO - "False", 06:00:26 INFO - "Change" 06:00:26 INFO - ] 06:00:26 INFO - ], 06:00:26 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:26 INFO - } 06:00:26 INFO - ], 06:00:26 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:26 INFO - } 06:00:26 INFO - } 06:00:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:00:26 INFO - Running post-action listener: _resource_record_post_action 06:00:26 INFO - ##### 06:00:26 INFO - ##### Running download-and-extract step. 06:00:26 INFO - ##### 06:00:26 INFO - Running pre-action listener: _resource_record_pre_action 06:00:26 INFO - Running main action method: download_and_extract 06:00:26 INFO - mkdir: /builds/slave/test/build/tests 06:00:26 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:00:26 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json 06:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json 06:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:00:36 INFO - Downloaded 1302 bytes. 06:00:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:00:36 INFO - Using the following test package requirements: 06:00:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'jsshell-linux-x86_64.zip'], 06:00:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:36 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:00:36 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:40 INFO - Downloaded 21860154 bytes. 06:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:00:42 INFO - Return code: 0 06:00:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:42 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:00:42 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:45 INFO - Downloaded 21860154 bytes. 06:00:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:00:46 INFO - Return code: 0 06:00:47 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:00:47 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:48 INFO - Downloaded 11132038 bytes. 06:00:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 06:00:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:00:48 INFO - Return code: 0 06:00:48 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:00:48 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:00:49 INFO - Downloaded 57728114 bytes. 06:00:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:49 INFO - mkdir: /builds/slave/test/properties 06:00:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:49 INFO - Contents: 06:00:49 INFO - build_url:https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:49 INFO - Running post-action listener: _resource_record_post_action 06:00:49 INFO - Running post-action listener: set_extra_try_arguments 06:00:49 INFO - ##### 06:00:49 INFO - ##### Running populate-webroot step. 06:00:49 INFO - ##### 06:00:49 INFO - Running pre-action listener: _resource_record_pre_action 06:00:49 INFO - Running main action method: populate_webroot 06:00:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:49 INFO - '--tppagecycles', 06:00:49 INFO - '7'], 06:00:49 INFO - 'tests': ['tsvgm']}}, 06:00:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'tests': ['damp', 'tps']}, 06:00:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['damp', 'tps']}, 06:00:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:49 INFO - 'other': {'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'other_l64': {'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:49 INFO - 'ts_paint', 06:00:49 INFO - 'tpaint', 06:00:49 INFO - 'sessionrestore', 06:00:49 INFO - 'sessionrestore_no_auto_restore']}, 06:00:49 INFO - 'svgr': {'tests': ['tsvgx', 06:00:49 INFO - 'tsvgr_opacity', 06:00:49 INFO - 'tart', 06:00:49 INFO - 'tscrollx', 06:00:49 INFO - 'cart']}, 06:00:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['tsvgx', 06:00:49 INFO - 'tsvgr_opacity', 06:00:49 INFO - 'tart', 06:00:49 INFO - 'tscrollx', 06:00:49 INFO - 'cart']}, 06:00:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'tests': ['tp5o']}, 06:00:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'talos_options': ['--e10s'], 06:00:49 INFO - 'tests': ['tp5o']}, 06:00:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'talos_options': ['--xperf_path', 06:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:49 INFO - 'tests': ['tp5n']}, 06:00:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:49 INFO - 'talos_options': ['--e10s', 06:00:49 INFO - '--xperf_path', 06:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:49 INFO - 'tests': ['tp5n']}}, 06:00:49 INFO - 'talos.zip': {'path': '', 06:00:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:49 INFO - Running post-action listener: _resource_record_post_action 06:00:49 INFO - ##### 06:00:49 INFO - ##### Running create-virtualenv step. 06:00:49 INFO - ##### 06:00:49 INFO - Running pre-action listener: _resource_record_pre_action 06:00:49 INFO - Running main action method: create_virtualenv 06:00:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:49 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:00:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:49 INFO - Using real prefix '/usr' 06:00:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:52 INFO - Installing pip.................done. 06:00:52 INFO - Return code: 0 06:00:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:00:52 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:00:52 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:00:52 INFO - Using env: {'DISPLAY': ':0', 06:00:52 INFO - 'HOME': '/home/cltbld', 06:00:52 INFO - 'LANG': 'en_US.UTF-8', 06:00:52 INFO - 'LANGUAGE': 'en_US:en', 06:00:52 INFO - 'LOGNAME': 'cltbld', 06:00:52 INFO - 'MAIL': '/var/mail/cltbld', 06:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:52 INFO - 'MOZ_NO_REMOTE': '1', 06:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:52 INFO - 'NO_EM_RESTART': '1', 06:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:52 INFO - 'PWD': '/builds/slave/test', 06:00:52 INFO - 'SHELL': '/bin/bash', 06:00:52 INFO - 'SHLVL': '1', 06:00:52 INFO - 'TERM': 'linux', 06:00:52 INFO - 'TMOUT': '86400', 06:00:52 INFO - 'USER': 'cltbld', 06:00:52 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:52 INFO - '_': '/tools/buildbot/bin/python'} 06:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:52 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:00:52 INFO - Cleaning up... 06:00:52 INFO - Return code: 0 06:00:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:00:52 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:00:52 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:00:52 INFO - Using env: {'DISPLAY': ':0', 06:00:52 INFO - 'HOME': '/home/cltbld', 06:00:52 INFO - 'LANG': 'en_US.UTF-8', 06:00:52 INFO - 'LANGUAGE': 'en_US:en', 06:00:52 INFO - 'LOGNAME': 'cltbld', 06:00:52 INFO - 'MAIL': '/var/mail/cltbld', 06:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:52 INFO - 'MOZ_NO_REMOTE': '1', 06:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:52 INFO - 'NO_EM_RESTART': '1', 06:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:52 INFO - 'PWD': '/builds/slave/test', 06:00:52 INFO - 'SHELL': '/bin/bash', 06:00:52 INFO - 'SHLVL': '1', 06:00:52 INFO - 'TERM': 'linux', 06:00:52 INFO - 'TMOUT': '86400', 06:00:52 INFO - 'USER': 'cltbld', 06:00:52 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:52 INFO - '_': '/tools/buildbot/bin/python'} 06:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:52 INFO - Downloading/unpacking psutil>=0.7.1 06:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:00:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:54 INFO - Installing collected packages: psutil 06:00:54 INFO - Running setup.py install for psutil 06:00:54 INFO - building 'psutil._psutil_linux' extension 06:00:54 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:00:54 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:00:54 INFO - building 'psutil._psutil_posix' extension 06:00:54 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:00:54 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:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:54 INFO - Successfully installed psutil 06:00:54 INFO - Cleaning up... 06:00:54 INFO - Return code: 0 06:00:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:00:54 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:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:00:54 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:00:54 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:00:54 INFO - Using env: {'DISPLAY': ':0', 06:00:54 INFO - 'HOME': '/home/cltbld', 06:00:54 INFO - 'LANG': 'en_US.UTF-8', 06:00:54 INFO - 'LANGUAGE': 'en_US:en', 06:00:54 INFO - 'LOGNAME': 'cltbld', 06:00:54 INFO - 'MAIL': '/var/mail/cltbld', 06:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:54 INFO - 'MOZ_NO_REMOTE': '1', 06:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:54 INFO - 'NO_EM_RESTART': '1', 06:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:54 INFO - 'PWD': '/builds/slave/test', 06:00:54 INFO - 'SHELL': '/bin/bash', 06:00:54 INFO - 'SHLVL': '1', 06:00:54 INFO - 'TERM': 'linux', 06:00:54 INFO - 'TMOUT': '86400', 06:00:54 INFO - 'USER': 'cltbld', 06:00:54 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:54 INFO - '_': '/tools/buildbot/bin/python'} 06:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:55 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:00:55 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:00:55 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:00:55 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:00:55 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:00:55 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:00:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:56 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:00:56 INFO - Installing collected packages: mozsystemmonitor 06:00:56 INFO - Running setup.py install for mozsystemmonitor 06:00:56 INFO - Successfully installed mozsystemmonitor 06:00:56 INFO - Cleaning up... 06:00:56 INFO - Return code: 0 06:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:56 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:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:56 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:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:56 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:00:56 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:00:56 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:00:56 INFO - Using env: {'DISPLAY': ':0', 06:00:56 INFO - 'HOME': '/home/cltbld', 06:00:56 INFO - 'LANG': 'en_US.UTF-8', 06:00:56 INFO - 'LANGUAGE': 'en_US:en', 06:00:56 INFO - 'LOGNAME': 'cltbld', 06:00:56 INFO - 'MAIL': '/var/mail/cltbld', 06:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:56 INFO - 'MOZ_NO_REMOTE': '1', 06:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:56 INFO - 'NO_EM_RESTART': '1', 06:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:56 INFO - 'PWD': '/builds/slave/test', 06:00:56 INFO - 'SHELL': '/bin/bash', 06:00:56 INFO - 'SHLVL': '1', 06:00:56 INFO - 'TERM': 'linux', 06:00:56 INFO - 'TMOUT': '86400', 06:00:56 INFO - 'USER': 'cltbld', 06:00:56 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:56 INFO - '_': '/tools/buildbot/bin/python'} 06:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:57 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:00:57 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:00:57 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:00:57 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:00:57 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:00:57 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:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:58 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:00:58 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:00:58 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:00:58 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:00:58 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:00:58 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:00:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 INFO - Downloading docopt-0.6.1.tar.gz 06:00:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:59 INFO - Running setup.py install for blobuploader 06:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:59 INFO - Running setup.py install for requests 06:01:00 INFO - Running setup.py install for docopt 06:01:00 INFO - Successfully installed blobuploader requests docopt 06:01:00 INFO - Cleaning up... 06:01:00 INFO - Return code: 0 06:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:00 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:01:00 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:01:00 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:01:00 INFO - Using env: {'DISPLAY': ':0', 06:01:00 INFO - 'HOME': '/home/cltbld', 06:01:00 INFO - 'LANG': 'en_US.UTF-8', 06:01:00 INFO - 'LANGUAGE': 'en_US:en', 06:01:00 INFO - 'LOGNAME': 'cltbld', 06:01:00 INFO - 'MAIL': '/var/mail/cltbld', 06:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:00 INFO - 'MOZ_NO_REMOTE': '1', 06:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:00 INFO - 'NO_EM_RESTART': '1', 06:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:00 INFO - 'PWD': '/builds/slave/test', 06:01:00 INFO - 'SHELL': '/bin/bash', 06:01:00 INFO - 'SHLVL': '1', 06:01:00 INFO - 'TERM': 'linux', 06:01:00 INFO - 'TMOUT': '86400', 06:01:00 INFO - 'USER': 'cltbld', 06:01:00 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:00 INFO - '_': '/tools/buildbot/bin/python'} 06:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:00 INFO - Running setup.py (path:/tmp/pip-QonKBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:00 INFO - Running setup.py (path:/tmp/pip-iYAKL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:00 INFO - Running setup.py (path:/tmp/pip-NFC7HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:00 INFO - Running setup.py (path:/tmp/pip-hX6f6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:00 INFO - Running setup.py (path:/tmp/pip-cnDYfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:00 INFO - Running setup.py (path:/tmp/pip-TU1wR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:00 INFO - Running setup.py (path:/tmp/pip-Z5HtMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:00 INFO - Running setup.py (path:/tmp/pip-2CBD8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:00 INFO - Running setup.py (path:/tmp/pip-KG_7ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:01 INFO - Running setup.py (path:/tmp/pip-KEv6nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:01 INFO - Running setup.py (path:/tmp/pip-tBZayl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:01 INFO - Running setup.py (path:/tmp/pip-i2juM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:01 INFO - Running setup.py (path:/tmp/pip-XyZKg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:01 INFO - Running setup.py (path:/tmp/pip-i_WNGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:01 INFO - Running setup.py (path:/tmp/pip-WYlOPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:01 INFO - Running setup.py (path:/tmp/pip-ThZYiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:01 INFO - Running setup.py (path:/tmp/pip-KBvybp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:01 INFO - Running setup.py install for manifestparser 06:01:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Running setup.py install for mozcrash 06:01:01 INFO - Running setup.py install for mozdebug 06:01:01 INFO - Running setup.py install for mozdevice 06:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozfile 06:01:02 INFO - Running setup.py install for mozhttpd 06:01:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozinfo 06:01:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozInstall 06:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozleak 06:01:02 INFO - Running setup.py install for mozlog 06:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for moznetwork 06:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozprocess 06:01:02 INFO - Running setup.py install for mozprofile 06:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozrunner 06:01:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:03 INFO - Running setup.py install for mozscreenshot 06:01:03 INFO - Running setup.py install for moztest 06:01:03 INFO - Running setup.py install for mozversion 06:01:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:03 INFO - Cleaning up... 06:01:03 INFO - Return code: 0 06:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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', '-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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:01:03 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:01:03 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:01:03 INFO - Using env: {'DISPLAY': ':0', 06:01:03 INFO - 'HOME': '/home/cltbld', 06:01:03 INFO - 'LANG': 'en_US.UTF-8', 06:01:03 INFO - 'LANGUAGE': 'en_US:en', 06:01:03 INFO - 'LOGNAME': 'cltbld', 06:01:03 INFO - 'MAIL': '/var/mail/cltbld', 06:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:03 INFO - 'MOZ_NO_REMOTE': '1', 06:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:03 INFO - 'NO_EM_RESTART': '1', 06:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:03 INFO - 'PWD': '/builds/slave/test', 06:01:03 INFO - 'SHELL': '/bin/bash', 06:01:03 INFO - 'SHLVL': '1', 06:01:03 INFO - 'TERM': 'linux', 06:01:03 INFO - 'TMOUT': '86400', 06:01:03 INFO - 'USER': 'cltbld', 06:01:03 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:03 INFO - '_': '/tools/buildbot/bin/python'} 06:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:03 INFO - Running setup.py (path:/tmp/pip-6SfJOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:03 INFO - Running setup.py (path:/tmp/pip-kedfJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:03 INFO - Running setup.py (path:/tmp/pip-9lSSR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:03 INFO - Running setup.py (path:/tmp/pip-70t3QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:03 INFO - Running setup.py (path:/tmp/pip-qGdIq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:03 INFO - Running setup.py (path:/tmp/pip-XEJAqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:03 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:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 INFO - Running setup.py (path:/tmp/pip-KPUX_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 INFO - Running setup.py (path:/tmp/pip-dlUHFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:04 INFO - Running setup.py (path:/tmp/pip-WwdpIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:04 INFO - Running setup.py (path:/tmp/pip-vAUZat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:04 INFO - Running setup.py (path:/tmp/pip-jLS2NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:04 INFO - Running setup.py (path:/tmp/pip-VIkT76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:04 INFO - Running setup.py (path:/tmp/pip-R7Vk43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:04 INFO - Running setup.py (path:/tmp/pip-ZiDeo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:04 INFO - Running setup.py (path:/tmp/pip-e7CZJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:04 INFO - Running setup.py (path:/tmp/pip-31AEu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:04 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:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:04 INFO - Running setup.py (path:/tmp/pip-zx5x9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:04 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:01:04 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:01:04 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:01:04 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:01:04 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:01:04 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:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:04 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:01:04 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:01:04 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:01:04 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:01:04 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:01:04 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:01:06 INFO - Downloading blessings-1.5.1.tar.gz 06:01:06 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:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:06 INFO - Installing collected packages: blessings 06:01:06 INFO - Running setup.py install for blessings 06:01:06 INFO - Successfully installed blessings 06:01:06 INFO - Cleaning up... 06:01:06 INFO - Return code: 0 06:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:06 INFO - Reading from file tmpfile_stdout 06:01:06 INFO - Current package versions: 06:01:06 INFO - argparse == 1.2.1 06:01:06 INFO - blessings == 1.5.1 06:01:06 INFO - blobuploader == 1.2.4 06:01:06 INFO - docopt == 0.6.1 06:01:06 INFO - manifestparser == 1.1 06:01:06 INFO - mozInstall == 1.12 06:01:06 INFO - mozcrash == 0.16 06:01:06 INFO - mozdebug == 0.1 06:01:06 INFO - mozdevice == 0.47 06:01:06 INFO - mozfile == 1.2 06:01:06 INFO - mozhttpd == 0.7 06:01:06 INFO - mozinfo == 0.9 06:01:06 INFO - mozleak == 0.1 06:01:06 INFO - mozlog == 3.1 06:01:06 INFO - moznetwork == 0.27 06:01:06 INFO - mozprocess == 0.22 06:01:06 INFO - mozprofile == 0.27 06:01:06 INFO - mozrunner == 6.11 06:01:06 INFO - mozscreenshot == 0.1 06:01:06 INFO - mozsystemmonitor == 0.0 06:01:06 INFO - moztest == 0.7 06:01:06 INFO - mozversion == 1.4 06:01:06 INFO - psutil == 3.1.1 06:01:06 INFO - requests == 1.2.3 06:01:06 INFO - wsgiref == 0.1.2 06:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01: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:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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', '-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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:01:06 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:01:06 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:01:06 INFO - Using env: {'DISPLAY': ':0', 06:01:06 INFO - 'HOME': '/home/cltbld', 06:01:06 INFO - 'LANG': 'en_US.UTF-8', 06:01:06 INFO - 'LANGUAGE': 'en_US:en', 06:01:06 INFO - 'LOGNAME': 'cltbld', 06:01:06 INFO - 'MAIL': '/var/mail/cltbld', 06:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:06 INFO - 'MOZ_NO_REMOTE': '1', 06:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:06 INFO - 'NO_EM_RESTART': '1', 06:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:06 INFO - 'PWD': '/builds/slave/test', 06:01:06 INFO - 'SHELL': '/bin/bash', 06:01:06 INFO - 'SHLVL': '1', 06:01:06 INFO - 'TERM': 'linux', 06:01:06 INFO - 'TMOUT': '86400', 06:01:06 INFO - 'USER': 'cltbld', 06:01:06 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:06 INFO - '_': '/tools/buildbot/bin/python'} 06:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 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:01:07 INFO - Cleaning up... 06:01:07 INFO - Return code: 0 06:01:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:07 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:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:07 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:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:07 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:01:07 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:01:07 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:01:07 INFO - Using env: {'DISPLAY': ':0', 06:01:07 INFO - 'HOME': '/home/cltbld', 06:01:07 INFO - 'LANG': 'en_US.UTF-8', 06:01:07 INFO - 'LANGUAGE': 'en_US:en', 06:01:07 INFO - 'LOGNAME': 'cltbld', 06:01:07 INFO - 'MAIL': '/var/mail/cltbld', 06:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:07 INFO - 'MOZ_NO_REMOTE': '1', 06:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:07 INFO - 'NO_EM_RESTART': '1', 06:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:07 INFO - 'PWD': '/builds/slave/test', 06:01:07 INFO - 'SHELL': '/bin/bash', 06:01:07 INFO - 'SHLVL': '1', 06:01:07 INFO - 'TERM': 'linux', 06:01:07 INFO - 'TMOUT': '86400', 06:01:07 INFO - 'USER': 'cltbld', 06:01:07 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:07 INFO - '_': '/tools/buildbot/bin/python'} 06:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:07 INFO - Downloading/unpacking jsonschema 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:09 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:01:09 INFO - Downloading/unpacking functools32 (from jsonschema) 06:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:09 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:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:09 INFO - warning: no files found matching '*.txt' 06:01:09 INFO - no previously-included directories found matching 'build' 06:01:09 INFO - no previously-included directories found matching 'dist' 06:01:09 INFO - no previously-included directories found matching '.git*' 06:01:09 INFO - Installing collected packages: jsonschema, functools32 06:01:09 INFO - Running setup.py install for functools32 06:01:09 INFO - warning: no files found matching '*.txt' 06:01:09 INFO - no previously-included directories found matching 'build' 06:01:09 INFO - no previously-included directories found matching 'dist' 06:01:09 INFO - no previously-included directories found matching '.git*' 06:01:09 INFO - Successfully installed jsonschema functools32 06:01:09 INFO - Cleaning up... 06:01:09 INFO - Return code: 0 06:01:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:01:09 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:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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 0x7fae0c5d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1584240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, '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': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', '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:01:09 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:01:09 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:01:09 INFO - Using env: {'DISPLAY': ':0', 06:01:09 INFO - 'HOME': '/home/cltbld', 06:01:09 INFO - 'LANG': 'en_US.UTF-8', 06:01:09 INFO - 'LANGUAGE': 'en_US:en', 06:01:09 INFO - 'LOGNAME': 'cltbld', 06:01:09 INFO - 'MAIL': '/var/mail/cltbld', 06:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:09 INFO - 'MOZ_NO_REMOTE': '1', 06:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:09 INFO - 'NO_EM_RESTART': '1', 06:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:09 INFO - 'PWD': '/builds/slave/test', 06:01:09 INFO - 'SHELL': '/bin/bash', 06:01:09 INFO - 'SHLVL': '1', 06:01:09 INFO - 'TERM': 'linux', 06:01:09 INFO - 'TMOUT': '86400', 06:01:09 INFO - 'USER': 'cltbld', 06:01:09 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:09 INFO - '_': '/tools/buildbot/bin/python'} 06:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:09 INFO - Downloading/unpacking flake8 06:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:09 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:01:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:01:11 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:01:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:01:11 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:01:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 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:01:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:12 INFO - no previously-included directories found matching 'docs/_build' 06:01:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:12 INFO - Running setup.py install for pep8 06:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:12 INFO - no previously-included directories found matching 'docs/_build' 06:01:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:01:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:12 INFO - Cleaning up... 06:01:12 INFO - Return code: 0 06:01:12 INFO - Running post-action listener: _resource_record_post_action 06:01:12 INFO - Running post-action listener: _start_resource_monitoring 06:01:12 INFO - Starting resource monitoring. 06:01:12 INFO - ##### 06:01:12 INFO - ##### Running install step. 06:01:12 INFO - ##### 06:01:12 INFO - Running pre-action listener: _resource_record_pre_action 06:01:12 INFO - Running main action method: install 06:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:12 INFO - Reading from file tmpfile_stdout 06:01:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:12 INFO - Reading from file tmpfile_stdout 06:01:12 INFO - Output received: 06:01:12 INFO - Usage: mozinstall [options] installer 06:01:12 INFO - Options: 06:01:12 INFO - -h, --help show this help message and exit 06:01:12 INFO - -d DEST, --destination=DEST 06:01:12 INFO - Directory to install application into. [default: 06:01:12 INFO - "/builds/slave/test"] 06:01:12 INFO - --app=APP Application being installed. [default: firefox] 06:01:12 INFO - mkdir: /builds/slave/test/build/application 06:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:01:27 INFO - Reading from file tmpfile_stdout 06:01:27 INFO - Output received: 06:01:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:27 INFO - Running post-action listener: _resource_record_post_action 06:01:27 INFO - ##### 06:01:27 INFO - ##### Running run-tests step. 06:01:27 INFO - ##### 06:01:27 INFO - Running pre-action listener: _resource_record_pre_action 06:01:27 INFO - Running main action method: run_tests 06:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:27 INFO - Python 2.7.3 06:01:27 INFO - Return code: 0 06:01:27 INFO - grabbing minidump binary from tooltool 06:01:27 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:01:27 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 0x16130b0>, '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 0x1613fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1614440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:27 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:01:27 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:01:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:27 INFO - Return code: 0 06:01:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:01:28 INFO - Return code: 0 06:01:28 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 06:01:28 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 06:01:28 INFO - Using env: {'DISPLAY': ':0', 06:01:28 INFO - 'HOME': '/home/cltbld', 06:01:28 INFO - 'LANG': 'en_US.UTF-8', 06:01:28 INFO - 'LANGUAGE': 'en_US:en', 06:01:28 INFO - 'LOGNAME': 'cltbld', 06:01:28 INFO - 'MAIL': '/var/mail/cltbld', 06:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:28 INFO - 'MOZ_NO_REMOTE': '1', 06:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:28 INFO - 'NO_EM_RESTART': '1', 06:01:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:28 INFO - 'PWD': '/builds/slave/test', 06:01:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:28 INFO - 'SHELL': '/bin/bash', 06:01:28 INFO - 'SHLVL': '1', 06:01:28 INFO - 'TERM': 'linux', 06:01:28 INFO - 'TMOUT': '86400', 06:01:28 INFO - 'USER': 'cltbld', 06:01:28 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449668376.853983-1651266090', 06:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:28 INFO - '_': '/tools/buildbot/bin/python'} 06:01:28 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 06:01:28 INFO - mozversion INFO | application_buildid: 20151209052340 06:01:28 INFO - mozversion INFO | application_changeset: 64fc74a36a1606092a3cf23b949773b0518908cb 06:01:28 INFO - mozversion INFO | application_display_name: Nightly 06:01:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:28 INFO - mozversion INFO | application_name: Firefox 06:01:28 INFO - mozversion INFO | application_remotingname: firefox 06:01:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:01:28 INFO - mozversion INFO | application_vendor: Mozilla 06:01:28 INFO - mozversion INFO | application_version: 45.0a1 06:01:28 INFO - mozversion INFO | platform_buildid: 20151209052340 06:01:28 INFO - mozversion INFO | platform_changeset: 64fc74a36a1606092a3cf23b949773b0518908cb 06:01:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:01:28 INFO - mozversion INFO | platform_version: 45.0a1 06:01:28 INFO - 2015-12-09 06:01:28,317 DEBUG : using testdate: 1449669688 06:01:28 INFO - 2015-12-09 06:01:28,317 DEBUG : actual date: 1449669688 06:01:28 INFO - 2015-12-09 06:01:28,327 INFO : starting webserver on 'localhost:43748' 06:01:28 INFO - 2015-12-09 06:01:28,328 INFO : Starting test suite talos-linux64-ix-039 06:01:28 INFO - 2015-12-09 06:01:28,329 INFO : Starting test dromaeo_css 06:01:28 INFO - 2015-12-09 06:01:28,329 DEBUG : operating with platform_type : linux_ 06:01:28 INFO - 2015-12-09 06:01:28,329 INFO : Initialising browser for dromaeo_css test... 06:01:28 INFO - 2015-12-09 06:01:28,342 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0i8GvJ/profile http://localhost:43748/getInfo.html 06:01:33 INFO - 2015-12-09 06:01:33,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:33 INFO - 2015-12-09 06:01:33,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:33 INFO - 2015-12-09 06:01:33,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:01:33 INFO - 2015-12-09 06:01:33,227 DEBUG : BROWSER_OUTPUT: __metrics 06:01:33 INFO - 2015-12-09 06:01:33,356 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:01:33 INFO - 2015-12-09 06:01:33,437 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:01:34 INFO - 2015-12-09 06:01:34,347 INFO : Browser initialized. 06:01:34 INFO - 2015-12-09 06:01:34,347 INFO : Running cycle 1/1 for dromaeo_css test... 06:01:34 INFO - 2015-12-09 06:01:34,348 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0i8GvJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:46 INFO - 2015-12-09 06:01:46,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 142778368 06:01:46 INFO - 2015-12-09 06:01:46,338 DEBUG : BROWSER_OUTPUT: 06:02:37 INFO - 2015-12-09 06:02:37,758 DEBUG : BROWSER_OUTPUT: 1449669757755 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:04:49 INFO - 2015-12-09 06:04:49,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43748/tests/dromaeo/cssquery-ext.html) 06:04:50 INFO - 2015-12-09 06:04:50,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 243867648 06:04:51 INFO - 2015-12-09 06:04:50,999 DEBUG : BROWSER_OUTPUT: 06:07:53 INFO - 2015-12-09 06:07:53,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-ext.html (next: http://localhost:43748/tests/dromaeo/cssquery-jquery.html) 06:07:54 INFO - 2015-12-09 06:07:54,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 217104384 06:07:54 INFO - 2015-12-09 06:07:54,031 DEBUG : BROWSER_OUTPUT: 06:10:56 INFO - 2015-12-09 06:10:56,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43748/tests/dromaeo/cssquery-mootools.html) 06:10:56 INFO - 2015-12-09 06:10:56,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 214224896 06:10:56 INFO - 2015-12-09 06:10:56,583 DEBUG : BROWSER_OUTPUT: 06:13:58 INFO - 2015-12-09 06:13:58,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43748/tests/dromaeo/cssquery-prototype.html) 06:13:59 INFO - 2015-12-09 06:13:59,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 201146368 06:13:59 INFO - 2015-12-09 06:13:59,061 DEBUG : BROWSER_OUTPUT: 06:17:01 INFO - 2015-12-09 06:17:01,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43748/tests/dromaeo/cssquery-yui.html) 06:17:02 INFO - 2015-12-09 06:17:02,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 204947456 06:17:02 INFO - 2015-12-09 06:17:02,327 DEBUG : BROWSER_OUTPUT: 06:20:04 INFO - 2015-12-09 06:20:04,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/dromaeo/cssquery-yui.html (next: http://localhost:43748/tests/dromaeo/cssquery-dojo.html) 06:20:05 INFO - 2015-12-09 06:20:05,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 255004672 06:20:05 INFO - 2015-12-09 06:20:05,126 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,127 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:20:05 INFO - 2015-12-09 06:20:05,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:20:05 INFO - 2015-12-09 06:20:05,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:20:05 INFO - 2015-12-09 06:20:05,127 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:20:05 INFO - 2015-12-09 06:20:05,129 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2646.232592548161;2752.7522522972927;2758.9034383796557;2764.7373499517553;2790.7348801863823;4499.910001799962;4626.8380606678775;4661.790219440125;4753.0969115867965;4782.808687652489;4591.609713174375;4650.697704649196;4722.50413706561;4738.265568836827;4746.050789842028;4256.872293831175;4300.957646754641;4396.912061758779;4397.230484665187;4543.182227199103;4449.866504004885;4524.6380289576755;4531.773411329436;4542.227821270392;4550.340200670901;4201.978990105061;4228.217779710763;4292.7424354538825;4305.741655500648;4365.738055716667;4403.933940990888;4414.668899832525;4437.711548749353;4459.375687403766;4470.664700147502;4359.193549193409;4378.365137055141;4380.759058251795;4383.736975781431;4415.139047885664;4425.247707889666;4561.40701708779;4567.0409214065085;4754.310624959396;4770.7376094314795;5021.949780502185;5070.366204224472;5100.821471248526;5103.642745007851;5109.744512774347;5085.79656813727;5091.1090559152;5095.821646242363;5135.820246291362;5145.202493613496;4458.264386376277;4581.289900065495;4581.5647513486165;4691.7654117294;4710.905781884343;5074.162763144113;5152.92270615941;5169.663971841818;5195.584353251731;5212.400573934046;4949.356583644175;5016.974915125401;5038.521340472649;5039;5080.161773307437;4884.8290309838985;4997.90004199914;5013.448520662724;5106.897862042812;5107.540321371094;4967.5529202371235;4968.751562421864;5006.1739812930455;5102.081625307406;5124.128898087334;4963;5033.572146367526;5081.8729531762;5087.720175390389;5139.691618502902;4217.219814334358;4241.660667146621;4253.361995700608;4256.106217694257;4300.483941926988;3514.4201206801104;3581.8030008349792;3610;3615.6022837487853;3680.5583330000036;4313.892152696145;4355.651547876226;4356.499002614676;4358.4769827620885;4398.736075835396;5131.97434012835;5155.175171972466;5156.664816786897;5158.3552055993005;5206.3752349717515;4133.235351459929;4224.767637779952;4243.215005224043;4246.235677578004;4330.891727706832;4437.5784300491405;4470.24005918988;4470.240059189946;4478.328250762412;4503.572160644733;4794.993051459232;4798;4798.712077275374;4805.447373552086;4846.660733748604;4859.902801943871;4885.877853053702;4978.925316120333;4990.101781679187;4992.400911890596;4844.733539655353;4881.194602890483;4897.16748152822;4906.067847109038;4945.653804233669;5089.669171503989;5104.540591346797;5107.540321371094;5111.952049829851;5157.432682405008;4928.211486162197;4998.1003419383405;5054.115529782347;5057.570106540985;5096.413912400121;4908.435529914105;4919.139150648693;4924.926126108039;4929.211326187793;4959.851204463872;4919.852404427873;4920.138975679313;4923.08922849274;4924.778384972613;4928.482509336468;4716.64625153108;4725.243960966229;4780.832670856643;4847.030593881167;4870.537298956593;4990.476000019946;5000.974995125001;5006.249062640487;5008.549230569266;5025.974870125626;4902.093112774148;4915.115279249626;4920.6801557898625;4921.163402221559;4962.230854217602 06:20:05 INFO - 2015-12-09 06:20:05,132 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.160773566162;529.9867503312414;531.4207513809946;532.0131156704315;544.5507456348511;27433.177004689867;28100.718992810092;28118.43763124736;28120.15639530815;28129.43741125176;28380.432391352213;37612.435813462755;37988.24023519535;38107.23785524288;38166;7920.960395198031;8035.517868927854;8040.035195776515;8042.235987581171;8045.919540804605;7227.096612923385;7445.181030086686;7912.841743165133;7991.520508769463;8045.235702608272;7208.711651533932;7301.415886729049;7301.415886729075;10319.071283584475;10575.576976920915;9982.600695972153;10067.446290454021;10083.142932850717;10087.445190514482;10088.445135517544;7241.131064272268;9961.103500684902;10107.848382274271;10111;10112.94943525285;27337.45325093507;40581.39127913084;41681.1663766723;41727.58272417298;41729.1654166918;2963.970360296391;3004.8197108173363;3032.408680307341;3294.8846790362463;3569.607343192247;26529;26719.198424047114;26788.330291742666;27024.864875675496;27375.589366159522;3213.3573285343023;3297.3734990351754;3331.1672081979505;3347.1130150510135;3385.4244778387488;224487;224651;224736.99999999837;225255;225328;57113;57197.428025720044;57306.713466432404;57430.425695743346;57453.81827271591;62089.68955155195;62365;62398.68800656059;62409;62489.37510624927;12987.740245195233;13259.469621215043;13287.73424531504;13296.534621288209;13320.600381988363;10104.646337378303;10138.391696498235;10155.593776249016;10159.034891685278;10171.898281017095;18709.064546772606;19537.218511259674;19704.31034913771;19738.40784776459;19767.60464790725;7719.884201736979;7916.960415198002;7987.400944929153;8040.477368970998;8101.716439924574;836.2557323981662;855.9272461840688;889.8487257166297;918.4948278446827;1012.9189664826796;25133.371665708502;25397;25530;25530.617040744404;30647.846760766053;861.7437404443783;908.4549270437684;932.421898422982;991.7917237380086;1072.646026811166;13870.987050818987;14669.926650366893;14717.19055451939;14827;14836.480723174853;314223;318048;319402;319879;319891;48340.64934155943;48964.26553601699;49350.75324623354;49400.50599493959;49456;1219.6523990662618;1220.4324988880214;1237.406045098358;1265.0448911072265;1266.8733126687441;26168;26949.86525067362;27512.862435687694;27524.311892202855;29637.703622963494;44559.33161002523;45082.32376514289;45105.774471128745;45121;45171.0965780676;260255;262010.75978480704;262069;262863;263094;35856.4621530672;38981.8050909755;39413.832239227115;44392.33411498766;44601;38098;38216.80891595635;38483.80758096304;39141.2171756569;39264.6073539261;32863.67136328606;32877;33585.32829343351;33954;34056.318873621894;30977.845110775204;33245.33509329848;37475.81262093672;38817.6118238814;39246;38255.80872095733;38349.42475862808;38553.22893542057;38878.222435551696;39247.60752392554;29198.27004324909;30086.69913300839;30266.092017239516;30468.390632187675;30557.54163687502;23849.761502384754;23867.52264954726;24226;24242.393940151636;25488.10791622284 06:20:05 INFO - 2015-12-09 06:20:05,132 DEBUG : BROWSER_OUTPUT: |2;jquery.html;270.1557632398754;270.6427515679302;270.64680591827664;273.3985232488524;274.5223311438098;10567.411559004579;15189.316480758365;15653.686926261482;15678.294476748546;16718.58203544912;16276.023438593664;16602.7509587356;16613.83386166138;17098.145092745373;17124.14379281034;5466.961277357299;5599.580031497633;5615.494605485505;5617.241672374238;5621.578381621374;5585.832425027235;5631.521320687746;5640.661560306375;5645.463680950324;5652.321721393439;4081.8163182656854;4209.5790420957965;4211.810468528924;5496.697681627509;5632.662040277596;4182.6862985276075;4200.348945913388;4207.410962465242;6211.378862113753;6437.324080971524;6032.487238584726;6146.631202127886;6162.84592885177;6183.598066125687;6189.535784816157;19362;19660.311889083958;19822.405327840188;20150.39548813538;20669.793302066937;2047.9590408191902;2062.7215325930956;2144.710464087344;2155.1164022750754;2635.1304069656967;13320.134191277633;13328.666783330398;13368.732625347537;13488.460461581524;13629.182249065088;1794.1657129434745;1864.8787828791085;1896.2225487550038;1919.9808001919941;1988.8408927285782;60798;60852.087218691755;61441;66082;66262.66868665675;14272.857271427152;14741.262936853114;14790.260486975823;14798.408063677332;14956.551303460914;21584.78415215859;21752.564948700936;21782.128714851227;21792.128314867547;21812.89093554522;7388.667509962064;7423.072115985502;7448.180700122982;7618.733344332922;7638.236176382317;5932.2584676915385;5987.850303742354;5991;6009.429104235091;6128.387161283836;7380.483366164317;7429.33136017761;7442.590657513889;7445.36714379273;7455.478116531791;2310.97689023111;2930.3846192299857;2991.6110905582136;3009.458297506426;3067.125869127288;535.9571234301246;774.9147593764682;853.9701110461104;935.3405848876525;961.3126614470548;15255.847441525442;15810.130442825755;15968.76046859298;16215.756763648555;16220.35118595243;871.7602659268625;883.6686242659002;889.3863234368265;893.6202114101611;916.9174774270215;9023.864642030374;9183.816323673624;9321.44071355721;9338.813223735488;9455.621775128919;405568;485788;493010;493179;500357;71060.2893971064;73875;75132;75617.62191189118;76353;1076.1552181537456;1076.6016573867562;1111.377628528027;1111.4276147783899;1114.1755101225035;14593.958415064579;14635.34140963638;14769.483068092564;14797.186154761592;15148.545543633709;33010.66989330076;33289.66710332962;33651.83174084114;34222.31555368829;34259.82870085733;43151.568484314754;43447.565524344354;45144;45538.77230613826;46154;8303.958480207802;8435.409521333448;8544.18830211129;8553.87169192475;8563.700270490503;9989.400635961865;10012.499375031073;10034.598616055568;12125.69685757863;16959.23683434224;13310.201387916755;13404.128731632412;14149.575512734635;14170.07894486855;14393.352299146773;13395.598132056053;13639.113457625223;13795.862041379458;14080.436782528584;14191.077579957682;14337.35481903296;14390.280485975869;14550.927245363706;14572.125672459686;14669.26653667291;8469.61886715087;8524.147585241426;8528.530930798866;8530.829383412422;8754.73735787902;12958.935205323913;13184.208947463183;13264.933675331562;13351.3991870368;14119.717605648035 06:20:05 INFO - 2015-12-09 06:20:05,133 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1441.1281174889198;1496.2219645784191;1551.705176016557;1609.1069456451664;1685.7808484896962;5907.379725128864;6994.160700715915;7116.822079448003;7148.142222933242;7151.570905745659;6888.276730943254;7093.04243927071;7096.85806283874;7104.36060754532;7115.537490063142;2025.291148098165;2047.7747447780732;2061.391889392633;2062.5462398272357;2066.917323307066;1977.8912159831204;2007.3275452723356;2010.829079528242;2025.8480613953939;2028.9289874854383;2001.7798042215345;2038.3069756282862;2051.8768873867616;2056.475598722324;2056.5681206946483;1999.040460578923;2015.7278767366365;2019.5254115282896;2021.8989050547486;2023.6660950943076;1987.3640435060786;2007.1068374573322;2014.909329080195;2018.5155562664854;2019.81821636052;7241.493095483318;7276;7329.670164842595;7346.77959661211;7355.301246381585;4176.791160441966;4249.575042495757;4249.617534421917;4253.043065310311;4267.381229721673;2772.6534183227095;2794.748472637452;2807.3262417019973;2828.6888442271334;2872.2819295176205;832.9916700832974;834.7353759055037;843.2789964580318;870.5951732444444;883.3154305413292;9731.805363892683;9762.707118786448;9789.804203915883;9800.705978820646;9806.705798826046;3770.962290377116;3797.487339209227;3838.846446142123;3845.2693988142164;3845.288621605012;8403.117672644285;8406.369522285731;8406.831863362699;8414.200650938152;8421.410501264852;4291.098869237433;4323.913521729548;4328.285832837547;4328.5022222444195;4339.913201735948;3282.2450836307785;3376.729861611065;3732.122951106488;3917.490726205575;3934.291827471083;3328.2012317043736;3365.7139143172617;3384.7292216623105;3394.7963122212745;3397.983010084983;1023.6826583759058;1033.266380869591;1040.245821779204;1041.0266400915168;1042.4943902207424;1139.715071232192;1152.8040233160216;1171.701216189866;1204.8313236146946;1208.6192849252457;6844.041834143224;6849.760258390932;6860.279670634512;6884.965575172092;6892;412.6265729514794;413.96688264938734;418.80316251361813;418.85130778573165;420.05278097889675;5261.394939581921;5323;5348.411674715778;5354.223637572531;5362.731863406892;8483.490990540464;8640.179182977607;8691.869621955675;8698.391112622183;8700.260477859452;8455.365847561457;8602.827943441096;8639.222469977733;8699.565021749015;8737.126287371339;6804.455643548505;6823.351781580742;6842.110525631736;6864.039034535169;6870.484713646497;6516.51126165549;6619.238787539494;6823.93176068233;6847.349501797321;6849.657517124024;7613.08642962848;7654.846903062019;7908.06252468149;7950.801229969297;7973.122956474899;7892.447528672938;8012.599370031592;8073.071596766447;8143.633536490991;8150.347972162094;5238.816641417532;5342.732863356894;6212.254529456494;6274.435300822948;6305.1172835803945;6413.198350206224;6545.967270163619;6563.04835798816;6579.309172536815;6584.8353791155605;5997.790077347272;6500.869982600227;6546.934530654633;6615.17310336208;6621.768238111643;6409.519286053658;6418.101465794886;6442.806715798533;6533.314002029909;6564.540482166202;6502.479801615765;6532.248791389051;6543.378379053982;6544.3782840630065;6547.279799221987;5691.77232910679;5977.9103313451205;5986.281646202309;5992.490638295793;6018;6112.510999119971;6171.9691401542705;6180.536459765445;6192.566520343713;6203.875922481616 06:20:05 INFO - 2015-12-09 06:20:05,133 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.13484047456515;254.90058877037947;255.9091522509509;258.52173479063737;258.7063682720112;5234.947650523493;5298.549623282021;5329.173978033401;5336.706481143545;5359.919601205985;4964.975175124128;4998.5501304882555;5036.068327359441;5225.059489291926;5266.81566145185;3983.2630963271745;3996.920061598766;3999.9400008999887;4000.979995100035;4002.4396584478195;3936.862209822657;3968.444417781513;3975.9006024849464;3984.442178095069;3985.501812273466;3748.119191989894;3850.8267127979307;3858.4405261237102;3926.764394136361;3934.4295077213787;3963.881083567483;3975.1056012397266;3975.5030621172355;3976.661983731372;3988.0827409695644;3432.090496018557;3433.4506478963494;3435.811030393327;3437.2781715839706;3442.5008373785663;5064.594832413398;5066.9746651266505;5067.138586440277;5071.644984851062;5072.2391641253735;4544.590986811203;4552.385427967215;4552.977235113836;4555.703879247838;4558.908821823545;5500.202470641734;5504.339479262474;5506.587005974568;5507.421720719307;5517.972410137963;3739.139997800494;3739.2334571412794;3740.663340299359;3741.1769410729594;3746.925061498782;5773.3072031356505;5821.67980761058;5823.883522329572;5824.767009319665;5825.970870145665;3614.945775813365;3685.2076803486843;3718.1262403335736;3843.423486477051;3848.1726428817938;3746.213295208037;3826.1582451860545;3827.215420838777;3828.7319887608155;3859.9421008684894;4462.955370446319;4465.642748580106;4473.083017981306;4484.977575112169;4492.707973981681;5508.14623733322;5510.366307874566;5511.118221084607;5513.558915286768;5515.806946756925;1345.9865401346058;1370;1371.5405339211477;1371.9984411379749;1372.540199033315;886.7162507997378;919.7424721078108;922.8154369126202;930.292977337215;935.8736570563022;4808.663393562487;4811.735354555533;4817.927731084036;4818.156822556039;4821.445533763662;5743.282089738783;5751.079827227623;5751.8562035949435;5752.9712351437975;5754.913676294859;4804.159272127364;4814.374131362971;4817.1810792164715;4818.7831547580445;4822.397200349957;3005.819650820914;3063.678313777066;3081.1372815611217;3085.2903832118736;3096.9845150774104;5419.918701219485;5420.972895135499;5420.972895135499;5425.376081750649;5432.2123292123215;5891.23413956183;5903.586748927534;5906.995810712189;5909.409059094056;5909.911351329733;5409.43200963901;5414.269073675082;5418.485243901823;5421.5391691706645;5422.810201642924;5570.749316280696;5707.400722924199;5720.942790572041;5724.885502289848;5735.684537350486;5613.578981576316;5617.775288988395;5620.578456615852;5621.831345059655;5626;5413.7834486620095;5416.4041955385665;5418.783248670009;5422.783088676567;5425.294711687456;3767.340715374853;3821.3694740367528;3839.251345987506;3842.7886466244627;3844.8077596120643;5527.640703354269;5680.71596420169;5704.260200638845;5725.51333136688;5815.389384114607;5567.721613919207;5579.330480342385;5581.6930068846605;5590.608657393944;5593.720313984203;5533.059379905345;5534.833954981357;5542.861428464321;5545.140503222007;5545.7781688732;5350.866228344167;5435.619506634655;5454.10007348783;5465.836024919259;5474.479924407175;5599.860003499945;5604.243427137448;5616.66300022;5622.690752008679;5623.2127502148915;5471.124620060771;5484.149956756709;5484.341878974548;5488.368837583729;5496.258005169251 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: |5;yui.html;665.7370338716204;671.3622059043906;698.5250029979615;714.3249629100499;738.6860584251693;12159.148859579833;12502.687432814184;12523.561675341341;12531.561395351164;12538.310392928386;13243.536476223335;13255.867441325583;13359.666008349795;13431.529896453627;13457.865421345783;631.7346714379948;794.1938931984026;807.5800583696474;807.7092246791179;807.8020884883211;640.123031446916;791.4459878085335;805.0661232969757;806.4475834053692;806.9798255043612;833.6248688090384;845.2055068235838;847.0301504777027;847.631280393028;847.7329641163045;662.9303923088079;671.4259308291438;818.9181081891822;841.7054031089131;842.4313588327885;619.7737825693634;620.110141946304;620.6803496199461;620.9782657607008;621.6208113051035;12515.123941324111;12663.366831658472;12673.809892851523;12677.302748348837;12682.175658582162;10700.51847666849;11226.719332016683;11246.55013799447;11360.147988900782;11377.146713996483;9495.952520237355;9580.377275477142;9617.855732164024;9658.75853103671;9732.75668108296;3178.666240044808;3227.8708851645906;3248.3016151527536;3249.220187155089;3254.349130173951;40354.79822600868;41314.1737165258;41428.79285603583;41495.1700965982;41523.584764152576;8429.536375499283;8446.66213351459;8461.534615596078;8521.957390213009;8574.314054875595;15682.607934801721;15740.763888541682;15769.526914192593;15798;15802.762958555631;6217.626942383471;6363.936360636334;6384.648844313608;6483.902741458882;6549.869002619921;3345.2974875275977;3604.5133906922756;3615.8553657853918;3620;3641.3299893223098;2646.325187077283;2679.0623281851585;2679.3569543309463;2688.2876037849987;2689.1394753678637;464.1204916682867;473.59034435213295;475.59811958894676;477.40801406256685;482.09366391184346;496.8832324403762;538.6875612144946;583.6439771739235;585.8213244960328;587.2571197435248;7547.924520754722;8643.524606146597;8796.428232165017;8940.597673104596;9017.458952462874;613.4233820209079;624.8000639795313;628.133235579688;628.745358129958;638.8754192932427;3650.6714395703984;3872.6127387261613;3904.570497245301;3942.3692209246956;4068;44054.55945440569;44097.338539921926;44412.55587444149;46981.06037879223;47749.283760743616;43423.78288108602;43611.34582981258;43651.34522982158;43771.78114109409;44003;38326.2334753309;39842.80078599588;39885.20803543782;39908.20183596312;40523.59476405198;8023.273770679734;8037.156098609562;8193.67225310981;8249.340052795882;8294.709685160991;30174;30431;30516;31242.531362030044;31515.52726709147;35943;38010.61989380181;38115;38604.80697596494;39266.80366598149;10135.391876487434;10200.744981375525;10392.297286544268;10447.477626118816;10478.214133939833;11255.606053788078;11310.547578096784;11383.03244224217;11598.652040438801;11599.246049006788;10616.203784716023;11150.665480035612;11161.609343672932;11301.378424186749;11634.534618615498;10216.795664086825;10582.100521455455;10642.201834862572;10787.137029037502;10901.727456813644;10556.630517932143;10632.468376581295;10730.907736247362;10990.395528246023;10994.230403871652;8883.480377243657;9084.772880678036;9271.490068046322;9468.431894086378;9538.14156725898;8304.501729895985;9172.44965302084;9232.907670923205;9245.907540924774;9264.351495395258 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670805126__endTimestamp 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:20:05 INFO - 2015-12-09 06:20:05,135 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,136 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4674.18 Median:4844.73 stddev:494.90 (10.2%) stddev-sans-first:470.16 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: Values: 2646.2 2752.8 2758.9 2764.7 2790.7 4499.9 4626.8 4661.8 4753.1 4782.8 4591.6 4650.7 4722.5 4738.3 4746.1 4256.9 4301.0 4396.9 4397.2 4543.2 4449.9 4524.6 4531.8 4542.2 4550.3 4202.0 4228.2 4292.7 4305.7 4365.7 4403.9 4414.7 4437.7 4459.4 4470.7 4359.2 4378.4 4380.8 4383.7 4415.1 4425.2 4561.4 4567.0 4754.3 4770.7 5021.9 5070.4 5100.8 5103.6 5109.7 5085.8 5091.1 5095.8 5135.8 5145.2 4458.3 4581.3 4581.6 4691.8 4710.9 5074.2 5152.9 5169.7 5195.6 5212.4 4949.4 5017.0 5038.5 5039.0 5080.2 4884.8 4997.9 5013.4 5106.9 5107.5 4967.6 4968.8 5006.2 5102.1 5124.1 4963.0 5033.6 5081.9 5087.7 5139.7 4217.2 4241.7 4253.4 4256.1 4300.5 3514.4 3581.8 3610.0 3615.6 3680.6 4313.9 4355.7 4356.5 4358.5 4398.7 5132.0 5155.2 5156.7 5158.4 5206.4 4133.2 4224.8 4243.2 4246.2 4330.9 4437.6 4470.2 4470.2 4478.3 4503.6 4795.0 4798.0 4798.7 4805.4 4846.7 4859.9 4885.9 4978.9 4990.1 4992.4 4844.7 4881.2 4897.2 4906.1 4945.7 5089.7 5104.5 5107.5 5112.0 5157.4 4928.2 4998.1 5054.1 5057.6 5096.4 4908.4 4919.1 4924.9 4929.2 4959.9 4919.9 4920.1 4923.1 4924.8 4928.5 4716.6 4725.2 4780.8 4847.0 4870.5 4990.5 5001.0 5006.2 5008.5 5026.0 4902.1 4915.1 4920.7 4921.2 4962.2 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43436.89 Median:3296.13 stddev:70904.48 (2151.1%) stddev-sans-first:71030.19 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: Values: 526.2 530.0 531.4 532.0 544.6 27433.2 28100.7 28118.4 28120.2 28129.4 28380.4 37612.4 37988.2 38107.2 38166.0 7921.0 8035.5 8040.0 8042.2 8045.9 7227.1 7445.2 7912.8 7991.5 8045.2 7208.7 7301.4 7301.4 10319.1 10575.6 9982.6 10067.4 10083.1 10087.4 10088.4 7241.1 9961.1 10107.8 10111.0 10112.9 27337.5 40581.4 41681.2 41727.6 41729.2 2964.0 3004.8 3032.4 3294.9 3569.6 26529.0 26719.2 26788.3 27024.9 27375.6 3213.4 3297.4 3331.2 3347.1 3385.4 224487.0 224651.0 224737.0 225255.0 225328.0 57113.0 57197.4 57306.7 57430.4 57453.8 62089.7 62365.0 62398.7 62409.0 62489.4 12987.7 13259.5 13287.7 13296.5 13320.6 10104.6 10138.4 10155.6 10159.0 10171.9 18709.1 19537.2 19704.3 19738.4 19767.6 7719.9 7917.0 7987.4 8040.5 8101.7 836.3 855.9 889.8 918.5 1012.9 25133.4 25397.0 25530.0 25530.6 30647.8 861.7 908.5 932.4 991.8 1072.6 13871.0 14669.9 14717.2 14827.0 14836.5 314223.0 318048.0 319402.0 319879.0 319891.0 48340.6 48964.3 49350.8 49400.5 49456.0 1219.7 1220.4 1237.4 1265.0 1266.9 26168.0 26949.9 27512.9 27524.3 29637.7 44559.3 45082.3 45105.8 45121.0 45171.1 260255.0 262010.8 262069.0 262863.0 263094.0 35856.5 38981.8 39413.8 44392.3 44601.0 38098.0 38216.8 38483.8 39141.2 39264.6 32863.7 32877.0 33585.3 33954.0 34056.3 30977.8 33245.3 37475.8 38817.6 39246.0 38255.8 38349.4 38553.2 38878.2 39247.6 29198.3 30086.7 30266.1 30468.4 30557.5 23849.8 23867.5 24226.0 24242.4 25488.1 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27091.21 Median:33470.75 stddev:77922.04 (232.8%) stddev-sans-first:78114.61 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: Values: 270.2 270.6 270.6 273.4 274.5 10567.4 15189.3 15653.7 15678.3 16718.6 16276.0 16602.8 16613.8 17098.1 17124.1 5467.0 5599.6 5615.5 5617.2 5621.6 5585.8 5631.5 5640.7 5645.5 5652.3 4081.8 4209.6 4211.8 5496.7 5632.7 4182.7 4200.3 4207.4 6211.4 6437.3 6032.5 6146.6 6162.8 6183.6 6189.5 19362.0 19660.3 19822.4 20150.4 20669.8 2048.0 2062.7 2144.7 2155.1 2635.1 13320.1 13328.7 13368.7 13488.5 13629.2 1794.2 1864.9 1896.2 1920.0 1988.8 60798.0 60852.1 61441.0 66082.0 66262.7 14272.9 14741.3 14790.3 14798.4 14956.6 21584.8 21752.6 21782.1 21792.1 21812.9 7388.7 7423.1 7448.2 7618.7 7638.2 5932.3 5987.9 5991.0 6009.4 6128.4 7380.5 7429.3 7442.6 7445.4 7455.5 2311.0 2930.4 2991.6 3009.5 3067.1 536.0 774.9 854.0 935.3 961.3 15255.8 15810.1 15968.8 16215.8 16220.4 871.8 883.7 889.4 893.6 916.9 9023.9 9183.8 9321.4 9338.8 9455.6 405568.0 485788.0 493010.0 493179.0 500357.0 71060.3 73875.0 75132.0 75617.6 76353.0 1076.2 1076.6 1111.4 1111.4 1114.2 14594.0 14635.3 14769.5 14797.2 15148.5 33010.7 33289.7 33651.8 34222.3 34259.8 43151.6 43447.6 45144.0 45538.8 46154.0 8304.0 8435.4 8544.2 8553.9 8563.7 9989.4 10012.5 10034.6 12125.7 16959.2 13310.2 13404.1 14149.6 14170.1 14393.4 13395.6 13639.1 13795.9 14080.4 14191.1 14337.4 14390.3 14550.9 14572.1 14669.3 8469.6 8524.1 8528.5 8530.8 8754.7 12958.9 13184.2 13264.9 13351.4 14119.7 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,137 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4991.75 Median:6176.25 stddev:2643.76 (42.8%) stddev-sans-first:2637.71 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: Values: 1441.1 1496.2 1551.7 1609.1 1685.8 5907.4 6994.2 7116.8 7148.1 7151.6 6888.3 7093.0 7096.9 7104.4 7115.5 2025.3 2047.8 2061.4 2062.5 2066.9 1977.9 2007.3 2010.8 2025.8 2028.9 2001.8 2038.3 2051.9 2056.5 2056.6 1999.0 2015.7 2019.5 2021.9 2023.7 1987.4 2007.1 2014.9 2018.5 2019.8 7241.5 7276.0 7329.7 7346.8 7355.3 4176.8 4249.6 4249.6 4253.0 4267.4 2772.7 2794.7 2807.3 2828.7 2872.3 833.0 834.7 843.3 870.6 883.3 9731.8 9762.7 9789.8 9800.7 9806.7 3771.0 3797.5 3838.8 3845.3 3845.3 8403.1 8406.4 8406.8 8414.2 8421.4 4291.1 4323.9 4328.3 4328.5 4339.9 3282.2 3376.7 3732.1 3917.5 3934.3 3328.2 3365.7 3384.7 3394.8 3398.0 1023.7 1033.3 1040.2 1041.0 1042.5 1139.7 1152.8 1171.7 1204.8 1208.6 6844.0 6849.8 6860.3 6885.0 6892.0 412.6 414.0 418.8 418.9 420.1 5261.4 5323.0 5348.4 5354.2 5362.7 8483.5 8640.2 8691.9 8698.4 8700.3 8455.4 8602.8 8639.2 8699.6 8737.1 6804.5 6823.4 6842.1 6864.0 6870.5 6516.5 6619.2 6823.9 6847.3 6849.7 7613.1 7654.8 7908.1 7950.8 7973.1 7892.4 8012.6 8073.1 8143.6 8150.3 5238.8 5342.7 6212.3 6274.4 6305.1 6413.2 6546.0 6563.0 6579.3 6584.8 5997.8 6500.9 6546.9 6615.2 6621.8 6409.5 6418.1 6442.8 6533.3 6564.5 6502.5 6532.2 6543.4 6544.4 6547.3 5691.8 5977.9 5986.3 5992.5 6018.0 6112.5 6172.0 6180.5 6192.6 6203.9 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4542.27 Median:5282.68 stddev:1377.51 (26.1%) stddev-sans-first:1343.19 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: Values: 251.1 254.9 255.9 258.5 258.7 5234.9 5298.5 5329.2 5336.7 5359.9 4965.0 4998.6 5036.1 5225.1 5266.8 3983.3 3996.9 3999.9 4001.0 4002.4 3936.9 3968.4 3975.9 3984.4 3985.5 3748.1 3850.8 3858.4 3926.8 3934.4 3963.9 3975.1 3975.5 3976.7 3988.1 3432.1 3433.5 3435.8 3437.3 3442.5 5064.6 5067.0 5067.1 5071.6 5072.2 4544.6 4552.4 4553.0 4555.7 4558.9 5500.2 5504.3 5506.6 5507.4 5518.0 3739.1 3739.2 3740.7 3741.2 3746.9 5773.3 5821.7 5823.9 5824.8 5826.0 3614.9 3685.2 3718.1 3843.4 3848.2 3746.2 3826.2 3827.2 3828.7 3859.9 4463.0 4465.6 4473.1 4485.0 4492.7 5508.1 5510.4 5511.1 5513.6 5515.8 1346.0 1370.0 1371.5 1372.0 1372.5 886.7 919.7 922.8 930.3 935.9 4808.7 4811.7 4817.9 4818.2 4821.4 5743.3 5751.1 5751.9 5753.0 5754.9 4804.2 4814.4 4817.2 4818.8 4822.4 3005.8 3063.7 3081.1 3085.3 3097.0 5419.9 5421.0 5421.0 5425.4 5432.2 5891.2 5903.6 5907.0 5909.4 5909.9 5409.4 5414.3 5418.5 5421.5 5422.8 5570.7 5707.4 5720.9 5724.9 5735.7 5613.6 5617.8 5620.6 5621.8 5626.0 5413.8 5416.4 5418.8 5422.8 5425.3 3767.3 3821.4 3839.3 3842.8 3844.8 5527.6 5680.7 5704.3 5725.5 5815.4 5567.7 5579.3 5581.7 5590.6 5593.7 5533.1 5534.8 5542.9 5545.1 5545.8 5350.9 5435.6 5454.1 5465.8 5474.5 5599.9 5604.2 5616.7 5622.7 5623.2 5471.1 5484.1 5484.3 5488.4 5496.3 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12155.46 Median:43517.56 stddev:13316.26 (30.6%) stddev-sans-first:13325.66 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: Values: 665.7 671.4 698.5 714.3 738.7 12159.1 12502.7 12523.6 12531.6 12538.3 13243.5 13255.9 13359.7 13431.5 13457.9 631.7 794.2 807.6 807.7 807.8 640.1 791.4 805.1 806.4 807.0 833.6 845.2 847.0 847.6 847.7 662.9 671.4 818.9 841.7 842.4 619.8 620.1 620.7 621.0 621.6 12515.1 12663.4 12673.8 12677.3 12682.2 10700.5 11226.7 11246.6 11360.1 11377.1 9496.0 9580.4 9617.9 9658.8 9732.8 3178.7 3227.9 3248.3 3249.2 3254.3 40354.8 41314.2 41428.8 41495.2 41523.6 8429.5 8446.7 8461.5 8522.0 8574.3 15682.6 15740.8 15769.5 15798.0 15802.8 6217.6 6363.9 6384.6 6483.9 6549.9 3345.3 3604.5 3615.9 3620.0 3641.3 2646.3 2679.1 2679.4 2688.3 2689.1 464.1 473.6 475.6 477.4 482.1 496.9 538.7 583.6 585.8 587.3 7547.9 8643.5 8796.4 8940.6 9017.5 613.4 624.8 628.1 628.7 638.9 3650.7 3872.6 3904.6 3942.4 4068.0 44054.6 44097.3 44412.6 46981.1 47749.3 43423.8 43611.3 43651.3 43771.8 44003.0 38326.2 39842.8 39885.2 39908.2 40523.6 8023.3 8037.2 8193.7 8249.3 8294.7 30174.0 30431.0 30516.0 31242.5 31515.5 35943.0 38010.6 38115.0 38604.8 39266.8 10135.4 10200.7 10392.3 10447.5 10478.2 11255.6 11310.5 11383.0 11598.7 11599.2 10616.2 11150.7 11161.6 11301.4 11634.5 10216.8 10582.1 10642.2 10787.1 10901.7 10556.6 10632.5 10730.9 10990.4 10994.2 8883.5 9084.8 9271.5 9468.4 9538.1 8304.5 9172.4 9232.9 9245.9 9264.4 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:20:05 INFO - 2015-12-09 06:20:05,139 DEBUG : BROWSER_OUTPUT: 06:20:05 INFO - 2015-12-09 06:20:05,835 INFO : Browser exited with error code: 0 06:20:05 INFO - 2015-12-09 06:20:05,856 INFO : Completed test dromaeo_css (00:18:37) 06:20:05 INFO - 2015-12-09 06:20:05,857 INFO : Starting test kraken 06:20:05 INFO - 2015-12-09 06:20:05,857 DEBUG : operating with platform_type : linux_ 06:20:05 INFO - 2015-12-09 06:20:05,857 INFO : Initialising browser for kraken test... 06:20:05 INFO - 2015-12-09 06:20:05,863 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJE02_Q/profile http://localhost:43748/getInfo.html 06:20:10 INFO - 2015-12-09 06:20:10,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:20:10 INFO - 2015-12-09 06:20:10,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:20:10 INFO - 2015-12-09 06:20:10,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:20:10 INFO - 2015-12-09 06:20:10,121 DEBUG : BROWSER_OUTPUT: __metrics 06:20:10 INFO - 2015-12-09 06:20:10,210 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:20:10 INFO - 2015-12-09 06:20:10,271 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:20:11 INFO - 2015-12-09 06:20:11,433 INFO : Browser initialized. 06:20:11 INFO - 2015-12-09 06:20:11,434 INFO : Running cycle 1/1 for kraken test... 06:20:11 INFO - 2015-12-09 06:20:11,434 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJE02_Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:20:23 INFO - 2015-12-09 06:20:23,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 143056896 06:20:23 INFO - 2015-12-09 06:20:23,478 DEBUG : BROWSER_OUTPUT: 06:20:26 INFO - 2015-12-09 06:20:26,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43748/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:26 INFO - 2015-12-09 06:20:26,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 175955968 06:20:26 INFO - 2015-12-09 06:20:26,709 DEBUG : BROWSER_OUTPUT: 06:20:29 INFO - 2015-12-09 06:20:29,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43748/tests/kraken/driver.html?testName=audio-dft) 06:20:30 INFO - 2015-12-09 06:20:30,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 165376000 06:20:30 INFO - 2015-12-09 06:20:30,085 DEBUG : BROWSER_OUTPUT: 06:20:33 INFO - 2015-12-09 06:20:33,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43748/tests/kraken/driver.html?testName=audio-fft) 06:20:33 INFO - 2015-12-09 06:20:33,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 153493504 06:20:33 INFO - 2015-12-09 06:20:33,686 DEBUG : BROWSER_OUTPUT: 06:20:35 INFO - 2015-12-09 06:20:35,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43748/tests/kraken/driver.html?testName=audio-oscillator) 06:20:36 INFO - 2015-12-09 06:20:36,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 154529792 06:20:36 INFO - 2015-12-09 06:20:36,308 DEBUG : BROWSER_OUTPUT: 06:20:38 INFO - 2015-12-09 06:20:38,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:39 INFO - 2015-12-09 06:20:39,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 157687808 06:20:39 INFO - 2015-12-09 06:20:39,110 DEBUG : BROWSER_OUTPUT: 06:20:42 INFO - 2015-12-09 06:20:42,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43748/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:42 INFO - 2015-12-09 06:20:42,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 157966336 06:20:42 INFO - 2015-12-09 06:20:42,702 DEBUG : BROWSER_OUTPUT: 06:20:46 INFO - 2015-12-09 06:20:46,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43748/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:46 INFO - 2015-12-09 06:20:46,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 157974528 06:20:46 INFO - 2015-12-09 06:20:46,633 DEBUG : BROWSER_OUTPUT: 06:20:49 INFO - 2015-12-09 06:20:49,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43748/tests/kraken/driver.html?testName=json-parse-financial) 06:20:50 INFO - 2015-12-09 06:20:50,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 158130176 06:20:50 INFO - 2015-12-09 06:20:50,069 DEBUG : BROWSER_OUTPUT: 06:20:51 INFO - 2015-12-09 06:20:51,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:52 INFO - 2015-12-09 06:20:52,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 168873984 06:20:52 INFO - 2015-12-09 06:20:52,439 DEBUG : BROWSER_OUTPUT: 06:20:54 INFO - 2015-12-09 06:20:54,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:54 INFO - 2015-12-09 06:20:54,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 167989248 06:20:54 INFO - 2015-12-09 06:20:54,940 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:57 INFO - 2015-12-09 06:20:57,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 179965952 06:20:57 INFO - 2015-12-09 06:20:57,688 DEBUG : BROWSER_OUTPUT: 06:21:00 INFO - 2015-12-09 06:21:00,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:00 INFO - 2015-12-09 06:21:00,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 184881152 06:21:00 INFO - 2015-12-09 06:21:00,801 DEBUG : BROWSER_OUTPUT: 06:21:03 INFO - 2015-12-09 06:21:03,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:03 INFO - 2015-12-09 06:21:03,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 182050816 06:21:03 INFO - 2015-12-09 06:21:03,998 DEBUG : BROWSER_OUTPUT: 06:21:05 INFO - 2015-12-09 06:21:05,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43748/tests/kraken/driver.html?testName=ai-astar) 06:21:06 INFO - 2015-12-09 06:21:06,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 240242688 06:21:06 INFO - 2015-12-09 06:21:06,018 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,021 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;116;109;114;114;114;104;113;115;107 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;153;163;138;165;151;138;173;132 06:21:06 INFO - 2015-12-09 06:21:06,022 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;159;162;161;163;163;162;161 06:21:06 INFO - 2015-12-09 06:21:06,023 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;83;91;72;72;71;100;89;72 06:21:06 INFO - 2015-12-09 06:21:06,023 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;126;94;95;95;128;94;95;135 06:21:06 INFO - 2015-12-09 06:21:06,023 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;110;109 06:21:06 INFO - 2015-12-09 06:21:06,023 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;147;146;146;146;148;146;146 06:21:06 INFO - 2015-12-09 06:21:06,023 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;94;95;96;95;95;95;95;95;94 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;74;73;74;76;73;74;80;72 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;68;68;69;68;69;69 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;85;85;87;84;84;85;84;85 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;123;125;119;118;121;120;124;126;129 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;150;150;148;151;135;150;146;150;136 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;68;70;70;69;69;70;68 06:21:06 INFO - 2015-12-09 06:21:06,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:21:06 INFO - 2015-12-09 06:21:06,025 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:21:06 INFO - 2015-12-09 06:21:06,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,981 06:21:06 INFO - 2015-12-09 06:21:06,025 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:21:06 INFO - 2015-12-09 06:21:06,025 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670866020__endTimestamp 06:21:06 INFO - 2015-12-09 06:21:06,025 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:114.00 stddev:3.88 (3.4%) stddev-sans-first:4.12 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: Values: 112.0 116.0 109.0 114.0 114.0 114.0 104.0 113.0 115.0 107.0 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.50 stddev:14.61 (9.5%) stddev-sans-first:15.42 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 153.0 163.0 138.0 165.0 151.0 138.0 173.0 132.0 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 159.0 162.0 161.0 163.0 163.0 162.0 161.0 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:72.50 stddev:10.60 (14.6%) stddev-sans-first:10.98 06:21:06 INFO - 2015-12-09 06:21:06,033 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 83.0 91.0 72.0 72.0 71.0 100.0 89.0 72.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:95.00 stddev:16.97 (17.9%) stddev-sans-first:17.59 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 126.0 94.0 95.0 95.0 128.0 94.0 95.0 135.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.40 Median:74.00 stddev:2.27 (3.1%) stddev-sans-first:2.40 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 74.0 73.0 74.0 76.0 73.0 74.0 80.0 72.0 06:21:06 INFO - 2015-12-09 06:21:06,034 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,035 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:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 69.0 69.0 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.18 (1.4%) stddev-sans-first:1.12 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 85.0 85.0 87.0 84.0 84.0 85.0 84.0 85.0 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:4.09 (3.3%) stddev-sans-first:3.60 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: Values: 130.0 123.0 125.0 119.0 118.0 121.0 120.0 124.0 126.0 129.0 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:150.00 stddev:6.73 (4.5%) stddev-sans-first:6.26 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: Values: 136.0 150.0 150.0 148.0 151.0 135.0 150.0 146.0 150.0 136.0 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 68.0 70.0 70.0 69.0 69.0 70.0 68.0 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:21:06 INFO - 2015-12-09 06:21:06,035 DEBUG : BROWSER_OUTPUT: 06:21:06 INFO - 2015-12-09 06:21:06,935 INFO : Browser exited with error code: 0 06:21:06 INFO - 2015-12-09 06:21:06,983 INFO : Completed test kraken (00:01:01) 06:21:06 INFO - 2015-12-09 06:21:06,983 INFO : Starting test v8_7 06:21:06 INFO - 2015-12-09 06:21:06,983 DEBUG : operating with platform_type : linux_ 06:21:06 INFO - 2015-12-09 06:21:06,984 INFO : Initialising browser for v8_7 test... 06:21:06 INFO - 2015-12-09 06:21:06,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4lZM9/profile http://localhost:43748/getInfo.html 06:21:11 INFO - 2015-12-09 06:21:11,234 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:21:11 INFO - 2015-12-09 06:21:11,234 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:21:11 INFO - 2015-12-09 06:21:11,234 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:21:11 INFO - 2015-12-09 06:21:11,234 DEBUG : BROWSER_OUTPUT: __metrics 06:21:11 INFO - 2015-12-09 06:21:11,351 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:21:11 INFO - 2015-12-09 06:21:11,419 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:21:12 INFO - 2015-12-09 06:21:12,760 INFO : Browser initialized. 06:21:12 INFO - 2015-12-09 06:21:12,760 INFO : Running cycle 1/1 for v8_7 test... 06:21:12 INFO - 2015-12-09 06:21:12,761 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4lZM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:21:24 INFO - 2015-12-09 06:21:24,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 142520320 06:21:24 INFO - 2015-12-09 06:21:24,804 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43748/tests/v8_7/run.html (next: http://localhost:43748/tests/v8_7/run.html) 06:21:46 INFO - 2015-12-09 06:21:46,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 460873728 06:21:46 INFO - 2015-12-09 06:21:46,536 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,536 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:21:46 INFO - 2015-12-09 06:21:46,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:21:46 INFO - 2015-12-09 06:21:46,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:21:46 INFO - 2015-12-09 06:21:46,537 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:21:46 INFO - 2015-12-09 06:21:46,537 DEBUG : BROWSER_OUTPUT: |0;Richards;167.9261125104954 06:21:46 INFO - 2015-12-09 06:21:46,538 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.6665428889714 06:21:46 INFO - 2015-12-09 06:21:46,539 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 06:21:46 INFO - 2015-12-09 06:21:46,539 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 06:21:46 INFO - 2015-12-09 06:21:46,539 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2059.670781893004 06:21:46 INFO - 2015-12-09 06:21:46,540 DEBUG : BROWSER_OUTPUT: |5;Earley;793.1854199683042 06:21:46 INFO - 2015-12-09 06:21:46,540 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 06:21:46 INFO - 2015-12-09 06:21:46,540 DEBUG : BROWSER_OUTPUT: |7;RegExp;27486.486486486487 06:21:46 INFO - 2015-12-09 06:21:46,540 DEBUG : BROWSER_OUTPUT: |8;Splay;600.1199040767386 06:21:46 INFO - 2015-12-09 06:21:46,541 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:21:46 INFO - 2015-12-09 06:21:46,541 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:21:46 INFO - 2015-12-09 06:21:46,541 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670906535__endTimestamp 06:21:46 INFO - 2015-12-09 06:21:46,541 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,542 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:21:46 INFO - 2015-12-09 06:21:46,542 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:21:46 INFO - 2015-12-09 06:21:46,542 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,542 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.93 Median:167.93 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,542 DEBUG : BROWSER_OUTPUT: Values: 167.9 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.67 Median:185.67 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: Values: 185.7 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,543 DEBUG : BROWSER_OUTPUT: Values: 278.0 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: Values: 5128.2 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2059.67 Median:2059.67 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: Values: 2059.7 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.19 Median:793.19 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,544 DEBUG : BROWSER_OUTPUT: Values: 793.2 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: Values: 12180.7 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27486.49 Median:27486.49 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: Values: 27486.5 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.12 Median:600.12 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: Values: 600.1 06:21:46 INFO - 2015-12-09 06:21:46,545 DEBUG : BROWSER_OUTPUT: 06:21:46 INFO - 2015-12-09 06:21:46,546 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:21:46 INFO - 2015-12-09 06:21:46,546 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:21:46 INFO - 2015-12-09 06:21:46,546 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:21:46 INFO - 2015-12-09 06:21:46,546 DEBUG : BROWSER_OUTPUT: 06:21:47 INFO - 2015-12-09 06:21:47,527 INFO : Browser exited with error code: 0 06:21:47 INFO - 2015-12-09 06:21:47,542 INFO : Completed test v8_7 (00:00:40) 06:21:48 INFO - 2015-12-09 06:21:48,014 INFO : Completed test suite (00:20:19) 06:21:48 INFO - 2015-12-09 06:21:48,015 DEBUG : Working with test: dromaeo_css 06:21:48 INFO - 2015-12-09 06:21:48,015 DEBUG : Generating results file: dromaeo_css 06:21:48 INFO - 2015-12-09 06:21:48,016 DEBUG : Working with test: kraken 06:21:48 INFO - 2015-12-09 06:21:48,016 DEBUG : Generating results file: kraken 06:21:48 INFO - 2015-12-09 06:21:48,017 INFO : javascript benchmark 06:21:48 INFO - 2015-12-09 06:21:48,017 DEBUG : Working with test: v8_7 06:21:48 INFO - 2015-12-09 06:21:48,017 DEBUG : Generating results file: v8_7 06:21:48 INFO - 2015-12-09 06:21:48,018 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:48 INFO - 2015-12-09 06:21:48,073 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 06:21:48 INFO - 2015-12-09 06:21:48,073 DEBUG : process_Request line: dromaeo_css 6396.41 graph.html#tests=[[72,132,35]] 06:21:48 INFO - 2015-12-09 06:21:48,073 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:48 INFO - 2015-12-09 06:21:48,108 DEBUG : process_Request line: kraken 1523.70 graph.html#tests=[[232,132,35]] 06:21:48 INFO - 2015-12-09 06:21:48,108 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:48 INFO - 2015-12-09 06:21:48,143 DEBUG : process_Request line: v8_7 19705.60 graph.html#tests=[[230,132,35]] 06:21:48 INFO - 2015-12-09 06:21:48,144 INFO : javascript benchmark 06:21:48 INFO - 2015-12-09 06:21:48,148 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2646.232592548161, 2752.7522522972927, 2758.9034383796557, 2764.7373499517553, 2790.7348801863823, 4499.910001799962, 4626.8380606678775, 4661.790219440125, 4753.0969115867965, 4782.808687652489, 4591.609713174375, 4650.697704649196, 4722.50413706561, 4738.265568836827, 4746.050789842028, 4256.872293831175, 4300.957646754641, 4396.912061758779, 4397.230484665187, 4543.182227199103, 4449.866504004885, 4524.6380289576755, 4531.773411329436, 4542.227821270392, 4550.340200670901, 4201.978990105061, 4228.217779710763, 4292.7424354538825, 4305.741655500648, 4365.738055716667, 4403.933940990888, 4414.668899832525, 4437.711548749353, 4459.375687403766, 4470.664700147502, 4359.193549193409, 4378.365137055141, 4380.759058251795, 4383.736975781431, 4415.139047885664, 4425.247707889666, 4561.40701708779, 4567.0409214065085, 4754.310624959396, 4770.7376094314795, 5021.949780502185, 5070.366204224472, 5100.821471248526, 5103.642745007851, 5109.744512774347, 5085.79656813727, 5091.1090559152, 5095.821646242363, 5135.820246291362, 5145.202493613496, 4458.264386376277, 4581.289900065495, 4581.5647513486165, 4691.7654117294, 4710.905781884343, 5074.162763144113, 5152.92270615941, 5169.663971841818, 5195.584353251731, 5212.400573934046, 4949.356583644175, 5016.974915125401, 5038.521340472649, 5039.0, 5080.161773307437, 4884.8290309838985, 4997.90004199914, 5013.448520662724, 5106.897862042812, 5107.540321371094, 4967.5529202371235, 4968.751562421864, 5006.1739812930455, 5102.081625307406, 5124.128898087334, 4963.0, 5033.572146367526, 5081.8729531762, 5087.720175390389, 5139.691618502902, 4217.219814334358, 4241.660667146621, 4253.361995700608, 4256.106217694257, 4300.483941926988, 3514.4201206801104, 3581.8030008349792, 3610.0, 3615.6022837487853, 3680.5583330000036, 4313.892152696145, 4355.651547876226, 4356.499002614676, 4358.4769827620885, 4398.736075835396, 5131.97434012835, 5155.175171972466, 5156.664816786897, 5158.3552055993005, 5206.3752349717515, 4133.235351459929, 4224.767637779952, 4243.215005224043, 4246.235677578004, 4330.891727706832, 4437.5784300491405, 4470.24005918988, 4470.240059189946, 4478.328250762412, 4503.572160644733, 4794.993051459232, 4798.0, 4798.712077275374, 4805.447373552086, 4846.660733748604, 4859.902801943871, 4885.877853053702, 4978.925316120333, 4990.101781679187, 4992.400911890596, 4844.733539655353, 4881.194602890483, 4897.16748152822, 4906.067847109038, 4945.653804233669, 5089.669171503989, 5104.540591346797, 5107.540321371094, 5111.952049829851, 5157.432682405008, 4928.211486162197, 4998.1003419383405, 5054.115529782347, 5057.570106540985, 5096.413912400121, 4908.435529914105, 4919.139150648693, 4924.926126108039, 4929.211326187793, 4959.851204463872, 4919.852404427873, 4920.138975679313, 4923.08922849274, 4924.778384972613, 4928.482509336468, 4716.64625153108, 4725.243960966229, 4780.832670856643, 4847.030593881167, 4870.537298956593, 4990.476000019946, 5000.974995125001, 5006.249062640487, 5008.549230569266, 5025.974870125626, 4902.093112774148, 4915.115279249626, 4920.6801557898625, 4921.163402221559, 4962.230854217602], "unit": "ms", "name": "dojo.html", "value": 4643.1886293663465}, {"lowerIsBetter": false, "replicates": [526.160773566162, 529.9867503312414, 531.4207513809946, 532.0131156704315, 544.5507456348511, 27433.177004689867, 28100.718992810092, 28118.43763124736, 28120.15639530815, 28129.43741125176, 28380.432391352213, 37612.435813462755, 37988.24023519535, 38107.23785524288, 38166.0, 7920.960395198031, 8035.517868927854, 8040.035195776515, 8042.235987581171, 8045.919540804605, 7227.096612923385, 7445.181030086686, 7912.841743165133, 7991.520508769463, 8045.235702608272, 7208.711651533932, 7301.415886729049, 7301.415886729075, 10319.071283584475, 10575.576976920915, 9982.600695972153, 10067.446290454021, 10083.142932850717, 10087.445190514482, 10088.445135517544, 7241.131064272268, 9961.103500684902, 10107.848382274271, 10111.0, 10112.94943525285, 27337.45325093507, 40581.39127913084, 41681.1663766723, 41727.58272417298, 41729.1654166918, 2963.970360296391, 3004.8197108173363, 3032.408680307341, 3294.8846790362463, 3569.607343192247, 26529.0, 26719.198424047114, 26788.330291742666, 27024.864875675496, 27375.589366159522, 3213.3573285343023, 3297.3734990351754, 3331.1672081979505, 3347.1130150510135, 3385.4244778387488, 224487.0, 224651.0, 224736.99999999837, 225255.0, 225328.0, 57113.0, 57197.428025720044, 57306.713466432404, 57430.425695743346, 57453.81827271591, 62089.68955155195, 62365.0, 62398.68800656059, 62409.0, 62489.37510624927, 12987.740245195233, 13259.469621215043, 13287.73424531504, 13296.534621288209, 13320.600381988363, 10104.646337378303, 10138.391696498235, 10155.593776249016, 10159.034891685278, 10171.898281017095, 18709.064546772606, 19537.218511259674, 19704.31034913771, 19738.40784776459, 19767.60464790725, 7719.884201736979, 7916.960415198002, 7987.400944929153, 8040.477368970998, 8101.716439924574, 836.2557323981662, 855.9272461840688, 889.8487257166297, 918.4948278446827, 1012.9189664826796, 25133.371665708502, 25397.0, 25530.0, 25530.617040744404, 30647.846760766053, 861.7437404443783, 908.4549270437684, 932.421898422982, 991.7917237380086, 1072.646026811166, 13870.987050818987, 14669.926650366893, 14717.19055451939, 14827.0, 14836.480723174853, 314223.0, 318048.0, 319402.0, 319879.0, 319891.0, 48340.64934155943, 48964.26553601699, 49350.75324623354, 49400.50599493959, 49456.0, 1219.6523990662618, 1220.4324988880214, 1237.406045098358, 1265.0448911072265, 1266.8733126687441, 26168.0, 26949.86525067362, 27512.862435687694, 27524.311892202855, 29637.703622963494, 44559.33161002523, 45082.32376514289, 45105.774471128745, 45121.0, 45171.0965780676, 260255.0, 262010.75978480704, 262069.0, 262863.0, 263094.0, 35856.4621530672, 38981.8050909755, 39413.832239227115, 44392.33411498766, 44601.0, 38098.0, 38216.80891595635, 38483.80758096304, 39141.2171756569, 39264.6073539261, 32863.67136328606, 32877.0, 33585.32829343351, 33954.0, 34056.318873621894, 30977.845110775204, 33245.33509329848, 37475.81262093672, 38817.6118238814, 39246.0, 38255.80872095733, 38349.42475862808, 38553.22893542057, 38878.222435551696, 39247.60752392554, 29198.27004324909, 30086.69913300839, 30266.092017239516, 30468.390632187675, 30557.54163687502, 23849.761502384754, 23867.52264954726, 24226.0, 24242.393940151636, 25488.10791622284], "unit": "ms", "name": "ext.html", "value": 17498.192617272558}, {"lowerIsBetter": false, "replicates": [270.1557632398754, 270.6427515679302, 270.64680591827664, 273.3985232488524, 274.5223311438098, 10567.411559004579, 15189.316480758365, 15653.686926261482, 15678.294476748546, 16718.58203544912, 16276.023438593664, 16602.7509587356, 16613.83386166138, 17098.145092745373, 17124.14379281034, 5466.961277357299, 5599.580031497633, 5615.494605485505, 5617.241672374238, 5621.578381621374, 5585.832425027235, 5631.521320687746, 5640.661560306375, 5645.463680950324, 5652.321721393439, 4081.8163182656854, 4209.5790420957965, 4211.810468528924, 5496.697681627509, 5632.662040277596, 4182.6862985276075, 4200.348945913388, 4207.410962465242, 6211.378862113753, 6437.324080971524, 6032.487238584726, 6146.631202127886, 6162.84592885177, 6183.598066125687, 6189.535784816157, 19362.0, 19660.311889083958, 19822.405327840188, 20150.39548813538, 20669.793302066937, 2047.9590408191902, 2062.7215325930956, 2144.710464087344, 2155.1164022750754, 2635.1304069656967, 13320.134191277633, 13328.666783330398, 13368.732625347537, 13488.460461581524, 13629.182249065088, 1794.1657129434745, 1864.8787828791085, 1896.2225487550038, 1919.9808001919941, 1988.8408927285782, 60798.0, 60852.087218691755, 61441.0, 66082.0, 66262.66868665675, 14272.857271427152, 14741.262936853114, 14790.260486975823, 14798.408063677332, 14956.551303460914, 21584.78415215859, 21752.564948700936, 21782.128714851227, 21792.128314867547, 21812.89093554522, 7388.667509962064, 7423.072115985502, 7448.180700122982, 7618.733344332922, 7638.236176382317, 5932.2584676915385, 5987.850303742354, 5991.0, 6009.429104235091, 6128.387161283836, 7380.483366164317, 7429.33136017761, 7442.590657513889, 7445.36714379273, 7455.478116531791, 2310.97689023111, 2930.3846192299857, 2991.6110905582136, 3009.458297506426, 3067.125869127288, 535.9571234301246, 774.9147593764682, 853.9701110461104, 935.3405848876525, 961.3126614470548, 15255.847441525442, 15810.130442825755, 15968.76046859298, 16215.756763648555, 16220.35118595243, 871.7602659268625, 883.6686242659002, 889.3863234368265, 893.6202114101611, 916.9174774270215, 9023.864642030374, 9183.816323673624, 9321.44071355721, 9338.813223735488, 9455.621775128919, 405568.0, 485788.0, 493010.0, 493179.0, 500357.0, 71060.2893971064, 73875.0, 75132.0, 75617.62191189118, 76353.0, 1076.1552181537456, 1076.6016573867562, 1111.377628528027, 1111.4276147783899, 1114.1755101225035, 14593.958415064579, 14635.34140963638, 14769.483068092564, 14797.186154761592, 15148.545543633709, 33010.66989330076, 33289.66710332962, 33651.83174084114, 34222.31555368829, 34259.82870085733, 43151.568484314754, 43447.565524344354, 45144.0, 45538.77230613826, 46154.0, 8303.958480207802, 8435.409521333448, 8544.18830211129, 8553.87169192475, 8563.700270490503, 9989.400635961865, 10012.499375031073, 10034.598616055568, 12125.69685757863, 16959.23683434224, 13310.201387916755, 13404.128731632412, 14149.575512734635, 14170.07894486855, 14393.352299146773, 13395.598132056053, 13639.113457625223, 13795.862041379458, 14080.436782528584, 14191.077579957682, 14337.35481903296, 14390.280485975869, 14550.927245363706, 14572.125672459686, 14669.26653667291, 8469.61886715087, 8524.147585241426, 8528.530930798866, 8530.829383412422, 8754.73735787902, 12958.935205323913, 13184.208947463183, 13264.933675331562, 13351.3991870368, 14119.717605648035], "unit": "ms", "name": "jquery.html", "value": 8969.05801610569}, {"lowerIsBetter": false, "replicates": [1441.1281174889198, 1496.2219645784191, 1551.705176016557, 1609.1069456451664, 1685.7808484896962, 5907.379725128864, 6994.160700715915, 7116.822079448003, 7148.142222933242, 7151.570905745659, 6888.276730943254, 7093.04243927071, 7096.85806283874, 7104.36060754532, 7115.537490063142, 2025.291148098165, 2047.7747447780732, 2061.391889392633, 2062.5462398272357, 2066.917323307066, 1977.8912159831204, 2007.3275452723356, 2010.829079528242, 2025.8480613953939, 2028.9289874854383, 2001.7798042215345, 2038.3069756282862, 2051.8768873867616, 2056.475598722324, 2056.5681206946483, 1999.040460578923, 2015.7278767366365, 2019.5254115282896, 2021.8989050547486, 2023.6660950943076, 1987.3640435060786, 2007.1068374573322, 2014.909329080195, 2018.5155562664854, 2019.81821636052, 7241.493095483318, 7276.0, 7329.670164842595, 7346.77959661211, 7355.301246381585, 4176.791160441966, 4249.575042495757, 4249.617534421917, 4253.043065310311, 4267.381229721673, 2772.6534183227095, 2794.748472637452, 2807.3262417019973, 2828.6888442271334, 2872.2819295176205, 832.9916700832974, 834.7353759055037, 843.2789964580318, 870.5951732444444, 883.3154305413292, 9731.805363892683, 9762.707118786448, 9789.804203915883, 9800.705978820646, 9806.705798826046, 3770.962290377116, 3797.487339209227, 3838.846446142123, 3845.2693988142164, 3845.288621605012, 8403.117672644285, 8406.369522285731, 8406.831863362699, 8414.200650938152, 8421.410501264852, 4291.098869237433, 4323.913521729548, 4328.285832837547, 4328.5022222444195, 4339.913201735948, 3282.2450836307785, 3376.729861611065, 3732.122951106488, 3917.490726205575, 3934.291827471083, 3328.2012317043736, 3365.7139143172617, 3384.7292216623105, 3394.7963122212745, 3397.983010084983, 1023.6826583759058, 1033.266380869591, 1040.245821779204, 1041.0266400915168, 1042.4943902207424, 1139.715071232192, 1152.8040233160216, 1171.701216189866, 1204.8313236146946, 1208.6192849252457, 6844.041834143224, 6849.760258390932, 6860.279670634512, 6884.965575172092, 6892.0, 412.6265729514794, 413.96688264938734, 418.80316251361813, 418.85130778573165, 420.05278097889675, 5261.394939581921, 5323.0, 5348.411674715778, 5354.223637572531, 5362.731863406892, 8483.490990540464, 8640.179182977607, 8691.869621955675, 8698.391112622183, 8700.260477859452, 8455.365847561457, 8602.827943441096, 8639.222469977733, 8699.565021749015, 8737.126287371339, 6804.455643548505, 6823.351781580742, 6842.110525631736, 6864.039034535169, 6870.484713646497, 6516.51126165549, 6619.238787539494, 6823.93176068233, 6847.349501797321, 6849.657517124024, 7613.08642962848, 7654.846903062019, 7908.06252468149, 7950.801229969297, 7973.122956474899, 7892.447528672938, 8012.599370031592, 8073.071596766447, 8143.633536490991, 8150.347972162094, 5238.816641417532, 5342.732863356894, 6212.254529456494, 6274.435300822948, 6305.1172835803945, 6413.198350206224, 6545.967270163619, 6563.04835798816, 6579.309172536815, 6584.8353791155605, 5997.790077347272, 6500.869982600227, 6546.934530654633, 6615.17310336208, 6621.768238111643, 6409.519286053658, 6418.101465794886, 6442.806715798533, 6533.314002029909, 6564.540482166202, 6502.479801615765, 6532.248791389051, 6543.378379053982, 6544.3782840630065, 6547.279799221987, 5691.77232910679, 5977.9103313451205, 5986.281646202309, 5992.490638295793, 6018.0, 6112.510999119971, 6171.9691401542705, 6180.536459765445, 6192.566520343713, 6203.875922481616], "unit": "ms", "name": "mootools.html", "value": 4005.4812041641903}, {"lowerIsBetter": false, "replicates": [251.13484047456515, 254.90058877037947, 255.9091522509509, 258.52173479063737, 258.7063682720112, 5234.947650523493, 5298.549623282021, 5329.173978033401, 5336.706481143545, 5359.919601205985, 4964.975175124128, 4998.5501304882555, 5036.068327359441, 5225.059489291926, 5266.81566145185, 3983.2630963271745, 3996.920061598766, 3999.9400008999887, 4000.979995100035, 4002.4396584478195, 3936.862209822657, 3968.444417781513, 3975.9006024849464, 3984.442178095069, 3985.501812273466, 3748.119191989894, 3850.8267127979307, 3858.4405261237102, 3926.764394136361, 3934.4295077213787, 3963.881083567483, 3975.1056012397266, 3975.5030621172355, 3976.661983731372, 3988.0827409695644, 3432.090496018557, 3433.4506478963494, 3435.811030393327, 3437.2781715839706, 3442.5008373785663, 5064.594832413398, 5066.9746651266505, 5067.138586440277, 5071.644984851062, 5072.2391641253735, 4544.590986811203, 4552.385427967215, 4552.977235113836, 4555.703879247838, 4558.908821823545, 5500.202470641734, 5504.339479262474, 5506.587005974568, 5507.421720719307, 5517.972410137963, 3739.139997800494, 3739.2334571412794, 3740.663340299359, 3741.1769410729594, 3746.925061498782, 5773.3072031356505, 5821.67980761058, 5823.883522329572, 5824.767009319665, 5825.970870145665, 3614.945775813365, 3685.2076803486843, 3718.1262403335736, 3843.423486477051, 3848.1726428817938, 3746.213295208037, 3826.1582451860545, 3827.215420838777, 3828.7319887608155, 3859.9421008684894, 4462.955370446319, 4465.642748580106, 4473.083017981306, 4484.977575112169, 4492.707973981681, 5508.14623733322, 5510.366307874566, 5511.118221084607, 5513.558915286768, 5515.806946756925, 1345.9865401346058, 1370.0, 1371.5405339211477, 1371.9984411379749, 1372.540199033315, 886.7162507997378, 919.7424721078108, 922.8154369126202, 930.292977337215, 935.8736570563022, 4808.663393562487, 4811.735354555533, 4817.927731084036, 4818.156822556039, 4821.445533763662, 5743.282089738783, 5751.079827227623, 5751.8562035949435, 5752.9712351437975, 5754.913676294859, 4804.159272127364, 4814.374131362971, 4817.1810792164715, 4818.7831547580445, 4822.397200349957, 3005.819650820914, 3063.678313777066, 3081.1372815611217, 3085.2903832118736, 3096.9845150774104, 5419.918701219485, 5420.972895135499, 5420.972895135499, 5425.376081750649, 5432.2123292123215, 5891.23413956183, 5903.586748927534, 5906.995810712189, 5909.409059094056, 5909.911351329733, 5409.43200963901, 5414.269073675082, 5418.485243901823, 5421.5391691706645, 5422.810201642924, 5570.749316280696, 5707.400722924199, 5720.942790572041, 5724.885502289848, 5735.684537350486, 5613.578981576316, 5617.775288988395, 5620.578456615852, 5621.831345059655, 5626.0, 5413.7834486620095, 5416.4041955385665, 5418.783248670009, 5422.783088676567, 5425.294711687456, 3767.340715374853, 3821.3694740367528, 3839.251345987506, 3842.7886466244627, 3844.8077596120643, 5527.640703354269, 5680.71596420169, 5704.260200638845, 5725.51333136688, 5815.389384114607, 5567.721613919207, 5579.330480342385, 5581.6930068846605, 5590.608657393944, 5593.720313984203, 5533.059379905345, 5534.833954981357, 5542.861428464321, 5545.140503222007, 5545.7781688732, 5350.866228344167, 5435.619506634655, 5454.10007348783, 5465.836024919259, 5474.479924407175, 5599.860003499945, 5604.243427137448, 5616.66300022, 5622.690752008679, 5623.2127502148915, 5471.124620060771, 5484.149956756709, 5484.341878974548, 5488.368837583729, 5496.258005169251], "unit": "ms", "name": "prototype.html", "value": 4082.7976648505414}, {"lowerIsBetter": false, "replicates": [665.7370338716204, 671.3622059043906, 698.5250029979615, 714.3249629100499, 738.6860584251693, 12159.148859579833, 12502.687432814184, 12523.561675341341, 12531.561395351164, 12538.310392928386, 13243.536476223335, 13255.867441325583, 13359.666008349795, 13431.529896453627, 13457.865421345783, 631.7346714379948, 794.1938931984026, 807.5800583696474, 807.7092246791179, 807.8020884883211, 640.123031446916, 791.4459878085335, 805.0661232969757, 806.4475834053692, 806.9798255043612, 833.6248688090384, 845.2055068235838, 847.0301504777027, 847.631280393028, 847.7329641163045, 662.9303923088079, 671.4259308291438, 818.9181081891822, 841.7054031089131, 842.4313588327885, 619.7737825693634, 620.110141946304, 620.6803496199461, 620.9782657607008, 621.6208113051035, 12515.123941324111, 12663.366831658472, 12673.809892851523, 12677.302748348837, 12682.175658582162, 10700.51847666849, 11226.719332016683, 11246.55013799447, 11360.147988900782, 11377.146713996483, 9495.952520237355, 9580.377275477142, 9617.855732164024, 9658.75853103671, 9732.75668108296, 3178.666240044808, 3227.8708851645906, 3248.3016151527536, 3249.220187155089, 3254.349130173951, 40354.79822600868, 41314.1737165258, 41428.79285603583, 41495.1700965982, 41523.584764152576, 8429.536375499283, 8446.66213351459, 8461.534615596078, 8521.957390213009, 8574.314054875595, 15682.607934801721, 15740.763888541682, 15769.526914192593, 15798.0, 15802.762958555631, 6217.626942383471, 6363.936360636334, 6384.648844313608, 6483.902741458882, 6549.869002619921, 3345.2974875275977, 3604.5133906922756, 3615.8553657853918, 3620.0, 3641.3299893223098, 2646.325187077283, 2679.0623281851585, 2679.3569543309463, 2688.2876037849987, 2689.1394753678637, 464.1204916682867, 473.59034435213295, 475.59811958894676, 477.40801406256685, 482.09366391184346, 496.8832324403762, 538.6875612144946, 583.6439771739235, 585.8213244960328, 587.2571197435248, 7547.924520754722, 8643.524606146597, 8796.428232165017, 8940.597673104596, 9017.458952462874, 613.4233820209079, 624.8000639795313, 628.133235579688, 628.745358129958, 638.8754192932427, 3650.6714395703984, 3872.6127387261613, 3904.570497245301, 3942.3692209246956, 4068.0, 44054.55945440569, 44097.338539921926, 44412.55587444149, 46981.06037879223, 47749.283760743616, 43423.78288108602, 43611.34582981258, 43651.34522982158, 43771.78114109409, 44003.0, 38326.2334753309, 39842.80078599588, 39885.20803543782, 39908.20183596312, 40523.59476405198, 8023.273770679734, 8037.156098609562, 8193.67225310981, 8249.340052795882, 8294.709685160991, 30174.0, 30431.0, 30516.0, 31242.531362030044, 31515.52726709147, 35943.0, 38010.61989380181, 38115.0, 38604.80697596494, 39266.80366598149, 10135.391876487434, 10200.744981375525, 10392.297286544268, 10447.477626118816, 10478.214133939833, 11255.606053788078, 11310.547578096784, 11383.03244224217, 11598.652040438801, 11599.246049006788, 10616.203784716023, 11150.665480035612, 11161.609343672932, 11301.378424186749, 11634.534618615498, 10216.795664086825, 10582.100521455455, 10642.201834862572, 10787.137029037502, 10901.727456813644, 10556.630517932143, 10632.468376581295, 10730.907736247362, 10990.395528246023, 10994.230403871652, 8883.480377243657, 9084.772880678036, 9271.490068046322, 9468.431894086378, 9538.14156725898, 8304.501729895985, 9172.44965302084, 9232.907670923205, 9245.907540924774, 9264.351495395258], "unit": "ms", "name": "yui.html", "value": 5746.452040723115}], "name": "dromaeo_css", "value": 6396.411687338273}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 116.0, 109.0, 114.0, 114.0, 114.0, 104.0, 113.0, 115.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 153.0, 163.0, 138.0, 165.0, 151.0, 138.0, 173.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 159.0, 162.0, 161.0, 163.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 83.0, 91.0, 72.0, 72.0, 71.0, 100.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 126.0, 94.0, 95.0, 95.0, 128.0, 94.0, 95.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 73.0, 74.0, 76.0, 73.0, 74.0, 80.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 85.0, 87.0, 84.0, 84.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [130.0, 123.0, 125.0, 119.0, 118.0, 121.0, 120.0, 124.0, 126.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 150.0, 148.0, 151.0, 135.0, 150.0, 146.0, 150.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 68.0, 70.0, 70.0, 69.0, 69.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1523.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.9261125104954], "unit": "score", "name": "Richards", "value": 210.22340999999997}, {"lowerIsBetter": false, "replicates": [185.6665428889714], "unit": "score", "name": "DeltaBlue", "value": 356.111548}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2059.670781893004], "unit": "score", "name": "RayTrace", "value": 359.27537862137854}, {"lowerIsBetter": false, "replicates": [793.1854199683042], "unit": "score", "name": "Earley", "value": 840.23606993007}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [27486.486486486487], "unit": "score", "name": "RegExp", "value": 33.14301376597835}, {"lowerIsBetter": false, "replicates": [600.1199040767386], "unit": "score", "name": "Splay", "value": 135.7911968031968}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19705.60089150548}]} 06:21:48 INFO - RETURN: dromaeo_css: 6396.41 06:21:48 INFO - RETURN: kraken: 1523.70 06:21:48 INFO - RETURN: v8_7: 19705.60 06:21:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19705.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6396.41"}}} 06:21:48 INFO - Return code: 0 06:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:48 INFO - # TBPL SUCCESS # 06:21:48 INFO - Running post-action listener: _resource_record_post_action 06:21:48 INFO - Running post-run listener: _resource_record_post_run 06:21:49 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 266240; Write bytes: 506527744; Read time: 92; Write time: 619936 06:21:49 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231321600; Read time: 0; Write time: 405960 06:21:49 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 266240; Write bytes: 274341888; Read time: 92; Write time: 213916 06:21:49 INFO - Running post-run listener: _upload_blobber_files 06:21:49 INFO - Blob upload gear active. 06:21:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:21:49 INFO - Copying logs to upload dir... 06:21:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.684743 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-09 06:21:49.111683) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:49.114880) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010047 build_url: 'https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:49.169319) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:49.170028) ========= 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=6e558709db315bacd2260379000001b6-1449668376.853983-1651266090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:49.223279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 06:21:49.224025) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 06:21:49.224713) ========= ========= Total master_lag: 0.31 =========