builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1465019897.93 results: success (0) buildid: 20160603203027 builduid: ef5926aa5cc042ab8d1a21c7ff36de3b revision: 67c37ed1a25f92cac6294cb70af97e95515c30e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:17.934000) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:17.934507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:17.934832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.076288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.076609) ========= 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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 22:58:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.8M=0s 2016-06-03 22:58:18 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178543 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.310216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.310570) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.132233 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.455475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:18.455892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 67c37ed1a25f92cac6294cb70af97e95515c30e2 --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 67c37ed1a25f92cac6294cb70af97e95515c30e2 --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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 22:58:18,485 truncating revision to first 12 chars 2016-06-03 22:58:18,485 Setting DEBUG logging. 2016-06-03 22:58:18,485 attempt 1/10 2016-06-03 22:58:18,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/67c37ed1a25f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 22:58:18,784 unpacking tar archive at: fx-team-67c37ed1a25f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653159 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:19.122773) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:19.123136) ========= script_repo_revision: 67c37ed1a25f92cac6294cb70af97e95515c30e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:19.123617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:19.123930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 22:58:19.132612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-03 22:58:19.132930) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:19 INFO - MultiFileLogger online at 20160603 22:58:19 in /builds/slave/test 22:58:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:58:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:58:19 INFO - {'append_to_log': False, 22:58:19 INFO - 'base_work_dir': '/builds/slave/test', 22:58:19 INFO - 'blob_upload_branch': 'Fx-Team', 22:58:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:58:19 INFO - 'branch': 'Fx-Team', 22:58:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:19 INFO - 'config_files': ('talos/linux_config.py',), 22:58:19 INFO - 'default_actions': ('clobber', 22:58:19 INFO - 'read-buildbot-config', 22:58:19 INFO - 'download-and-extract', 22:58:19 INFO - 'populate-webroot', 22:58:19 INFO - 'create-virtualenv', 22:58:19 INFO - 'install', 22:58:19 INFO - 'run-tests'), 22:58:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:19 INFO - 'download_minidump_stackwalk': True, 22:58:19 INFO - 'download_symbols': 'ondemand', 22:58:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:19 INFO - 'installer_path': 'installer.exe', 22:58:19 INFO - 'log_level': 'info', 22:58:19 INFO - 'log_name': 'talos', 22:58:19 INFO - 'log_to_console': True, 22:58:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:19 INFO - 'opt_config_files': (), 22:58:19 INFO - 'pip_index': False, 22:58:19 INFO - 'sps_profile': False, 22:58:19 INFO - 'sps_profile_interval': 0, 22:58:19 INFO - 'suite': 'dromaeojs-e10s', 22:58:19 INFO - 'system_bits': '32', 22:58:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:19 INFO - 'title': 'talos-linux64-ix-003', 22:58:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:19 INFO - 'use_talos_json': True, 22:58:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:58:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:19 INFO - 'work_dir': 'build'} 22:58:19 INFO - ##### 22:58:19 INFO - ##### Running clobber step. 22:58:19 INFO - ##### 22:58:19 INFO - Running pre-action listener: _resource_record_pre_action 22:58:19 INFO - Running main action method: clobber 22:58:19 INFO - rmtree: /builds/slave/test/build 22:58:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:58:20 INFO - Running post-action listener: _resource_record_post_action 22:58:20 INFO - ##### 22:58:20 INFO - ##### Finished clobber step (success) 22:58:20 INFO - ##### 22:58:20 INFO - ##### 22:58:20 INFO - ##### Running read-buildbot-config step. 22:58:20 INFO - ##### 22:58:20 INFO - Running pre-action listener: _resource_record_pre_action 22:58:20 INFO - Running main action method: read_buildbot_config 22:58:20 INFO - Using buildbot properties: 22:58:20 INFO - { 22:58:20 INFO - "project": "", 22:58:20 INFO - "product": "firefox", 22:58:20 INFO - "script_repo_revision": "production", 22:58:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:58:20 INFO - "repository": "", 22:58:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:58:20 INFO - "buildid": "20160603203027", 22:58:20 INFO - "pgo_build": "True", 22:58:20 INFO - "basedir": "/builds/slave/test", 22:58:20 INFO - "buildnumber": 417, 22:58:20 INFO - "slavename": "talos-linux64-ix-003", 22:58:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:58:20 INFO - "platform": "ubuntu64_hw", 22:58:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:20 INFO - "branch": "fx-team", 22:58:20 INFO - "repo_path": "integration/fx-team", 22:58:20 INFO - "revision": "67c37ed1a25f92cac6294cb70af97e95515c30e2", 22:58:20 INFO - "stage_platform": "linux64-pgo", 22:58:20 INFO - "builduid": "ef5926aa5cc042ab8d1a21c7ff36de3b", 22:58:20 INFO - "slavebuilddir": "test" 22:58:20 INFO - } 22:58:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:58:20 INFO - Running post-action listener: _resource_record_post_action 22:58:20 INFO - ##### 22:58:20 INFO - ##### Finished read-buildbot-config step (success) 22:58:20 INFO - ##### 22:58:20 INFO - ##### 22:58:20 INFO - ##### Running download-and-extract step. 22:58:20 INFO - ##### 22:58:20 INFO - Running pre-action listener: _resource_record_pre_action 22:58:20 INFO - Running main action method: download_and_extract 22:58:20 INFO - mkdir: /builds/slave/test/build/tests 22:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:20 INFO - https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:58:30 INFO - Downloaded 1361 bytes. 22:58:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:58:30 INFO - Using the following test package requirements: 22:58:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:58:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'jsshell-linux-x86_64.zip'], 22:58:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:30 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')]} 22:58:30 INFO - https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:46 INFO - Downloaded 24440958 bytes. 22:58:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:58:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:58:47 INFO - Return code: 0 22:58:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:58: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')]} 22:58:47 INFO - https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:48 INFO - Downloaded 24440958 bytes. 22:58:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:58:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:58:50 INFO - Return code: 0 22:58:50 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')]} 22:58:50 INFO - https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:58:51 INFO - Downloaded 10833369 bytes. 22:58:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:58:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:58:51 INFO - Return code: 0 22:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:51 INFO - https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:58:53 INFO - Downloaded 59170076 bytes. 22:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:58:53 INFO - mkdir: /builds/slave/test/properties 22:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 22:58:53 INFO - Contents: 22:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:58:54 INFO - Running post-action listener: _resource_record_post_action 22:58:54 INFO - Running post-action listener: set_extra_try_arguments 22:58:54 INFO - ##### 22:58:54 INFO - ##### Finished download-and-extract step (success) 22:58:54 INFO - ##### 22:58:54 INFO - ##### 22:58:54 INFO - ##### Running populate-webroot step. 22:58:54 INFO - ##### 22:58:54 INFO - Running pre-action listener: _resource_record_pre_action 22:58:54 INFO - Running main action method: populate_webroot 22:58:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:54 INFO - '--tppagecycles', 22:58:54 INFO - '7'], 22:58:54 INFO - 'tests': ['tsvgm']}}, 22:58:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:58:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:58:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:58:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['damp', 'tps']}, 22:58:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'tests': ['damp', 'tps']}, 22:58:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['dromaeo_dom']}, 22:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'other-e10s': {'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['a11yr', 22:58:54 INFO - 'ts_paint', 22:58:54 INFO - 'tpaint', 22:58:54 INFO - 'sessionrestore', 22:58:54 INFO - 'sessionrestore_no_auto_restore', 22:58:54 INFO - 'tabpaint']}, 22:58:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['tsvgx', 22:58:54 INFO - 'tsvgr_opacity', 22:58:54 INFO - 'tart', 22:58:54 INFO - 'tscrollx', 22:58:54 INFO - 'cart']}, 22:58:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:58:54 INFO - 'tsvgr_opacity', 22:58:54 INFO - 'tart', 22:58:54 INFO - 'tscrollx', 22:58:54 INFO - 'cart']}, 22:58:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'talos_options': ['--disable-e10s'], 22:58:54 INFO - 'tests': ['tp5o']}, 22:58:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'tests': ['tp5o']}, 22:58:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'talos_options': ['--disable-e10s', 22:58:54 INFO - '--xperf_path', 22:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:54 INFO - 'tests': ['tp5n']}, 22:58:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:54 INFO - 'talos_options': ['--xperf_path', 22:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:54 INFO - 'tests': ['tp5n']}}, 22:58:54 INFO - 'talos.zip': {'path': '', 22:58:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:54 INFO - Running post-action listener: _resource_record_post_action 22:58:54 INFO - ##### 22:58:54 INFO - ##### Finished populate-webroot step (success) 22:58:54 INFO - ##### 22:58:54 INFO - ##### 22:58:54 INFO - ##### Running create-virtualenv step. 22:58:54 INFO - ##### 22:58:54 INFO - Running pre-action listener: _resource_record_pre_action 22:58:54 INFO - Running main action method: create_virtualenv 22:58:54 INFO - Creating virtualenv /builds/slave/test/build/venv 22:58:54 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 22:58:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:54 INFO - Using real prefix '/usr' 22:58:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:58:55 INFO - Installing distribute.............................................................................................................................................................................................done. 22:58:57 INFO - Installing pip.................done. 22:58:57 INFO - Return code: 0 22:58:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:58:57 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')]} 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 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')]} 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:58:57 INFO - Using env: {'DISPLAY': ':0', 22:58:57 INFO - 'HOME': '/home/cltbld', 22:58:57 INFO - 'LANG': 'en_US.UTF-8', 22:58:57 INFO - 'LANGUAGE': 'en_US:en', 22:58:57 INFO - 'LOGNAME': 'cltbld', 22:58:57 INFO - 'MAIL': '/var/mail/cltbld', 22:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:57 INFO - 'MOZ_NO_REMOTE': '1', 22:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:57 INFO - 'NO_EM_RESTART': '1', 22:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:57 INFO - 'PWD': '/builds/slave/test', 22:58:57 INFO - 'SHELL': '/bin/bash', 22:58:57 INFO - 'SHLVL': '1', 22:58:57 INFO - 'TERM': 'linux', 22:58:57 INFO - 'TMOUT': '86400', 22:58:57 INFO - 'USER': 'cltbld', 22:58:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:57 INFO - '_': '/tools/buildbot/bin/python'} 22:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:57 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 22:58:57 INFO - Cleaning up... 22:58:57 INFO - Return code: 0 22:58:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:58:57 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')]} 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 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')]} 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 22:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 22:58:57 INFO - Using env: {'DISPLAY': ':0', 22:58:57 INFO - 'HOME': '/home/cltbld', 22:58:57 INFO - 'LANG': 'en_US.UTF-8', 22:58:57 INFO - 'LANGUAGE': 'en_US:en', 22:58:57 INFO - 'LOGNAME': 'cltbld', 22:58:57 INFO - 'MAIL': '/var/mail/cltbld', 22:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:57 INFO - 'MOZ_NO_REMOTE': '1', 22:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:57 INFO - 'NO_EM_RESTART': '1', 22:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:57 INFO - 'PWD': '/builds/slave/test', 22:58:57 INFO - 'SHELL': '/bin/bash', 22:58:57 INFO - 'SHLVL': '1', 22:58:57 INFO - 'TERM': 'linux', 22:58:57 INFO - 'TMOUT': '86400', 22:58:57 INFO - 'USER': 'cltbld', 22:58:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:57 INFO - '_': '/tools/buildbot/bin/python'} 22:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:58 INFO - Downloading/unpacking psutil>=3.1.1 22:58: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 22:58: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 22:58: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 22:58: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 22:58: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 22:58: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 22:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:00 INFO - Installing collected packages: psutil 22:59:00 INFO - Running setup.py install for psutil 22:59:00 INFO - building 'psutil._psutil_linux' extension 22:59:00 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 22:59:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:59:02 INFO - building 'psutil._psutil_posix' extension 22:59:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:59:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:02 INFO - Successfully installed psutil 22:59:02 INFO - Cleaning up... 22:59:03 INFO - Return code: 0 22:59:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 22:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 22:59:03 INFO - Using env: {'DISPLAY': ':0', 22:59:03 INFO - 'HOME': '/home/cltbld', 22:59:03 INFO - 'LANG': 'en_US.UTF-8', 22:59:03 INFO - 'LANGUAGE': 'en_US:en', 22:59:03 INFO - 'LOGNAME': 'cltbld', 22:59:03 INFO - 'MAIL': '/var/mail/cltbld', 22:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:03 INFO - 'MOZ_NO_REMOTE': '1', 22:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:03 INFO - 'NO_EM_RESTART': '1', 22:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:03 INFO - 'PWD': '/builds/slave/test', 22:59:03 INFO - 'SHELL': '/bin/bash', 22:59:03 INFO - 'SHLVL': '1', 22:59:03 INFO - 'TERM': 'linux', 22:59:03 INFO - 'TMOUT': '86400', 22:59:03 INFO - 'USER': 'cltbld', 22:59:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:03 INFO - '_': '/tools/buildbot/bin/python'} 22:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:59:05 INFO - Installing collected packages: mozsystemmonitor 22:59:05 INFO - Running setup.py install for mozsystemmonitor 22:59:05 INFO - Successfully installed mozsystemmonitor 22:59:05 INFO - Cleaning up... 22:59:05 INFO - Return code: 0 22:59:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 22:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 22:59:05 INFO - Using env: {'DISPLAY': ':0', 22:59:05 INFO - 'HOME': '/home/cltbld', 22:59:05 INFO - 'LANG': 'en_US.UTF-8', 22:59:05 INFO - 'LANGUAGE': 'en_US:en', 22:59:05 INFO - 'LOGNAME': 'cltbld', 22:59:05 INFO - 'MAIL': '/var/mail/cltbld', 22:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:05 INFO - 'MOZ_NO_REMOTE': '1', 22:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:05 INFO - 'NO_EM_RESTART': '1', 22:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:05 INFO - 'PWD': '/builds/slave/test', 22:59:05 INFO - 'SHELL': '/bin/bash', 22:59:05 INFO - 'SHLVL': '1', 22:59:05 INFO - 'TERM': 'linux', 22:59:05 INFO - 'TMOUT': '86400', 22:59:05 INFO - 'USER': 'cltbld', 22:59:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:05 INFO - '_': '/tools/buildbot/bin/python'} 22:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:05 INFO - Downloading/unpacking jsonschema==2.5.1 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:07 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:07 INFO - warning: no files found matching '*.txt' 22:59:07 INFO - no previously-included directories found matching 'build' 22:59:07 INFO - no previously-included directories found matching 'dist' 22:59:07 INFO - no previously-included directories found matching '.git*' 22:59:07 INFO - Installing collected packages: jsonschema, functools32 22:59:07 INFO - Running setup.py install for functools32 22:59:07 INFO - warning: no files found matching '*.txt' 22:59:07 INFO - no previously-included directories found matching 'build' 22:59:07 INFO - no previously-included directories found matching 'dist' 22:59:07 INFO - no previously-included directories found matching '.git*' 22:59:07 INFO - Successfully installed jsonschema functools32 22:59:07 INFO - Cleaning up... 22:59:07 INFO - Return code: 0 22:59:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:59:07 INFO - Using env: {'DISPLAY': ':0', 22:59:07 INFO - 'HOME': '/home/cltbld', 22:59:07 INFO - 'LANG': 'en_US.UTF-8', 22:59:07 INFO - 'LANGUAGE': 'en_US:en', 22:59:07 INFO - 'LOGNAME': 'cltbld', 22:59:07 INFO - 'MAIL': '/var/mail/cltbld', 22:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:07 INFO - 'MOZ_NO_REMOTE': '1', 22:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:07 INFO - 'NO_EM_RESTART': '1', 22:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:07 INFO - 'PWD': '/builds/slave/test', 22:59:07 INFO - 'SHELL': '/bin/bash', 22:59:07 INFO - 'SHLVL': '1', 22:59:07 INFO - 'TERM': 'linux', 22:59:07 INFO - 'TMOUT': '86400', 22:59:07 INFO - 'USER': 'cltbld', 22:59:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:07 INFO - '_': '/tools/buildbot/bin/python'} 22:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:08 INFO - Downloading/unpacking blobuploader==1.2.4 22:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:09 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:59:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - Downloading docopt-0.6.1.tar.gz 22:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:10 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:10 INFO - Running setup.py install for blobuploader 22:59:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:59:10 INFO - Running setup.py install for requests 22:59:11 INFO - Running setup.py install for docopt 22:59:11 INFO - Successfully installed blobuploader requests docopt 22:59:11 INFO - Cleaning up... 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 22:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:11 INFO - Running setup.py (path:/tmp/pip-m1SPj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:11 INFO - Running setup.py (path:/tmp/pip-xWNY9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:11 INFO - Running setup.py (path:/tmp/pip-BNbNIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:11 INFO - Running setup.py (path:/tmp/pip-9wz9Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:11 INFO - Running setup.py (path:/tmp/pip-FwMov8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:11 INFO - Running setup.py (path:/tmp/pip-wEruXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:11 INFO - Running setup.py (path:/tmp/pip-Ix1b2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:12 INFO - Running setup.py (path:/tmp/pip-QJNnTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:12 INFO - Running setup.py (path:/tmp/pip-JJDXRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:12 INFO - Running setup.py (path:/tmp/pip-Z4ZtiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:12 INFO - Running setup.py (path:/tmp/pip-KvTGhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:12 INFO - Running setup.py (path:/tmp/pip-wUZcok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:12 INFO - Running setup.py (path:/tmp/pip-CupsIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:12 INFO - Running setup.py (path:/tmp/pip-aAEkAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:12 INFO - Running setup.py (path:/tmp/pip-DhjAO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:12 INFO - Running setup.py (path:/tmp/pip-AmtTBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:12 INFO - Running setup.py (path:/tmp/pip-q3y_xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:12 INFO - Running setup.py install for manifestparser 22:59:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:59:12 INFO - Running setup.py install for mozcrash 22:59:12 INFO - Running setup.py install for mozdebug 22:59:13 INFO - Running setup.py install for mozdevice 22:59:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozfile 22:59:13 INFO - Running setup.py install for mozhttpd 22:59:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozinfo 22:59:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozInstall 22:59:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozleak 22:59:13 INFO - Running setup.py install for mozlog 22:59:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for moznetwork 22:59:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozprocess 22:59:14 INFO - Running setup.py install for mozprofile 22:59:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozrunner 22:59:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozscreenshot 22:59:14 INFO - Running setup.py install for moztest 22:59:14 INFO - Running setup.py install for mozversion 22:59:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:14 INFO - Cleaning up... 22:59:14 INFO - Return code: 0 22:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:59:14 INFO - Using env: {'DISPLAY': ':0', 22:59:14 INFO - 'HOME': '/home/cltbld', 22:59:14 INFO - 'LANG': 'en_US.UTF-8', 22:59:14 INFO - 'LANGUAGE': 'en_US:en', 22:59:14 INFO - 'LOGNAME': 'cltbld', 22:59:14 INFO - 'MAIL': '/var/mail/cltbld', 22:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:14 INFO - 'MOZ_NO_REMOTE': '1', 22:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:14 INFO - 'NO_EM_RESTART': '1', 22:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:14 INFO - 'PWD': '/builds/slave/test', 22:59:14 INFO - 'SHELL': '/bin/bash', 22:59:14 INFO - 'SHLVL': '1', 22:59:14 INFO - 'TERM': 'linux', 22:59:14 INFO - 'TMOUT': '86400', 22:59:14 INFO - 'USER': 'cltbld', 22:59:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:14 INFO - '_': '/tools/buildbot/bin/python'} 22:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:14 INFO - Running setup.py (path:/tmp/pip-EEK9hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:14 INFO - Running setup.py (path:/tmp/pip-Kku2gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:14 INFO - Running setup.py (path:/tmp/pip-OGHrTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:14 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)) 22:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:15 INFO - Running setup.py (path:/tmp/pip-kfYpnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:15 INFO - Running setup.py (path:/tmp/pip-cqFkjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:15 INFO - Running setup.py (path:/tmp/pip-Gc3KUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:15 INFO - Running setup.py (path:/tmp/pip-MVOndB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:15 INFO - Running setup.py (path:/tmp/pip-GSxU3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:15 INFO - Running setup.py (path:/tmp/pip-Ys0Sfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:15 INFO - Running setup.py (path:/tmp/pip-mjumT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:15 INFO - Running setup.py (path:/tmp/pip-I4HI88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:15 INFO - Running setup.py (path:/tmp/pip-YPcCpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:15 INFO - Running setup.py (path:/tmp/pip-FmkaPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:15 INFO - Running setup.py (path:/tmp/pip-K5P_3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:15 INFO - Running setup.py (path:/tmp/pip-6ZhuEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:15 INFO - Running setup.py (path:/tmp/pip-veFvKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:15 INFO - Running setup.py (path:/tmp/pip-1ir5kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:17 INFO - Downloading blessings-1.6.tar.gz 22:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:17 INFO - Installing collected packages: blessings 22:59:17 INFO - Running setup.py install for blessings 22:59:18 INFO - Successfully installed blessings 22:59:18 INFO - Cleaning up... 22:59:18 INFO - Return code: 0 22:59:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:18 INFO - Reading from file tmpfile_stdout 22:59:18 INFO - Current package versions: 22:59:18 INFO - argparse == 1.2.1 22:59:18 INFO - blessings == 1.6 22:59:18 INFO - blobuploader == 1.2.4 22:59:18 INFO - docopt == 0.6.1 22:59:18 INFO - functools32 == 3.2.3-2 22:59:18 INFO - jsonschema == 2.5.1 22:59:18 INFO - manifestparser == 1.1 22:59:18 INFO - mozInstall == 1.12 22:59:18 INFO - mozcrash == 0.17 22:59:18 INFO - mozdebug == 0.1 22:59:18 INFO - mozdevice == 0.48 22:59:18 INFO - mozfile == 1.2 22:59:18 INFO - mozhttpd == 0.7 22:59:18 INFO - mozinfo == 0.9 22:59:18 INFO - mozleak == 0.1 22:59:18 INFO - mozlog == 3.2 22:59:18 INFO - moznetwork == 0.27 22:59:18 INFO - mozprocess == 0.22 22:59:18 INFO - mozprofile == 0.28 22:59:18 INFO - mozrunner == 6.11 22:59:18 INFO - mozscreenshot == 0.1 22:59:18 INFO - mozsystemmonitor == 0.3 22:59:18 INFO - moztest == 0.7 22:59:18 INFO - mozversion == 1.4 22:59:18 INFO - psutil == 3.1.1 22:59:18 INFO - requests == 1.2.3 22:59:18 INFO - wsgiref == 0.1.2 22:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:59:18 INFO - Using env: {'DISPLAY': ':0', 22:59:18 INFO - 'HOME': '/home/cltbld', 22:59:18 INFO - 'LANG': 'en_US.UTF-8', 22:59:18 INFO - 'LANGUAGE': 'en_US:en', 22:59:18 INFO - 'LOGNAME': 'cltbld', 22:59:18 INFO - 'MAIL': '/var/mail/cltbld', 22:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:18 INFO - 'MOZ_NO_REMOTE': '1', 22:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:18 INFO - 'NO_EM_RESTART': '1', 22:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:18 INFO - 'PWD': '/builds/slave/test', 22:59:18 INFO - 'SHELL': '/bin/bash', 22:59:18 INFO - 'SHLVL': '1', 22:59:18 INFO - 'TERM': 'linux', 22:59:18 INFO - 'TMOUT': '86400', 22:59:18 INFO - 'USER': 'cltbld', 22:59:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:18 INFO - '_': '/tools/buildbot/bin/python'} 22:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:59:18 INFO - Cleaning up... 22:59:18 INFO - Return code: 0 22:59:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:59:18 INFO - Using env: {'DISPLAY': ':0', 22:59:18 INFO - 'HOME': '/home/cltbld', 22:59:18 INFO - 'LANG': 'en_US.UTF-8', 22:59:18 INFO - 'LANGUAGE': 'en_US:en', 22:59:18 INFO - 'LOGNAME': 'cltbld', 22:59:18 INFO - 'MAIL': '/var/mail/cltbld', 22:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:18 INFO - 'MOZ_NO_REMOTE': '1', 22:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:18 INFO - 'NO_EM_RESTART': '1', 22:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:18 INFO - 'PWD': '/builds/slave/test', 22:59:18 INFO - 'SHELL': '/bin/bash', 22:59:18 INFO - 'SHLVL': '1', 22:59:18 INFO - 'TERM': 'linux', 22:59:18 INFO - 'TMOUT': '86400', 22:59:18 INFO - 'USER': 'cltbld', 22:59:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:18 INFO - '_': '/tools/buildbot/bin/python'} 22:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:59:18 INFO - Cleaning up... 22:59:18 INFO - Return code: 0 22:59:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7ff2a23e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13de350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, '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': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', '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 22:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 22:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 22:59:18 INFO - Using env: {'DISPLAY': ':0', 22:59:18 INFO - 'HOME': '/home/cltbld', 22:59:18 INFO - 'LANG': 'en_US.UTF-8', 22:59:18 INFO - 'LANGUAGE': 'en_US:en', 22:59:18 INFO - 'LOGNAME': 'cltbld', 22:59:18 INFO - 'MAIL': '/var/mail/cltbld', 22:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:18 INFO - 'MOZ_NO_REMOTE': '1', 22:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:18 INFO - 'NO_EM_RESTART': '1', 22:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:18 INFO - 'PWD': '/builds/slave/test', 22:59:18 INFO - 'SHELL': '/bin/bash', 22:59:18 INFO - 'SHLVL': '1', 22:59:18 INFO - 'TERM': 'linux', 22:59:18 INFO - 'TMOUT': '86400', 22:59:18 INFO - 'USER': 'cltbld', 22:59:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:18 INFO - '_': '/tools/buildbot/bin/python'} 22:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:19 INFO - Downloading/unpacking flake8 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:59:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:21 INFO - no previously-included directories found matching 'docs/_build' 22:59:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:59:21 INFO - Running setup.py install for pep8 22:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:21 INFO - no previously-included directories found matching 'docs/_build' 22:59:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:59:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:59:21 INFO - Cleaning up... 22:59:21 INFO - Return code: 0 22:59:21 INFO - Running post-action listener: _resource_record_post_action 22:59:21 INFO - Running post-action listener: _start_resource_monitoring 22:59:21 INFO - Starting resource monitoring. 22:59:21 INFO - ##### 22:59:21 INFO - ##### Finished create-virtualenv step (success) 22:59:21 INFO - ##### 22:59:21 INFO - ##### 22:59:21 INFO - ##### Running install step. 22:59:21 INFO - ##### 22:59:21 INFO - Running pre-action listener: _resource_record_pre_action 22:59:21 INFO - Running main action method: install 22:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:22 INFO - Reading from file tmpfile_stdout 22:59:22 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:59:22 INFO - Reading from file tmpfile_stdout 22:59:22 INFO - Output received: 22:59:22 INFO - Usage: mozinstall [options] installer 22:59:22 INFO - Options: 22:59:22 INFO - -h, --help show this help message and exit 22:59:22 INFO - -d DEST, --destination=DEST 22:59:22 INFO - Directory to install application into. [default: 22:59:22 INFO - "/builds/slave/test"] 22:59:22 INFO - --app=APP Application being installed. [default: firefox] 22:59:22 INFO - mkdir: /builds/slave/test/build/application 22:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:59:38 INFO - Reading from file tmpfile_stdout 22:59:38 INFO - Output received: 22:59:38 INFO - /builds/slave/test/build/application/firefox/firefox 22:59:38 INFO - Running post-action listener: _resource_record_post_action 22:59:38 INFO - ##### 22:59:38 INFO - ##### Finished install step (success) 22:59:38 INFO - ##### 22:59:38 INFO - ##### 22:59:38 INFO - ##### Running run-tests step. 22:59:38 INFO - ##### 22:59:38 INFO - Running pre-action listener: _resource_record_pre_action 22:59:38 INFO - Running main action method: run_tests 22:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:59:38 INFO - Python 2.7.3 22:59:38 INFO - Return code: 0 22:59:38 INFO - grabbing minidump binary from tooltool 22:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d1c0>, '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 0x146e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:59:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:59:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:59:38 INFO - Calling ['/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'] with output_timeout 600 22:59:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:39 INFO - Return code: 0 22:59:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:59:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:59:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:59:40 INFO - Return code: 0 22:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:59:40 INFO - Using env: {'DISPLAY': ':0', 22:59:40 INFO - 'HOME': '/home/cltbld', 22:59:40 INFO - 'LANG': 'en_US.UTF-8', 22:59:40 INFO - 'LANGUAGE': 'en_US:en', 22:59:40 INFO - 'LOGNAME': 'cltbld', 22:59:40 INFO - 'MAIL': '/var/mail/cltbld', 22:59:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:59:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:40 INFO - 'MOZ_NO_REMOTE': '1', 22:59:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:40 INFO - 'NO_EM_RESTART': '1', 22:59:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:40 INFO - 'PWD': '/builds/slave/test', 22:59:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:59:40 INFO - 'SHELL': '/bin/bash', 22:59:40 INFO - 'SHLVL': '1', 22:59:40 INFO - 'TERM': 'linux', 22:59:40 INFO - 'TMOUT': '86400', 22:59:40 INFO - 'USER': 'cltbld', 22:59:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465016645.91306-1414977163', 22:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:40 INFO - '_': '/tools/buildbot/bin/python'} 22:59:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:59:40 INFO - mozversion application_buildid: 20160603203027 22:59:40 INFO - mozversion application_changeset: 67c37ed1a25f92cac6294cb70af97e95515c30e2 22:59:40 INFO - mozversion application_display_name: Nightly 22:59:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:40 INFO - mozversion application_name: Firefox 22:59:40 INFO - mozversion application_remotingname: firefox 22:59:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:40 INFO - mozversion application_vendor: Mozilla 22:59:40 INFO - mozversion application_version: 49.0a1 22:59:40 INFO - mozversion platform_buildid: 20160603203027 22:59:40 INFO - mozversion platform_changeset: 67c37ed1a25f92cac6294cb70af97e95515c30e2 22:59:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:40 INFO - mozversion platform_version: 49.0a1 22:59:40 INFO - using testdate: 1465019980 22:59:40 INFO - actual date: 1465019980 22:59:40 INFO - starting webserver on 'localhost:35985' 22:59:40 INFO - SUITE-START | Running 2 tests 22:59:40 INFO - TEST-START | dromaeo_css 22:59:40 INFO - operating with platform_type : linux_ 22:59:40 INFO - Initialising browser for dromaeo_css test... 22:59:40 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp95y8La/profile http://localhost:35985/getInfo.html) 22:59:47 INFO - PROCESS | 3312 | __metrics Screen width/height:1600/1200 22:59:47 INFO - PROCESS | 3312 | colorDepth:24 22:59:47 INFO - PROCESS | 3312 | Browser inner width/height: 1024/697 22:59:47 INFO - PROCESS | 3312 | __metrics 22:59:48 ERROR - PROCESS | 3312 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:59:49 INFO - TEST-INFO | 3312: exit 0 22:59:49 INFO - Browser initialized. 22:59:49 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:49 INFO - TEST-INFO | started process 3432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp95y8La/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:01 INFO - PROCESS | 3432 | RSS: Main: 167694336 23:00:01 INFO - PROCESS | 3432 | 23:00:50 INFO - PROCESS | 3432 | 1465020050714 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] 23:02:58 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35985/tests/dromaeo/cssquery-ext.html) 23:02:59 INFO - PROCESS | 3432 | RSS: Main: 170000384 23:02:59 INFO - PROCESS | 3432 | 23:06:01 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-ext.html (next: http://localhost:35985/tests/dromaeo/cssquery-jquery.html) 23:06:02 INFO - PROCESS | 3432 | RSS: Main: 170237952 23:06:02 INFO - PROCESS | 3432 | 23:09:04 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35985/tests/dromaeo/cssquery-mootools.html) 23:09:04 INFO - PROCESS | 3432 | RSS: Main: 170934272 23:09:04 INFO - PROCESS | 3432 | 23:12:06 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35985/tests/dromaeo/cssquery-prototype.html) 23:12:07 INFO - PROCESS | 3432 | RSS: Main: 168456192 23:12:07 INFO - PROCESS | 3432 | 23:15:09 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35985/tests/dromaeo/cssquery-yui.html) 23:15:10 INFO - PROCESS | 3432 | RSS: Main: 170299392 23:15:10 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:35985/tests/dromaeo/cssquery-yui.html (next: http://localhost:35985/tests/dromaeo/cssquery-dojo.html) 23:18:12 INFO - PROCESS | 3432 | RSS: Main: 171634688 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | __start_tp_report 23:18:12 INFO - PROCESS | 3432 | _x_x_mozilla_page_load 23:18:12 INFO - PROCESS | 3432 | _x_x_mozilla_page_load_details 23:18:12 INFO - PROCESS | 3432 | |i|pagename|runs| 23:18:12 INFO - PROCESS | 3432 | |0;dojo.html;3076.061801150649;3098.829564373961;3125.5936728225342;3139.168120448081;3145.072203699907;5251.553617942474;5317.255584218207;5351.57187425006;5368.812091576786;5399.9730001350035;5337.893242135165;5485.725713714308;5501.449855014496;5511.476409741078;5540.972295138518;4953.876153096175;4975.701457912519;5018.071656743496;5117;5152.021115987969;4886.193778026622;5136.743162841862;5143.485651434864;5162.070827251093;5170.663906846062;4951.282064100721;4958.578520825734;4960.032793605266;4990.126727822617;4997.800087996476;4992.775325110379;4998.450170481244;5000.349954505928;5003.474635163292;5091.821786237501;4992;4996.875078123076;5011.699298042129;5027.170516864713;5070.543651071384;5132.435432102466;5355;5356.384015838151;5386.245925570423;5471.23402723619;5853.941460585383;5893.263342082239;5902.6163299385835;5904.232449781543;5911.793087241969;5928.436798504135;5945;5945.732442040118;5989.880202395928;5995.340512543617;5227.712475813829;5419.3225846769155;5458.863528411782;5474.972625136888;5499.340079190482;5954.523638108941;5980.5514586405325;6006.519478441802;6014.458698717136;6017.6389416634265;5618.775248989995;5776.884462310731;5794.565407594448;5802.6808525531505;5831.825045248649;5679.346875109332;5679.574031947621;5702.572307076985;5734.053881109654;5743.4543718346695;5644.350899646511;5696.829095127153;5698.572607054488;5713.971430142823;5750.4249575042995;5710.828675139753;5758.280214973129;5758.971205143947;5777.768889244468;5789.131630255495;4301.311790113629;4341.283688191476;4413.095315460323;4415.735055896656;4436.667249956202;3926.7447615904875;3931.6658084063174;3960.1683646433994;3972.0467087898696;4003.2994226010333;5457.099578569491;5564.582656300794;5589.776408943597;5605.103183490622;5642;5882.323532793784;5913.822585322448;5934.109883517421;5963.0459126539545;5974.910376344358;5695.5443564514735;5703.486686198262;5704.429557044263;5717.799877004285;5722.799702010409;4883.926741098886;4972.651914366032;5106.974465127651;5110.054639891632;5110.744462776846;5965.105234214902;5969.432903874125;6028.608140470856;6040.275166979991;6086.60437071589;5783.479486846204;5799.94200057994;5848.824535263949;5856.326522449803;5865.973454645506;5827.679477628772;5974.970125149346;5988.28140623128;6008.068749343859;6017.638941663339;5733.799317023884;5748.48263656273;5768.1347797828985;5776.075827867521;5801.564882633735;5795.797147099831;5868.4424979626865;5872.148538461814;5875.059990401515;5877.588568800143;5496.31296087989;5654.349749778664;5657.971710141423;5685.829425117253;5696.886062278814;5552.139418390156;5603.467670571289;5619.185218143428;5652.3217213934595;5663.943360566506;5557.388687244481;5576.860578485408;5580.302462192226;5581.888362232814;5609.27079479665;5648.717564121695;5689.943100568941;5694.288213973254;5718.542516598579;5767.884642307215;5518.503334699896;5521.944780552143;5577.051901176728;5602.635828671123;5605.383407825055 23:18:12 INFO - PROCESS | 3432 | |1;ext.html;577.8006587727235;621.9782307619234;623.6663385088976;641.8587910659656;657.477305542094;39173.80413097934;43908.1459705119;44010.55989440105;44084.11831763363;44356.77821610891;44221.778891105496;44507;44875.77562112193;44895.77552112243;44901.32648010283;8573.528455934937;8718.215360617543;8729.170728780755;8810.955945220265;8827.382083254175;8568.143185681445;8689.17452841979;8691.565421728888;8694.304455643532;8697.260732837716;8701.7824554386;8761.904761904761;8772.254358379545;8772.605232764508;8785.868211976825;8557.97304323479;8635.52504612246;8660.8700869487;8675.913240867574;8738.213560779497;8625.396222264444;8657;8685.696000640011;8690.652373905035;8738.563071846445;40580.1883962322;40856.591434085574;41008.38487422691;41204.793976030225;41222.793886030675;3217.7747557670973;3284.8850290239966;3321.601407831076;3376.4766461198556;3774.1508160663907;32339.83830080858;32577.837110814533;32703.18242043944;34350.14124646879;34627;4237.749863790158;4276.893077673052;4286.485621725413;4298.849540266076;4323.308270676708;241934;243324;244270;244690;244712;58938;59483.70258148682;59873;59920.400795992355;59955;35912.46131308033;36234;36333.27333453316;38746.6125338743;38938;17187.398441054753;17339.306427742747;17477.213525391388;17495.212715427835;17506.824931750518;13146.737065258832;13216.207027578184;13308.73382532344;13340.399682014333;13376.665583360495;19691.60616787656;19966.401007969784;19980.700289495668;20056.899715501622;20106.798932010784;7138.6085661303005;7251.105503784924;7316.853662926712;7341.77974660761;7562.659680314399;946.6781294359813;1021.8262895307666;1061.2836335473523;1079.3631757263252;1203.9638810835688;32362;32366.514502282484;32429;32632.510512342335;33040.83479582587;1125.6285425809463;1140.5380820767602;1235.1662627726428;1237.3256575166556;1261.2495565138727;17176.656466870594;17313.82686173147;17343.65312693739;17349.56626084358;17502.299908003537;540551;546777;547381;547663;553748;58436;58942.41057589455;59013.40986590165;59280.407195928354;59619.40380596139;1341.1014620204487;1347.3532704301795;1389.8054272402073;1390.7218556288783;1394.6931675031476;31177.68822311748;31882.840585796923;32055.839720802178;32203.677963221005;33126.503102453;51790.223146652075;52027;52054.73972630112;52056.47943520516;52086.73956630193;449489;453384;453544;453761;454313;28076.719232808227;28343.716562834106;28564.42871142607;28607.28481787972;28677.85661071681;48769;50206.246906297165;50847;51011.48988510067;51228.23157652713;42344.788276058425;43171.78414107909;43841.34237986497;44145.55854441415;44458.777706111265;42063.3690494649;42467.1506569873;42537;43289.3506597395;43920.78039609781;41835;42085.57914420817;42647.360289596305;42980;44887.55112448834;34696.82651586726;38477.42283865688;38584.80707596444;38690.80654596822;39112.41331379975;28820.711792881804;29132.27169320784;29316.41367172602;29617;29624.111276661733 23:18:12 INFO - PROCESS | 3432 | |2;jquery.html;391.28395037082134;393.0762707637055;396.0889953107853;396.57764480827916;415.0805964787994;13459.730805383886;18096.18567164481;18320.541986450327;19014.809851901493;19052.047397630115;18045.548861278476;18174.182161802717;18416.907915460404;19256.711149332736;19298.61402771947;5220.112580861262;5467.562594992401;5525.060739674245;5570.8607284818;5651.943480565204;5493.890122197554;5532;5536.086545719952;6686.899696504532;7122.074130363046;7104.893426598605;7250.2024777274455;7258.709651613929;7260.419166466696;7261.709531618729;7121.608311542863;7265.273472652692;7302.37929775967;7306.123265208156;7316.634168291617;6285.779997700059;6732.360425759545;6757.526973111884;6936.09830722008;6979.89530157048;24543.877280613484;24550;24838.5032299353;25933.74066259332;26181.083662071927;2275.1240772302617;2318.8260880434036;2389.880505974712;2442.6336049592524;2459.32368598635;14434.927825360806;15417.922910385376;15438.768418473732;15945.521634350987;16022.278997445143;1951.2390167834556;2065.9586808263903;2114.7990940860595;2146.8497205195645;2218.2901471529117;89593.55203223941;89681;89719;91454.5427272866;92760.53619731926;17086.48740537786;17363.913180434018;17575.02449167289;18012.279508819764;18091;31457.8427107863;31486.527702084488;31509.684903151134;31666.525002124985;31744.36511269762;9847.901520984698;9939.850902236472;10180.185585153169;10267.435291059064;10373.84439233412;8525.65897364111;8629.568521573896;8701.564921753887;8790.780230494289;8867.73396798097;8610;8784.597472554333;8842.513661748666;8876.467411955304;8894.93260808707;3313.486409606515;3375.696187343151;3513.1744040150543;3601.1897323102094;3625.2930678517964;982.9655962041294;1015.2284263959444;1026.58423338548;1077.4881931082673;1079.4764539198482;18182.090895455174;18455.446336609653;19054.904725476285;19088.14103365352;19312.4206273812;1027.9588816447258;1054.9314294570981;1064.771074219031;1080.6325849211305;1084.4089970965842;10470.319429237075;10576.841347379795;10694.572217111385;10793.892061079288;10829.801695186356;448607;451664;454659;456984;474873;53743;66988.33011669919;71731;78034.21965780383;82795;990.4255531791543;996.8155891160013;1002.664107523973;1023.1763430438419;1023.6007956896816;16825.41111061107;17170.313187472362;17194;17197.226124824163;17547.298108075534;28579.857100714362;32997.83501082479;33605;39136;40105.79947100246;52266.47733522768;55218.72390638021;55778.72110639421;55954.72022639861;56005.59986000383;8037.874697542466;8299.792505187177;8363.49819010837;8385.077641459557;8422.831543368975;12591.181573197713;12729.681757955756;12805.359732013549;12906.80639790385;12910.935445322713;10909.18181136402;11127.499262533043;11192;11535.653930382103;11549.133814963743;10922.453877305945;11130.553028106295;11227.71930701739;11290.830637540608;11359.602413915472;10716.678499645022;11076.280041797258;11287.20989530725;11346.773064538827;11575.652730418102;7435.7025718970635;7720.150783413707;8542.06037335905;8591.871121933302;8702.47785132894;11241.775164496828;11671.708207294885;11804.940975295069;11910.344931028876;12203.206791558876 23:18:12 INFO - PROCESS | 3432 | |3;mootools.html;1491.1500444746491;1494.4097081652747;1680.9831901680986;1757.5606098475382;1788.695921693312;7942.761717148494;8702.825943481135;8775.648974041047;9269.026752191015;9276;8768.079351668079;9015.954920225406;9064.320175986812;9081.046490118542;9113.407628504143;2423.357810180299;2460.1758410932357;2463.4949835283815;2463.5442443148077;2464.8397854139425;2389.64155376694;2461.679981602389;2470.8641024743633;2476.071473197551;2476.170482888235;2396.6165413533836;2403.158894386968;2443.743406942272;2447.437089469423;2452.865092419916;2418.9153379631716;2443.2670198940336;2444.7555244475498;2457.8771061447037;2480.379905023744;2351.776581224781;2359;2361.740208577055;2367.3726462487452;2367.798737107331;9052.230560402373;9059.864102038475;9116;9131.406458580172;9138.040505746934;5325.494078062617;5422;5462.945370546284;5476.424975377608;5484.424135465799;3547.5565554305713;3567.2865426914464;3600.3519366514015;3617.0595645132457;3751.268502641986;1222.9021678265806;1240.4542001519303;1252.4051075739042;1260.514701839789;1274.5093139141404;12752.617421477371;12801.93599031999;12860.678483037906;12861.67845803853;12868.485260589565;4727.149113159596;4865.464798872121;4936.777844996984;4939.506049395031;4969.503049695001;10740.194485413625;10789.514471848786;10799.352038877692;10829.620963266405;10853.077488413574;5425;5469.972650136724;5493.368262649847;5496.972515137399;5515.034868897927;4432.445944256968;4806.711597304173;4951.257311403318;4961.404631444249;5099.23511473282;4076.8369265229057;4123.558018828167;4138.958610413857;4159.625633692982;4181.205570941512;1281.2440660010639;1295.8768916952874;1308.2739079810797;1314.4413624209672;1328.621342917264;923.7459698582943;1009.8232809258351;1031.6956497833157;1040.193849766437;1046.4663021858908;6091.878162436815;6231.189945307081;6264.498840092781;6299.244090709144;6329.905051424233;461.83835657520274;462.8411094281542;465.3368949247309;467.22440748357565;483.07732231437785;4341.261985462415;4385.298352263622;4401.713888597231;4422.380866678667;4432.246518091933;10935.781284374269;11208.21542492034;11287.153463490107;11341.943290283496;11362.545498180145;10561.419121948213;10998.890011099948;11003.834942475869;11245.381504017358;11343.092552595772;8460.788480288042;8573.957130214434;8580.613872375758;8583.742487725378;8584.527850968258;5944.762209511571;5986.730597123227;6170.50635949132;6197.845053873689;6249.625022498482;10132.645357412455;10223.386596804216;10238.436885971045;10397.428141452292;10458.058774710313;10425.426601536685;10624;10832.079273261861;10868.891311086787;10926.180536459957;7332.706691732271;8196.38527110481;8213.79465513343;8320.875186872323;8498.107698691549;8594.269487093667;8793.384463087523;8801.47191168532;8809.251213646912;8857.3799834011;7486.9625651873575;7603.239676032353;7630.847383052419;7729.458937874295;8083.9191608083165;7495.550266983998;7635.618219089134;7687;7714.074311082706;7763.961180194063;6993.720251190099;7130.42956563484;7140.428765698628;7154.177269614061;7173.354398104196;5007.5993920487;5150.742462876916;5173.198154286091;5351.063563876384;5419.674819510842;5167;5221.242919776687;5296.576273898156;5309.57523398135;5335.146376579729 23:18:12 INFO - PROCESS | 3432 | |4;prototype.html;326.27566801700215;326.9280758233189;327.65268815056044;332.97336213102955;335.4950799047433;5564.749586268617;5632.633878797876;5668.291463567054;5698.829035128942;5721.284839395075;5552.4169962154;5564;5581.441855814416;5597.132444471104;5658;4149.630621894783;4283.785810709468;4295.613394794468;4325.426371309082;4347.913041739163;4327.285997810358;4334.436523251973;4349.173657005174;4376.934345984797;4391.9121617567625;4336.284513055358;4370.125974805036;4383.868483945486;4385.956140438602;4399.978000109995;4199.895002624943;4315.180115777992;4345.369921361416;4346.891327716832;4358.4527492739935;3804.961950380516;3838.560539797576;3840.423936409533;3871.6515513603913;3902.824372903198;5322.5209731124;5336.493033161843;5366.865828354284;5420.807422367073;5425.647332923387;4809.807607695723;4990.675606085593;4991.301217829507;5001.824936127218;5018.824341148043;5718.513926316268;5739.62692424991;5757.280339957505;5802.709864506758;5834.854128646775;4250.128723611652;4252.149570085995;4253.978730106361;4267.698352002638;4268.765217913014;5843.620164689324;6068.484178844804;6115.143879856823;6129.448349648553;6166.722497487579;4253.553376895381;4254.936175957363;4259.1268789897995;4260.467441569804;4272.188284225987;4291.141771645684;4292.18448494785;4297.78511074445;4305.74165550068;4351.69538132334;4801.975990120097;4923.236898280772;4923.86751047254;4931.87670308238;5016.372953380827;5892.410758924073;5944.7027648617395;5960.64236145824;5962.880742385128;5982;1473.7568301230176;1488.5311126994961;1500.887433442496;1515.0076699761673;1515.4847351900187;954.6754103604808;963.393062370702;982.4449186209769;987.3286165407449;996.1632228927735;5567.693776842231;5627.127795191752;5637.577181711388;5651.971740141273;5693.743781529841;5979.996701105091;5998.310194327708;6023.45788879003;6038.9396106038375;6075.392460753889;5389.191621256765;5668.441178675815;5756.625819321731;5773.595848290579;5792.913106303409;3243.5621191139367;3249.6262929762906;3276.7057012480414;3282.7209687176855;3297.7856439331367;6120.571559990847;6308.337624549448;6362.936370636327;6371.076193951943;6377;6201.844953876099;6205.81382558524;6268.840264551072;6271.937280627227;6278.215223097113;5818.6035351516175;6146.846328841814;6185.536084793658;6186.659733714599;6189.535784816157;5969.611975221596;6027.276726792637;6029.939700602938;6051.818445446644;6121.969390153021;5943.910841337297;6074.817755467343;6087.847803804763;6089.604175728564;6126.908096378647;5988;6216.844578885564;6265.906011409741;6353;6360.77737279193;4266.210751011073;4281.2293787118615;4318.978405107954;4321.7406955582765;4322.78386080701;5901.468867801918;6030.75876964934;6037.516998640011;6054.212952316171;6141.170941922962;5885.117232415172;5886.3525012247765;5904.498117660047;5910;5950.613210141327;5857.384974577608;5885.234919460614;5892.587518873637;5896.587238893237;5909.556783241188;5659.302209337265;5720.338983050768;5785.4214578541805;5866.5893387462465;5873.2658417697785;5971.223740913653;6022.337542870368;6028.156058151774;6055.212822333068;6078.270607527125;5592.189132575835;5833.212516310414;5867.794627188028;5929.347771745191;5932.525397968066 23:18:12 INFO - PROCESS | 3432 | |5;yui.html;763.427429427929;783.4946459533601;806.395203597302;830.5099991005308;866.8179682266725;14490.420383184673;15715.52853414398;15764.211789410512;15793.368265269375;15965.12191829449;15050;15165.014274072177;15172.848271517281;15203.315850786714;15239.77140342893;680.5202332355677;797.7766225456852;801.1227705662305;816.4978538199024;817.3461231015164;805.5972013993004;806.6853926968487;809.348474478045;810.4893916832388;816.848882956655;850.2560259772699;852.1180578101666;853.8164294676643;855.9657613695445;858.1418581418582;853.6158728572167;853.7865533616596;853.8249658819958;854.4403415762686;854.5385491834402;621.574221658161;622.9345918678564;623.2987888625297;623.5697368815503;624.2914292278297;14402.279886005763;14554.126752394784;14691.265436728228;14699.55901322962;14704.411823527045;15467.92266038674;15685.686286274211;15689.676539843847;15813.446529371531;15969.281382337707;11885.643430697093;12181.695457613541;12570.120091593591;12927.353632318347;13068.215907045607;4616.884577885546;4622.815087396534;4631.884202894955;4671.34601155835;4751.121042607128;69905.65047174782;69985;70452.6477367615;70689.29310706879;71190;11872.643820685393;11932.463039163258;11939.761204775856;12002.459889305002;12157.331346776013;21392.144314227568;21455.14179432805;21526;21585.352439426842;22107.226247081595;8170.692190732641;8282.1303763104;8330.66677332912;8624.396292259607;8829.072947340564;4839.879003024953;4924.827631032968;5048.7728052237735;5164.3802743671;5186.948130518722;3740.5698344690163;3901.765894046366;3913.3347330953807;3913.9021524462114;3914.119323152325;649.7660842096841;650.4796163069525;659.0871642774696;666.7066490744057;671.2649648634737;682.7644462660375;705.1784670858392;755.2787088330631;786.6853258696567;806.7015204374419;9966.651167209258;10183.54584182631;10236.48817559134;10441.477926103664;10482.790344193227;543.1689515041992;558.7346010644992;675.1324547955951;706.3113464372299;726.2895880202153;5052.797888084436;5126.1798112302595;5197.168453047494;5215.921761173586;5256.237845512379;62441;63013;65825;82695.7595636066;119456.40271798585;58071;58437.12344314839;67526.66236668786;67856.6607166971;92302.53848730848;87452.5627371859;90736;91985;92330;93036.53481732548;9516.809663806824;9718.75703107428;9750.561224744763;9841.507924603884;9940.502974851373;52577.7371113142;52793;53374.73312633412;54485.45514544804;54923.176152356944;72808.27191728014;74866.62566687132;75952.79222789142;77615.2238477608;78904;12085.214461060003;12210.877891220975;12373.381330933596;12457.688557786129;12964.8055279169;13681.670025627707;13789.931050344683;13986.44054237819;14103.153810771386;14155.929220353832;13332.533361332307;13366.131201471873;13845.169289842239;14108.647283817987;14109.6472588182;12972.610821675366;13260.513271506437;13538.120022198525;13730.588082357544;14149.929250353682;13135.605931822061;13136.671583210496;13585.456581737015;13660.521881734092;13667.111637743516;11103.72240693989;11131.220814542905;11264.436778161224;11277.548898043986;11310.660680179608;9880.209583233467;10039.648612298535;10143.239257055602;10201.234907381828;10230.795384092426 23:18:12 INFO - PROCESS | 3432 | __end_tp_report 23:18:12 INFO - PROCESS | 3432 | __start_cc_report 23:18:12 INFO - PROCESS | 3432 | _x_x_mozilla_cycle_collect,336 23:18:12 INFO - PROCESS | 3432 | __end_cc_report 23:18:12 INFO - PROCESS | 3432 | __startTimestamp1465021092662__endTimestamp 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | ------- Summary: start ------- 23:18:12 INFO - PROCESS | 3432 | Number of tests: 6 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#0] dojo.html Cycles:165 Average:5416.77 Median:5618.78 stddev:617.46 (11.0%) stddev-sans-first:591.42 23:18:12 INFO - PROCESS | 3432 | Values: 3076.1 3098.8 3125.6 3139.2 3145.1 5251.6 5317.3 5351.6 5368.8 5400.0 5337.9 5485.7 5501.4 5511.5 5541.0 4953.9 4975.7 5018.1 5117.0 5152.0 4886.2 5136.7 5143.5 5162.1 5170.7 4951.3 4958.6 4960.0 4990.1 4997.8 4992.8 4998.5 5000.3 5003.5 5091.8 4992.0 4996.9 5011.7 5027.2 5070.5 5132.4 5355.0 5356.4 5386.2 5471.2 5853.9 5893.3 5902.6 5904.2 5911.8 5928.4 5945.0 5945.7 5989.9 5995.3 5227.7 5419.3 5458.9 5475.0 5499.3 5954.5 5980.6 6006.5 6014.5 6017.6 5618.8 5776.9 5794.6 5802.7 5831.8 5679.3 5679.6 5702.6 5734.1 5743.5 5644.4 5696.8 5698.6 5714.0 5750.4 5710.8 5758.3 5759.0 5777.8 5789.1 4301.3 4341.3 4413.1 4415.7 4436.7 3926.7 3931.7 3960.2 3972.0 4003.3 5457.1 5564.6 5589.8 5605.1 5642.0 5882.3 5913.8 5934.1 5963.0 5974.9 5695.5 5703.5 5704.4 5717.8 5722.8 4883.9 4972.7 5107.0 5110.1 5110.7 5965.1 5969.4 6028.6 6040.3 6086.6 5783.5 5799.9 5848.8 5856.3 5866.0 5827.7 5975.0 5988.3 6008.1 6017.6 5733.8 5748.5 5768.1 5776.1 5801.6 5795.8 5868.4 5872.1 5875.1 5877.6 5496.3 5654.3 5658.0 5685.8 5696.9 5552.1 5603.5 5619.2 5652.3 5663.9 5557.4 5576.9 5580.3 5581.9 5609.3 5648.7 5689.9 5694.3 5718.5 5767.9 5518.5 5521.9 5577.1 5602.6 5605.4 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#1] ext.html Cycles:180 Average:57908.87 Median:42502.08 stddev:115314.76 (271.3%) stddev-sans-first:115557.91 23:18:12 INFO - PROCESS | 3432 | Values: 577.8 622.0 623.7 641.9 657.5 39173.8 43908.1 44010.6 44084.1 44356.8 44221.8 44507.0 44875.8 44895.8 44901.3 8573.5 8718.2 8729.2 8811.0 8827.4 8568.1 8689.2 8691.6 8694.3 8697.3 8701.8 8761.9 8772.3 8772.6 8785.9 8558.0 8635.5 8660.9 8675.9 8738.2 8625.4 8657.0 8685.7 8690.7 8738.6 40580.2 40856.6 41008.4 41204.8 41222.8 3217.8 3284.9 3321.6 3376.5 3774.2 32339.8 32577.8 32703.2 34350.1 34627.0 4237.7 4276.9 4286.5 4298.8 4323.3 241934.0 243324.0 244270.0 244690.0 244712.0 58938.0 59483.7 59873.0 59920.4 59955.0 35912.5 36234.0 36333.3 38746.6 38938.0 17187.4 17339.3 17477.2 17495.2 17506.8 13146.7 13216.2 13308.7 13340.4 13376.7 19691.6 19966.4 19980.7 20056.9 20106.8 7138.6 7251.1 7316.9 7341.8 7562.7 946.7 1021.8 1061.3 1079.4 1204.0 32362.0 32366.5 32429.0 32632.5 33040.8 1125.6 1140.5 1235.2 1237.3 1261.2 17176.7 17313.8 17343.7 17349.6 17502.3 540551.0 546777.0 547381.0 547663.0 553748.0 58436.0 58942.4 59013.4 59280.4 59619.4 1341.1 1347.4 1389.8 1390.7 1394.7 31177.7 31882.8 32055.8 32203.7 33126.5 51790.2 52027.0 52054.7 52056.5 52086.7 449489.0 453384.0 453544.0 453761.0 454313.0 28076.7 28343.7 28564.4 28607.3 28677.9 48769.0 50206.2 50847.0 51011.5 51228.2 42344.8 43171.8 43841.3 44145.6 44458.8 42063.4 42467.2 42537.0 43289.4 43920.8 41835.0 42085.6 42647.4 42980.0 44887.6 34696.8 38477.4 38584.8 38690.8 39112.4 28820.7 29132.3 29316.4 29617.0 29624.1 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#2] jquery.html Cycles:180 Average:28553.90 Median:30018.85 stddev:75192.42 (250.5%) stddev-sans-first:75373.62 23:18:12 INFO - PROCESS | 3432 | Values: 391.3 393.1 396.1 396.6 415.1 13459.7 18096.2 18320.5 19014.8 19052.0 18045.5 18174.2 18416.9 19256.7 19298.6 5220.1 5467.6 5525.1 5570.9 5651.9 5493.9 5532.0 5536.1 6686.9 7122.1 7104.9 7250.2 7258.7 7260.4 7261.7 7121.6 7265.3 7302.4 7306.1 7316.6 6285.8 6732.4 6757.5 6936.1 6979.9 24543.9 24550.0 24838.5 25933.7 26181.1 2275.1 2318.8 2389.9 2442.6 2459.3 14434.9 15417.9 15438.8 15945.5 16022.3 1951.2 2066.0 2114.8 2146.8 2218.3 89593.6 89681.0 89719.0 91454.5 92760.5 17086.5 17363.9 17575.0 18012.3 18091.0 31457.8 31486.5 31509.7 31666.5 31744.4 9847.9 9939.9 10180.2 10267.4 10373.8 8525.7 8629.6 8701.6 8790.8 8867.7 8610.0 8784.6 8842.5 8876.5 8894.9 3313.5 3375.7 3513.2 3601.2 3625.3 983.0 1015.2 1026.6 1077.5 1079.5 18182.1 18455.4 19054.9 19088.1 19312.4 1028.0 1054.9 1064.8 1080.6 1084.4 10470.3 10576.8 10694.6 10793.9 10829.8 448607.0 451664.0 454659.0 456984.0 474873.0 53743.0 66988.3 71731.0 78034.2 82795.0 990.4 996.8 1002.7 1023.2 1023.6 16825.4 17170.3 17194.0 17197.2 17547.3 28579.9 32997.8 33605.0 39136.0 40105.8 52266.5 55218.7 55778.7 55954.7 56005.6 8037.9 8299.8 8363.5 8385.1 8422.8 12591.2 12729.7 12805.4 12906.8 12910.9 10909.2 11127.5 11192.0 11535.7 11549.1 10922.5 11130.6 11227.7 11290.8 11359.6 10716.7 11076.3 11287.2 11346.8 11575.7 7435.7 7720.2 8542.1 8591.9 8702.5 11241.8 11671.7 11804.9 11910.3 12203.2 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#3] mootools.html Cycles:180 Average:5977.99 Median:462.34 stddev:3404.23 (736.3%) stddev-sans-first:3397.08 23:18:12 INFO - PROCESS | 3432 | Values: 1491.2 1494.4 1681.0 1757.6 1788.7 7942.8 8702.8 8775.6 9269.0 9276.0 8768.1 9016.0 9064.3 9081.0 9113.4 2423.4 2460.2 2463.5 2463.5 2464.8 2389.6 2461.7 2470.9 2476.1 2476.2 2396.6 2403.2 2443.7 2447.4 2452.9 2418.9 2443.3 2444.8 2457.9 2480.4 2351.8 2359.0 2361.7 2367.4 2367.8 9052.2 9059.9 9116.0 9131.4 9138.0 5325.5 5422.0 5462.9 5476.4 5484.4 3547.6 3567.3 3600.4 3617.1 3751.3 1222.9 1240.5 1252.4 1260.5 1274.5 12752.6 12801.9 12860.7 12861.7 12868.5 4727.1 4865.5 4936.8 4939.5 4969.5 10740.2 10789.5 10799.4 10829.6 10853.1 5425.0 5470.0 5493.4 5497.0 5515.0 4432.4 4806.7 4951.3 4961.4 5099.2 4076.8 4123.6 4139.0 4159.6 4181.2 1281.2 1295.9 1308.3 1314.4 1328.6 923.7 1009.8 1031.7 1040.2 1046.5 6091.9 6231.2 6264.5 6299.2 6329.9 461.8 462.8 465.3 467.2 483.1 4341.3 4385.3 4401.7 4422.4 4432.2 10935.8 11208.2 11287.2 11341.9 11362.5 10561.4 10998.9 11003.8 11245.4 11343.1 8460.8 8574.0 8580.6 8583.7 8584.5 5944.8 5986.7 6170.5 6197.8 6249.6 10132.6 10223.4 10238.4 10397.4 10458.1 10425.4 10624.0 10832.1 10868.9 10926.2 7332.7 8196.4 8213.8 8320.9 8498.1 8594.3 8793.4 8801.5 8809.3 8857.4 7487.0 7603.2 7630.8 7729.5 8083.9 7495.6 7635.6 7687.0 7714.1 7764.0 6993.7 7130.4 7140.4 7154.2 7173.4 5007.6 5150.7 5173.2 5351.1 5419.7 5167.0 5221.2 5296.6 5309.6 5335.1 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#4] prototype.html Cycles:180 Average:4957.65 Median:5681.09 stddev:1468.98 (25.9%) stddev-sans-first:1431.38 23:18:12 INFO - PROCESS | 3432 | Values: 326.3 326.9 327.7 333.0 335.5 5564.7 5632.6 5668.3 5698.8 5721.3 5552.4 5564.0 5581.4 5597.1 5658.0 4149.6 4283.8 4295.6 4325.4 4347.9 4327.3 4334.4 4349.2 4376.9 4391.9 4336.3 4370.1 4383.9 4386.0 4400.0 4199.9 4315.2 4345.4 4346.9 4358.5 3805.0 3838.6 3840.4 3871.7 3902.8 5322.5 5336.5 5366.9 5420.8 5425.6 4809.8 4990.7 4991.3 5001.8 5018.8 5718.5 5739.6 5757.3 5802.7 5834.9 4250.1 4252.1 4254.0 4267.7 4268.8 5843.6 6068.5 6115.1 6129.4 6166.7 4253.6 4254.9 4259.1 4260.5 4272.2 4291.1 4292.2 4297.8 4305.7 4351.7 4802.0 4923.2 4923.9 4931.9 5016.4 5892.4 5944.7 5960.6 5962.9 5982.0 1473.8 1488.5 1500.9 1515.0 1515.5 954.7 963.4 982.4 987.3 996.2 5567.7 5627.1 5637.6 5652.0 5693.7 5980.0 5998.3 6023.5 6038.9 6075.4 5389.2 5668.4 5756.6 5773.6 5792.9 3243.6 3249.6 3276.7 3282.7 3297.8 6120.6 6308.3 6362.9 6371.1 6377.0 6201.8 6205.8 6268.8 6271.9 6278.2 5818.6 6146.8 6185.5 6186.7 6189.5 5969.6 6027.3 6029.9 6051.8 6122.0 5943.9 6074.8 6087.8 6089.6 6126.9 5988.0 6216.8 6265.9 6353.0 6360.8 4266.2 4281.2 4319.0 4321.7 4322.8 5901.5 6030.8 6037.5 6054.2 6141.2 5885.1 5886.4 5904.5 5910.0 5950.6 5857.4 5885.2 5892.6 5896.6 5909.6 5659.3 5720.3 5785.4 5866.6 5873.3 5971.2 6022.3 6028.2 6055.2 6078.3 5592.2 5833.2 5867.8 5929.3 5932.5 23:18:12 INFO - PROCESS | 3432 | 23:18:12 INFO - PROCESS | 3432 | [#5] yui.html Cycles:180 Average:19119.11 Median:5192.06 stddev:25633.06 (493.7%) stddev-sans-first:25667.91 23:18:12 INFO - PROCESS | 3432 | Values: 763.4 783.5 806.4 830.5 866.8 14490.4 15715.5 15764.2 15793.4 15965.1 15050.0 15165.0 15172.8 15203.3 15239.8 680.5 797.8 801.1 816.5 817.3 805.6 806.7 809.3 810.5 816.8 850.3 852.1 853.8 856.0 858.1 853.6 853.8 853.8 854.4 854.5 621.6 622.9 623.3 623.6 624.3 14402.3 14554.1 14691.3 14699.6 14704.4 15467.9 15685.7 15689.7 15813.4 15969.3 11885.6 12181.7 12570.1 12927.4 13068.2 4616.9 4622.8 4631.9 4671.3 4751.1 69905.7 69985.0 70452.6 70689.3 71190.0 11872.6 11932.5 11939.8 12002.5 12157.3 21392.1 21455.1 21526.0 21585.4 22107.2 8170.7 8282.1 8330.7 8624.4 8829.1 4839.9 4924.8 5048.8 5164.4 5186.9 3740.6 3901.8 3913.3 3913.9 3914.1 649.8 650.5 659.1 666.7 671.3 682.8 705.2 755.3 786.7 806.7 9966.7 10183.5 10236.5 10441.5 10482.8 543.2 558.7 675.1 706.3 726.3 5052.8 5126.2 5197.2 5215.9 5256.2 62441.0 63013.0 65825.0 82695.8 119456.4 58071.0 58437.1 67526.7 67856.7 92302.5 87452.6 90736.0 91985.0 92330.0 93036.5 9516.8 9718.8 9750.6 9841.5 9940.5 52577.7 52793.0 53374.7 54485.5 54923.2 72808.3 74866.6 75952.8 77615.2 78904.0 12085.2 12210.9 12373.4 12457.7 12964.8 13681.7 13789.9 13986.4 14103.2 14155.9 13332.5 13366.1 13845.2 14108.6 14109.6 12972.6 13260.5 13538.1 13730.6 14149.9 13135.6 13136.7 13585.5 13660.5 13667.1 11103.7 11131.2 11264.4 11277.5 11310.7 9880.2 10039.6 10143.2 10201.2 10230.8 23:18:12 INFO - PROCESS | 3432 | -------- Summary: end -------- 23:18:12 INFO - PROCESS | 3432 | 23:18:13 INFO - TEST-INFO | 3432: exit 0 23:18:13 INFO - TEST-OK | dromaeo_css | took 1113013ms 23:18:13 INFO - TEST-START | kraken 23:18:13 INFO - operating with platform_type : linux_ 23:18:13 INFO - Initialising browser for kraken test... 23:18:13 INFO - TEST-INFO | started process 3670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNt39b0/profile http://localhost:35985/getInfo.html) 23:18:17 INFO - PROCESS | 3670 | __metrics Screen width/height:1600/1200 23:18:17 INFO - PROCESS | 3670 | colorDepth:24 23:18:17 INFO - PROCESS | 3670 | Browser inner width/height: 1024/697 23:18:17 INFO - PROCESS | 3670 | __metrics 23:18:18 ERROR - PROCESS | 3670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:18:19 INFO - TEST-INFO | 3670: exit 0 23:18:19 INFO - Browser initialized. 23:18:19 INFO - Running cycle 1/1 for kraken test... 23:18:19 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNt39b0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:31 INFO - PROCESS | 3790 | RSS: Main: 167325696 23:18:31 INFO - PROCESS | 3790 | 23:18:33 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35985/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:34 INFO - PROCESS | 3790 | RSS: Main: 172593152 23:18:34 INFO - PROCESS | 3790 | 23:18:37 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35985/tests/kraken/driver.html?testName=audio-dft) 23:18:38 INFO - PROCESS | 3790 | RSS: Main: 172105728 23:18:38 INFO - PROCESS | 3790 | 23:18:40 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35985/tests/kraken/driver.html?testName=audio-fft) 23:18:41 INFO - PROCESS | 3790 | RSS: Main: 167038976 23:18:41 INFO - PROCESS | 3790 | 23:18:43 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35985/tests/kraken/driver.html?testName=audio-oscillator) 23:18:44 INFO - PROCESS | 3790 | RSS: Main: 167587840 23:18:44 INFO - PROCESS | 3790 | 23:18:46 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35985/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:47 INFO - PROCESS | 3790 | RSS: Main: 167964672 23:18:47 INFO - PROCESS | 3790 | 23:18:50 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35985/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:50 INFO - PROCESS | 3790 | RSS: Main: 168624128 23:18:50 INFO - PROCESS | 3790 | 23:18:54 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35985/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:55 INFO - PROCESS | 3790 | RSS: Main: 166146048 23:18:55 INFO - PROCESS | 3790 | 23:18:57 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35985/tests/kraken/driver.html?testName=json-parse-financial) 23:18:58 INFO - PROCESS | 3790 | RSS: Main: 167419904 23:18:58 INFO - PROCESS | 3790 | 23:19:00 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35985/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:00 INFO - PROCESS | 3790 | RSS: Main: 167747584 23:19:00 INFO - PROCESS | 3790 | 23:19:02 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:03 INFO - PROCESS | 3790 | RSS: Main: 167792640 23:19:03 INFO - PROCESS | 3790 | 23:19:05 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:05 INFO - PROCESS | 3790 | RSS: Main: 167964672 23:19:05 INFO - PROCESS | 3790 | 23:19:08 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:09 INFO - PROCESS | 3790 | RSS: Main: 168513536 23:19:09 INFO - PROCESS | 3790 | 23:19:11 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:12 INFO - PROCESS | 3790 | RSS: Main: 168148992 23:19:12 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35985/tests/kraken/driver.html?testName=ai-astar) 23:19:14 INFO - PROCESS | 3790 | RSS: Main: 168968192 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | __start_tp_report 23:19:14 INFO - PROCESS | 3790 | _x_x_mozilla_page_load 23:19:14 INFO - PROCESS | 3790 | _x_x_mozilla_page_load_details 23:19:14 INFO - PROCESS | 3790 | |i|pagename|runs| 23:19:14 INFO - PROCESS | 3790 | |0;ai-astar;115;107;112;111;114;112;111;110;112;113 23:19:14 INFO - PROCESS | 3790 | |1;audio-beat-detection;155;124;152;183;128;154;156;131;187;128 23:19:14 INFO - PROCESS | 3790 | |2;audio-dft;170;166;162;164;167;166;168;162;162;163 23:19:14 INFO - PROCESS | 3790 | |3;audio-fft;77;75;76;170;75;77;75;76;161;76 23:19:14 INFO - PROCESS | 3790 | |4;audio-oscillator;86;85;154;86;85;92;150;86;88;140 23:19:14 INFO - PROCESS | 3790 | |5;imaging-gaussian-blur;118;118;116;117;117;117;117;122;118;118 23:19:14 INFO - PROCESS | 3790 | |6;imaging-darkroom;150;147;147;149;146;146;147;147;150;148 23:19:14 INFO - PROCESS | 3790 | |7;imaging-desaturate;97;99;99;95;100;100;96;95;100;96 23:19:14 INFO - PROCESS | 3790 | |8;json-parse-financial;54;54;56;54;56;55;54;56;55;55 23:19:14 INFO - PROCESS | 3790 | |9;json-stringify-tinderbox;61;61;61;62;63;62;60;61;61;61 23:19:14 INFO - PROCESS | 3790 | |10;stanford-crypto-aes;84;78;83;79;81;81;81;86;109;81 23:19:14 INFO - PROCESS | 3790 | |11;stanford-crypto-ccm;126;124;142;133;122;135;125;137;139;134 23:19:14 INFO - PROCESS | 3790 | |12;stanford-crypto-pbkdf2;162;161;161;159;165;161;162;163;164;157 23:19:14 INFO - PROCESS | 3790 | |13;stanford-crypto-sha256-iterative;69;65;63;63;64;63;64;63;63;64 23:19:14 INFO - PROCESS | 3790 | __end_tp_report 23:19:14 INFO - PROCESS | 3790 | __start_cc_report 23:19:14 INFO - PROCESS | 3790 | _x_x_mozilla_cycle_collect,903 23:19:14 INFO - PROCESS | 3790 | __end_cc_report 23:19:14 INFO - PROCESS | 3790 | __startTimestamp1465021154487__endTimestamp 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | ------- Summary: start ------- 23:19:14 INFO - PROCESS | 3790 | Number of tests: 14 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.21 (2.0%) stddev-sans-first:2.00 23:19:14 INFO - PROCESS | 3790 | Values: 115.0 107.0 112.0 111.0 114.0 112.0 111.0 110.0 112.0 113.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:22.47 (14.5%) stddev-sans-first:23.75 23:19:14 INFO - PROCESS | 3790 | Values: 155.0 124.0 152.0 183.0 128.0 154.0 156.0 131.0 187.0 128.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#2] audio-dft Cycles:10 Average:165.00 Median:166.00 stddev:2.83 (1.7%) stddev-sans-first:2.35 23:19:14 INFO - PROCESS | 3790 | Values: 170.0 166.0 162.0 164.0 167.0 166.0 168.0 162.0 162.0 163.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.86 (49.8%) stddev-sans-first:39.66 23:19:14 INFO - PROCESS | 3790 | Values: 77.0 75.0 76.0 170.0 75.0 77.0 75.0 76.0 161.0 76.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:86.00 stddev:29.80 (34.6%) stddev-sans-first:30.79 23:19:14 INFO - PROCESS | 3790 | Values: 86.0 85.0 154.0 86.0 85.0 92.0 150.0 86.0 88.0 140.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.62 (1.4%) stddev-sans-first:1.72 23:19:14 INFO - PROCESS | 3790 | Values: 118.0 118.0 116.0 117.0 117.0 117.0 117.0 122.0 118.0 118.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.49 (1.0%) stddev-sans-first:1.33 23:19:14 INFO - PROCESS | 3790 | Values: 150.0 147.0 147.0 149.0 146.0 146.0 147.0 147.0 150.0 148.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:96.00 stddev:2.11 (2.2%) stddev-sans-first:2.22 23:19:14 INFO - PROCESS | 3790 | Values: 97.0 99.0 99.0 95.0 100.0 100.0 96.0 95.0 100.0 96.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 23:19:14 INFO - PROCESS | 3790 | Values: 54.0 54.0 56.0 54.0 56.0 55.0 54.0 56.0 55.0 55.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 23:19:14 INFO - PROCESS | 3790 | Values: 61.0 61.0 61.0 62.0 63.0 62.0 60.0 61.0 61.0 61.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:8.98 (11.1%) stddev-sans-first:9.53 23:19:14 INFO - PROCESS | 3790 | Values: 84.0 78.0 83.0 79.0 81.0 81.0 81.0 86.0 109.0 81.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:134.50 stddev:6.96 (5.2%) stddev-sans-first:7.07 23:19:14 INFO - PROCESS | 3790 | Values: 126.0 124.0 142.0 133.0 122.0 135.0 125.0 137.0 139.0 134.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 23:19:14 INFO - PROCESS | 3790 | Values: 162.0 161.0 161.0 159.0 165.0 161.0 162.0 163.0 164.0 157.0 23:19:14 INFO - PROCESS | 3790 | 23:19:14 INFO - PROCESS | 3790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.85 (2.9%) stddev-sans-first:0.73 23:19:14 INFO - PROCESS | 3790 | Values: 69.0 65.0 63.0 63.0 64.0 63.0 64.0 63.0 63.0 64.0 23:19:14 INFO - PROCESS | 3790 | -------- Summary: end -------- 23:19:14 INFO - PROCESS | 3790 | 23:19:15 INFO - TEST-INFO | 3790: exit 0 23:19:15 INFO - TEST-OK | kraken | took 62079ms 23:19:15 INFO - SUITE-END | took 1175s 23:19:15 INFO - Completed test suite (00:19:35) 23:19:15 INFO - javascript benchmark 23:19:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7462.437233429346, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.061801150649, 3098.829564373961, 3125.5936728225342, 3139.168120448081, 3145.072203699907, 5251.553617942474, 5317.255584218207, 5351.57187425006, 5368.812091576786, 5399.9730001350035, 5337.893242135165, 5485.725713714308, 5501.449855014496, 5511.476409741078, 5540.972295138518, 4953.876153096175, 4975.701457912519, 5018.071656743496, 5117.0, 5152.021115987969, 4886.193778026622, 5136.743162841862, 5143.485651434864, 5162.070827251093, 5170.663906846062, 4951.282064100721, 4958.578520825734, 4960.032793605266, 4990.126727822617, 4997.800087996476, 4992.775325110379, 4998.450170481244, 5000.349954505928, 5003.474635163292, 5091.821786237501, 4992.0, 4996.875078123076, 5011.699298042129, 5027.170516864713, 5070.543651071384, 5132.435432102466, 5355.0, 5356.384015838151, 5386.245925570423, 5471.23402723619, 5853.941460585383, 5893.263342082239, 5902.6163299385835, 5904.232449781543, 5911.793087241969, 5928.436798504135, 5945.0, 5945.732442040118, 5989.880202395928, 5995.340512543617, 5227.712475813829, 5419.3225846769155, 5458.863528411782, 5474.972625136888, 5499.340079190482, 5954.523638108941, 5980.5514586405325, 6006.519478441802, 6014.458698717136, 6017.6389416634265, 5618.775248989995, 5776.884462310731, 5794.565407594448, 5802.6808525531505, 5831.825045248649, 5679.346875109332, 5679.574031947621, 5702.572307076985, 5734.053881109654, 5743.4543718346695, 5644.350899646511, 5696.829095127153, 5698.572607054488, 5713.971430142823, 5750.4249575042995, 5710.828675139753, 5758.280214973129, 5758.971205143947, 5777.768889244468, 5789.131630255495, 4301.311790113629, 4341.283688191476, 4413.095315460323, 4415.735055896656, 4436.667249956202, 3926.7447615904875, 3931.6658084063174, 3960.1683646433994, 3972.0467087898696, 4003.2994226010333, 5457.099578569491, 5564.582656300794, 5589.776408943597, 5605.103183490622, 5642.0, 5882.323532793784, 5913.822585322448, 5934.109883517421, 5963.0459126539545, 5974.910376344358, 5695.5443564514735, 5703.486686198262, 5704.429557044263, 5717.799877004285, 5722.799702010409, 4883.926741098886, 4972.651914366032, 5106.974465127651, 5110.054639891632, 5110.744462776846, 5965.105234214902, 5969.432903874125, 6028.608140470856, 6040.275166979991, 6086.60437071589, 5783.479486846204, 5799.94200057994, 5848.824535263949, 5856.326522449803, 5865.973454645506, 5827.679477628772, 5974.970125149346, 5988.28140623128, 6008.068749343859, 6017.638941663339, 5733.799317023884, 5748.48263656273, 5768.1347797828985, 5776.075827867521, 5801.564882633735, 5795.797147099831, 5868.4424979626865, 5872.148538461814, 5875.059990401515, 5877.588568800143, 5496.31296087989, 5654.349749778664, 5657.971710141423, 5685.829425117253, 5696.886062278814, 5552.139418390156, 5603.467670571289, 5619.185218143428, 5652.3217213934595, 5663.943360566506, 5557.388687244481, 5576.860578485408, 5580.302462192226, 5581.888362232814, 5609.27079479665, 5648.717564121695, 5689.943100568941, 5694.288213973254, 5718.542516598579, 5767.884642307215, 5518.503334699896, 5521.944780552143, 5577.051901176728, 5602.635828671123, 5605.383407825055], "value": 5374.541043174518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8006587727235, 621.9782307619234, 623.6663385088976, 641.8587910659656, 657.477305542094, 39173.80413097934, 43908.1459705119, 44010.55989440105, 44084.11831763363, 44356.77821610891, 44221.778891105496, 44507.0, 44875.77562112193, 44895.77552112243, 44901.32648010283, 8573.528455934937, 8718.215360617543, 8729.170728780755, 8810.955945220265, 8827.382083254175, 8568.143185681445, 8689.17452841979, 8691.565421728888, 8694.304455643532, 8697.260732837716, 8701.7824554386, 8761.904761904761, 8772.254358379545, 8772.605232764508, 8785.868211976825, 8557.97304323479, 8635.52504612246, 8660.8700869487, 8675.913240867574, 8738.213560779497, 8625.396222264444, 8657.0, 8685.696000640011, 8690.652373905035, 8738.563071846445, 40580.1883962322, 40856.591434085574, 41008.38487422691, 41204.793976030225, 41222.793886030675, 3217.7747557670973, 3284.8850290239966, 3321.601407831076, 3376.4766461198556, 3774.1508160663907, 32339.83830080858, 32577.837110814533, 32703.18242043944, 34350.14124646879, 34627.0, 4237.749863790158, 4276.893077673052, 4286.485621725413, 4298.849540266076, 4323.308270676708, 241934.0, 243324.0, 244270.0, 244690.0, 244712.0, 58938.0, 59483.70258148682, 59873.0, 59920.400795992355, 59955.0, 35912.46131308033, 36234.0, 36333.27333453316, 38746.6125338743, 38938.0, 17187.398441054753, 17339.306427742747, 17477.213525391388, 17495.212715427835, 17506.824931750518, 13146.737065258832, 13216.207027578184, 13308.73382532344, 13340.399682014333, 13376.665583360495, 19691.60616787656, 19966.401007969784, 19980.700289495668, 20056.899715501622, 20106.798932010784, 7138.6085661303005, 7251.105503784924, 7316.853662926712, 7341.77974660761, 7562.659680314399, 946.6781294359813, 1021.8262895307666, 1061.2836335473523, 1079.3631757263252, 1203.9638810835688, 32362.0, 32366.514502282484, 32429.0, 32632.510512342335, 33040.83479582587, 1125.6285425809463, 1140.5380820767602, 1235.1662627726428, 1237.3256575166556, 1261.2495565138727, 17176.656466870594, 17313.82686173147, 17343.65312693739, 17349.56626084358, 17502.299908003537, 540551.0, 546777.0, 547381.0, 547663.0, 553748.0, 58436.0, 58942.41057589455, 59013.40986590165, 59280.407195928354, 59619.40380596139, 1341.1014620204487, 1347.3532704301795, 1389.8054272402073, 1390.7218556288783, 1394.6931675031476, 31177.68822311748, 31882.840585796923, 32055.839720802178, 32203.677963221005, 33126.503102453, 51790.223146652075, 52027.0, 52054.73972630112, 52056.47943520516, 52086.73956630193, 449489.0, 453384.0, 453544.0, 453761.0, 454313.0, 28076.719232808227, 28343.716562834106, 28564.42871142607, 28607.28481787972, 28677.85661071681, 48769.0, 50206.246906297165, 50847.0, 51011.48988510067, 51228.23157652713, 42344.788276058425, 43171.78414107909, 43841.34237986497, 44145.55854441415, 44458.777706111265, 42063.3690494649, 42467.1506569873, 42537.0, 43289.3506597395, 43920.78039609781, 41835.0, 42085.57914420817, 42647.360289596305, 42980.0, 44887.55112448834, 34696.82651586726, 38477.42283865688, 38584.80707596444, 38690.80654596822, 39112.41331379975, 28820.711792881804, 29132.27169320784, 29316.41367172602, 29617.0, 29624.111276661733], "value": 19988.35890043114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.28395037082134, 393.0762707637055, 396.0889953107853, 396.57764480827916, 415.0805964787994, 13459.730805383886, 18096.18567164481, 18320.541986450327, 19014.809851901493, 19052.047397630115, 18045.548861278476, 18174.182161802717, 18416.907915460404, 19256.711149332736, 19298.61402771947, 5220.112580861262, 5467.562594992401, 5525.060739674245, 5570.8607284818, 5651.943480565204, 5493.890122197554, 5532.0, 5536.086545719952, 6686.899696504532, 7122.074130363046, 7104.893426598605, 7250.2024777274455, 7258.709651613929, 7260.419166466696, 7261.709531618729, 7121.608311542863, 7265.273472652692, 7302.37929775967, 7306.123265208156, 7316.634168291617, 6285.779997700059, 6732.360425759545, 6757.526973111884, 6936.09830722008, 6979.89530157048, 24543.877280613484, 24550.0, 24838.5032299353, 25933.74066259332, 26181.083662071927, 2275.1240772302617, 2318.8260880434036, 2389.880505974712, 2442.6336049592524, 2459.32368598635, 14434.927825360806, 15417.922910385376, 15438.768418473732, 15945.521634350987, 16022.278997445143, 1951.2390167834556, 2065.9586808263903, 2114.7990940860595, 2146.8497205195645, 2218.2901471529117, 89593.55203223941, 89681.0, 89719.0, 91454.5427272866, 92760.53619731926, 17086.48740537786, 17363.913180434018, 17575.02449167289, 18012.279508819764, 18091.0, 31457.8427107863, 31486.527702084488, 31509.684903151134, 31666.525002124985, 31744.36511269762, 9847.901520984698, 9939.850902236472, 10180.185585153169, 10267.435291059064, 10373.84439233412, 8525.65897364111, 8629.568521573896, 8701.564921753887, 8790.780230494289, 8867.73396798097, 8610.0, 8784.597472554333, 8842.513661748666, 8876.467411955304, 8894.93260808707, 3313.486409606515, 3375.696187343151, 3513.1744040150543, 3601.1897323102094, 3625.2930678517964, 982.9655962041294, 1015.2284263959444, 1026.58423338548, 1077.4881931082673, 1079.4764539198482, 18182.090895455174, 18455.446336609653, 19054.904725476285, 19088.14103365352, 19312.4206273812, 1027.9588816447258, 1054.9314294570981, 1064.771074219031, 1080.6325849211305, 1084.4089970965842, 10470.319429237075, 10576.841347379795, 10694.572217111385, 10793.892061079288, 10829.801695186356, 448607.0, 451664.0, 454659.0, 456984.0, 474873.0, 53743.0, 66988.33011669919, 71731.0, 78034.21965780383, 82795.0, 990.4255531791543, 996.8155891160013, 1002.664107523973, 1023.1763430438419, 1023.6007956896816, 16825.41111061107, 17170.313187472362, 17194.0, 17197.226124824163, 17547.298108075534, 28579.857100714362, 32997.83501082479, 33605.0, 39136.0, 40105.79947100246, 52266.47733522768, 55218.72390638021, 55778.72110639421, 55954.72022639861, 56005.59986000383, 8037.874697542466, 8299.792505187177, 8363.49819010837, 8385.077641459557, 8422.831543368975, 12591.181573197713, 12729.681757955756, 12805.359732013549, 12906.80639790385, 12910.935445322713, 10909.18181136402, 11127.499262533043, 11192.0, 11535.653930382103, 11549.133814963743, 10922.453877305945, 11130.553028106295, 11227.71930701739, 11290.830637540608, 11359.602413915472, 10716.678499645022, 11076.280041797258, 11287.20989530725, 11346.773064538827, 11575.652730418102, 7435.7025718970635, 7720.150783413707, 8542.06037335905, 8591.871121933302, 8702.47785132894, 11241.775164496828, 11671.708207294885, 11804.940975295069, 11910.344931028876, 12203.206791558876], "value": 10095.666084138093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.1500444746491, 1494.4097081652747, 1680.9831901680986, 1757.5606098475382, 1788.695921693312, 7942.761717148494, 8702.825943481135, 8775.648974041047, 9269.026752191015, 9276.0, 8768.079351668079, 9015.954920225406, 9064.320175986812, 9081.046490118542, 9113.407628504143, 2423.357810180299, 2460.1758410932357, 2463.4949835283815, 2463.5442443148077, 2464.8397854139425, 2389.64155376694, 2461.679981602389, 2470.8641024743633, 2476.071473197551, 2476.170482888235, 2396.6165413533836, 2403.158894386968, 2443.743406942272, 2447.437089469423, 2452.865092419916, 2418.9153379631716, 2443.2670198940336, 2444.7555244475498, 2457.8771061447037, 2480.379905023744, 2351.776581224781, 2359.0, 2361.740208577055, 2367.3726462487452, 2367.798737107331, 9052.230560402373, 9059.864102038475, 9116.0, 9131.406458580172, 9138.040505746934, 5325.494078062617, 5422.0, 5462.945370546284, 5476.424975377608, 5484.424135465799, 3547.5565554305713, 3567.2865426914464, 3600.3519366514015, 3617.0595645132457, 3751.268502641986, 1222.9021678265806, 1240.4542001519303, 1252.4051075739042, 1260.514701839789, 1274.5093139141404, 12752.617421477371, 12801.93599031999, 12860.678483037906, 12861.67845803853, 12868.485260589565, 4727.149113159596, 4865.464798872121, 4936.777844996984, 4939.506049395031, 4969.503049695001, 10740.194485413625, 10789.514471848786, 10799.352038877692, 10829.620963266405, 10853.077488413574, 5425.0, 5469.972650136724, 5493.368262649847, 5496.972515137399, 5515.034868897927, 4432.445944256968, 4806.711597304173, 4951.257311403318, 4961.404631444249, 5099.23511473282, 4076.8369265229057, 4123.558018828167, 4138.958610413857, 4159.625633692982, 4181.205570941512, 1281.2440660010639, 1295.8768916952874, 1308.2739079810797, 1314.4413624209672, 1328.621342917264, 923.7459698582943, 1009.8232809258351, 1031.6956497833157, 1040.193849766437, 1046.4663021858908, 6091.878162436815, 6231.189945307081, 6264.498840092781, 6299.244090709144, 6329.905051424233, 461.83835657520274, 462.8411094281542, 465.3368949247309, 467.22440748357565, 483.07732231437785, 4341.261985462415, 4385.298352263622, 4401.713888597231, 4422.380866678667, 4432.246518091933, 10935.781284374269, 11208.21542492034, 11287.153463490107, 11341.943290283496, 11362.545498180145, 10561.419121948213, 10998.890011099948, 11003.834942475869, 11245.381504017358, 11343.092552595772, 8460.788480288042, 8573.957130214434, 8580.613872375758, 8583.742487725378, 8584.527850968258, 5944.762209511571, 5986.730597123227, 6170.50635949132, 6197.845053873689, 6249.625022498482, 10132.645357412455, 10223.386596804216, 10238.436885971045, 10397.428141452292, 10458.058774710313, 10425.426601536685, 10624.0, 10832.079273261861, 10868.891311086787, 10926.180536459957, 7332.706691732271, 8196.38527110481, 8213.79465513343, 8320.875186872323, 8498.107698691549, 8594.269487093667, 8793.384463087523, 8801.47191168532, 8809.251213646912, 8857.3799834011, 7486.9625651873575, 7603.239676032353, 7630.847383052419, 7729.458937874295, 8083.9191608083165, 7495.550266983998, 7635.618219089134, 7687.0, 7714.074311082706, 7763.961180194063, 6993.720251190099, 7130.42956563484, 7140.428765698628, 7154.177269614061, 7173.354398104196, 5007.5993920487, 5150.742462876916, 5173.198154286091, 5351.063563876384, 5419.674819510842, 5167.0, 5221.242919776687, 5296.576273898156, 5309.57523398135, 5335.146376579729], "value": 4720.442040198062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.27566801700215, 326.9280758233189, 327.65268815056044, 332.97336213102955, 335.4950799047433, 5564.749586268617, 5632.633878797876, 5668.291463567054, 5698.829035128942, 5721.284839395075, 5552.4169962154, 5564.0, 5581.441855814416, 5597.132444471104, 5658.0, 4149.630621894783, 4283.785810709468, 4295.613394794468, 4325.426371309082, 4347.913041739163, 4327.285997810358, 4334.436523251973, 4349.173657005174, 4376.934345984797, 4391.9121617567625, 4336.284513055358, 4370.125974805036, 4383.868483945486, 4385.956140438602, 4399.978000109995, 4199.895002624943, 4315.180115777992, 4345.369921361416, 4346.891327716832, 4358.4527492739935, 3804.961950380516, 3838.560539797576, 3840.423936409533, 3871.6515513603913, 3902.824372903198, 5322.5209731124, 5336.493033161843, 5366.865828354284, 5420.807422367073, 5425.647332923387, 4809.807607695723, 4990.675606085593, 4991.301217829507, 5001.824936127218, 5018.824341148043, 5718.513926316268, 5739.62692424991, 5757.280339957505, 5802.709864506758, 5834.854128646775, 4250.128723611652, 4252.149570085995, 4253.978730106361, 4267.698352002638, 4268.765217913014, 5843.620164689324, 6068.484178844804, 6115.143879856823, 6129.448349648553, 6166.722497487579, 4253.553376895381, 4254.936175957363, 4259.1268789897995, 4260.467441569804, 4272.188284225987, 4291.141771645684, 4292.18448494785, 4297.78511074445, 4305.74165550068, 4351.69538132334, 4801.975990120097, 4923.236898280772, 4923.86751047254, 4931.87670308238, 5016.372953380827, 5892.410758924073, 5944.7027648617395, 5960.64236145824, 5962.880742385128, 5982.0, 1473.7568301230176, 1488.5311126994961, 1500.887433442496, 1515.0076699761673, 1515.4847351900187, 954.6754103604808, 963.393062370702, 982.4449186209769, 987.3286165407449, 996.1632228927735, 5567.693776842231, 5627.127795191752, 5637.577181711388, 5651.971740141273, 5693.743781529841, 5979.996701105091, 5998.310194327708, 6023.45788879003, 6038.9396106038375, 6075.392460753889, 5389.191621256765, 5668.441178675815, 5756.625819321731, 5773.595848290579, 5792.913106303409, 3243.5621191139367, 3249.6262929762906, 3276.7057012480414, 3282.7209687176855, 3297.7856439331367, 6120.571559990847, 6308.337624549448, 6362.936370636327, 6371.076193951943, 6377.0, 6201.844953876099, 6205.81382558524, 6268.840264551072, 6271.937280627227, 6278.215223097113, 5818.6035351516175, 6146.846328841814, 6185.536084793658, 6186.659733714599, 6189.535784816157, 5969.611975221596, 6027.276726792637, 6029.939700602938, 6051.818445446644, 6121.969390153021, 5943.910841337297, 6074.817755467343, 6087.847803804763, 6089.604175728564, 6126.908096378647, 5988.0, 6216.844578885564, 6265.906011409741, 6353.0, 6360.77737279193, 4266.210751011073, 4281.2293787118615, 4318.978405107954, 4321.7406955582765, 4322.78386080701, 5901.468867801918, 6030.75876964934, 6037.516998640011, 6054.212952316171, 6141.170941922962, 5885.117232415172, 5886.3525012247765, 5904.498117660047, 5910.0, 5950.613210141327, 5857.384974577608, 5885.234919460614, 5892.587518873637, 5896.587238893237, 5909.556783241188, 5659.302209337265, 5720.338983050768, 5785.4214578541805, 5866.5893387462465, 5873.2658417697785, 5971.223740913653, 6022.337542870368, 6028.156058151774, 6055.212822333068, 6078.270607527125, 5592.189132575835, 5833.212516310414, 5867.794627188028, 5929.347771745191, 5932.525397968066], "value": 4481.057050179333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.427429427929, 783.4946459533601, 806.395203597302, 830.5099991005308, 866.8179682266725, 14490.420383184673, 15715.52853414398, 15764.211789410512, 15793.368265269375, 15965.12191829449, 15050.0, 15165.014274072177, 15172.848271517281, 15203.315850786714, 15239.77140342893, 680.5202332355677, 797.7766225456852, 801.1227705662305, 816.4978538199024, 817.3461231015164, 805.5972013993004, 806.6853926968487, 809.348474478045, 810.4893916832388, 816.848882956655, 850.2560259772699, 852.1180578101666, 853.8164294676643, 855.9657613695445, 858.1418581418582, 853.6158728572167, 853.7865533616596, 853.8249658819958, 854.4403415762686, 854.5385491834402, 621.574221658161, 622.9345918678564, 623.2987888625297, 623.5697368815503, 624.2914292278297, 14402.279886005763, 14554.126752394784, 14691.265436728228, 14699.55901322962, 14704.411823527045, 15467.92266038674, 15685.686286274211, 15689.676539843847, 15813.446529371531, 15969.281382337707, 11885.643430697093, 12181.695457613541, 12570.120091593591, 12927.353632318347, 13068.215907045607, 4616.884577885546, 4622.815087396534, 4631.884202894955, 4671.34601155835, 4751.121042607128, 69905.65047174782, 69985.0, 70452.6477367615, 70689.29310706879, 71190.0, 11872.643820685393, 11932.463039163258, 11939.761204775856, 12002.459889305002, 12157.331346776013, 21392.144314227568, 21455.14179432805, 21526.0, 21585.352439426842, 22107.226247081595, 8170.692190732641, 8282.1303763104, 8330.66677332912, 8624.396292259607, 8829.072947340564, 4839.879003024953, 4924.827631032968, 5048.7728052237735, 5164.3802743671, 5186.948130518722, 3740.5698344690163, 3901.765894046366, 3913.3347330953807, 3913.9021524462114, 3914.119323152325, 649.7660842096841, 650.4796163069525, 659.0871642774696, 666.7066490744057, 671.2649648634737, 682.7644462660375, 705.1784670858392, 755.2787088330631, 786.6853258696567, 806.7015204374419, 9966.651167209258, 10183.54584182631, 10236.48817559134, 10441.477926103664, 10482.790344193227, 543.1689515041992, 558.7346010644992, 675.1324547955951, 706.3113464372299, 726.2895880202153, 5052.797888084436, 5126.1798112302595, 5197.168453047494, 5215.921761173586, 5256.237845512379, 62441.0, 63013.0, 65825.0, 82695.7595636066, 119456.40271798585, 58071.0, 58437.12344314839, 67526.66236668786, 67856.6607166971, 92302.53848730848, 87452.5627371859, 90736.0, 91985.0, 92330.0, 93036.53481732548, 9516.809663806824, 9718.75703107428, 9750.561224744763, 9841.507924603884, 9940.502974851373, 52577.7371113142, 52793.0, 53374.73312633412, 54485.45514544804, 54923.176152356944, 72808.27191728014, 74866.62566687132, 75952.79222789142, 77615.2238477608, 78904.0, 12085.214461060003, 12210.877891220975, 12373.381330933596, 12457.688557786129, 12964.8055279169, 13681.670025627707, 13789.931050344683, 13986.44054237819, 14103.153810771386, 14155.929220353832, 13332.533361332307, 13366.131201471873, 13845.169289842239, 14108.647283817987, 14109.6472588182, 12972.610821675366, 13260.513271506437, 13538.120022198525, 13730.588082357544, 14149.929250353682, 13135.605931822061, 13136.671583210496, 13585.456581737015, 13660.521881734092, 13667.111637743516, 11103.72240693989, 11131.220814542905, 11264.436778161224, 11277.548898043986, 11310.660680179608, 9880.209583233467, 10039.648612298535, 10143.239257055602, 10201.234907381828, 10230.795384092426], "value": 7527.045314689145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 112.0, 111.0, 114.0, 112.0, 111.0, 110.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 152.0, 183.0, 128.0, 154.0, 156.0, 131.0, 187.0, 128.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 162.0, 164.0, 167.0, 166.0, 168.0, 162.0, 162.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 170.0, 75.0, 77.0, 75.0, 76.0, 161.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 154.0, 86.0, 85.0, 92.0, 150.0, 86.0, 88.0, 140.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 122.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 149.0, 146.0, 146.0, 147.0, 147.0, 150.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 99.0, 95.0, 100.0, 100.0, 96.0, 95.0, 100.0, 96.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 56.0, 55.0, 54.0, 56.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 60.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 83.0, 79.0, 81.0, 81.0, 81.0, 86.0, 109.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 142.0, 133.0, 122.0, 135.0, 125.0, 137.0, 139.0, 134.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 159.0, 165.0, 161.0, 162.0, 163.0, 164.0, 157.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 23:19:15 INFO - Return code: 0 23:19:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:19:15 ERROR - # TBPL SUCCESS # 23:19:15 INFO - Running post-action listener: _resource_record_post_action 23:19:15 INFO - ##### 23:19:15 INFO - ##### Finished run-tests step (success) 23:19:15 INFO - ##### 23:19:15 INFO - Running post-run listener: _resource_record_post_run 23:19:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7856128; Write bytes: 449908736; Read time: 940; Write time: 380048 23:19:15 INFO - TinderboxPrint: CPU usage
13.4% 23:19:15 INFO - TinderboxPrint: I/O read bytes / time
7,856,128 / 940 23:19:15 INFO - TinderboxPrint: I/O write bytes / time
449,908,736 / 380,048 23:19:15 INFO - TinderboxPrint: CPU idle
8,243.2 (86.6%) 23:19:15 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 23:19:15 INFO - TinderboxPrint: Swap in / out
0 / 0 23:19:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20590592; Read time: 0; Write time: 11804 23:19:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6094848; Write bytes: 429318144; Read time: 884; Write time: 368244 23:19:16 INFO - Running post-run listener: _upload_blobber_files 23:19:16 INFO - Blob upload gear active. 23:19:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:19:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:19:16 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:19:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:19:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:17 INFO - (blobuploader) - INFO - Done attempting. 23:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:18 INFO - (blobuploader) - INFO - Done attempting. 23:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:22 INFO - (blobuploader) - INFO - Done attempting. 23:19:22 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:22 INFO - Return code: 0 23:19:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:19:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b2350ad0e37cda959790d8b9a8b90b9fccfe00eb4ae30383ccb354d4afe2e9a1999ee6b9dc971c2538686282f84b43921696deac4eb6456a2ee189ee25ad5ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ab192323f652a040c7919e6258af6cdb657886255c504fab57256ebe7525a82d92cc56f2e445c9d2a49a13762cfed2a022bcba666bea0d528467d323a567dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e404d84ba4e62f4a564c89f24430b71d5b7b450f17325b5361666913ab010db936ccce191a0cac34bf62e45416d79910e98ee25ab27baaa731fe86c7933f7ce6"} 23:19:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:19:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:19:22 INFO - Contents: 23:19:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b2350ad0e37cda959790d8b9a8b90b9fccfe00eb4ae30383ccb354d4afe2e9a1999ee6b9dc971c2538686282f84b43921696deac4eb6456a2ee189ee25ad5ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ab192323f652a040c7919e6258af6cdb657886255c504fab57256ebe7525a82d92cc56f2e445c9d2a49a13762cfed2a022bcba666bea0d528467d323a567dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e404d84ba4e62f4a564c89f24430b71d5b7b450f17325b5361666913ab010db936ccce191a0cac34bf62e45416d79910e98ee25ab27baaa731fe86c7933f7ce6"} 23:19:22 INFO - Running post-run listener: copy_logs_to_upload_dir 23:19:22 INFO - Copying logs to upload dir... 23:19:22 INFO - mkdir: /builds/slave/test/build/upload/logs 23:19:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.347138 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-03 23:19:22.496512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 23:19:22.499910) ========= 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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b2350ad0e37cda959790d8b9a8b90b9fccfe00eb4ae30383ccb354d4afe2e9a1999ee6b9dc971c2538686282f84b43921696deac4eb6456a2ee189ee25ad5ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ab192323f652a040c7919e6258af6cdb657886255c504fab57256ebe7525a82d92cc56f2e445c9d2a49a13762cfed2a022bcba666bea0d528467d323a567dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e404d84ba4e62f4a564c89f24430b71d5b7b450f17325b5361666913ab010db936ccce191a0cac34bf62e45416d79910e98ee25ab27baaa731fe86c7933f7ce6"} build_url:https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/QA-5G66oT2GDCH7QQTLHPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b2350ad0e37cda959790d8b9a8b90b9fccfe00eb4ae30383ccb354d4afe2e9a1999ee6b9dc971c2538686282f84b43921696deac4eb6456a2ee189ee25ad5ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ab192323f652a040c7919e6258af6cdb657886255c504fab57256ebe7525a82d92cc56f2e445c9d2a49a13762cfed2a022bcba666bea0d528467d323a567dc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e404d84ba4e62f4a564c89f24430b71d5b7b450f17325b5361666913ab010db936ccce191a0cac34bf62e45416d79910e98ee25ab27baaa731fe86c7933f7ce6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 23:19:22.524785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 23:19:22.525111) ========= 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=7de08804244eb36560b44971000001c3-1465016645.91306-1414977163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004366 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 23:19:22.609622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 23:19:22.609946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 23:19:22.610216) ========= ========= Total master_lag: 0.19 =========