builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1466528366.3 results: success (0) buildid: 20160621073315 builduid: c2564c366b334454b14b40f2544bb8a7 revision: 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.304916) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.305706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.306150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.350763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.351042) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 09:59:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-21 09:59:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.495884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.496217) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014845 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.546462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:26.546829) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 --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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 09:59:26,775 truncating revision to first 12 chars 2016-06-21 09:59:26,775 Setting DEBUG logging. 2016-06-21 09:59:26,775 attempt 1/10 2016-06-21 09:59:26,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/14ac8b409bcd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 09:59:27,078 unpacking tar archive at: mozilla-inbound-14ac8b409bcd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:27.204942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:27.205461) ========= script_repo_revision: 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:27.206118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:27.206535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 09:59:27.218105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-21 09:59:27.219386) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:27 INFO - MultiFileLogger online at 20160621 09:59:27 in /builds/slave/test 09:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:27 INFO - {'append_to_log': False, 09:59:27 INFO - 'base_work_dir': '/builds/slave/test', 09:59:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:27 INFO - 'branch': 'Mozilla-Inbound', 09:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:27 INFO - 'config_files': ('talos/linux_config.py',), 09:59:27 INFO - 'default_actions': ('clobber', 09:59:27 INFO - 'read-buildbot-config', 09:59:27 INFO - 'download-and-extract', 09:59:27 INFO - 'populate-webroot', 09:59:27 INFO - 'create-virtualenv', 09:59:27 INFO - 'install', 09:59:27 INFO - 'run-tests'), 09:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:27 INFO - 'download_minidump_stackwalk': True, 09:59:27 INFO - 'download_symbols': 'ondemand', 09:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:27 INFO - 'installer_path': 'installer.exe', 09:59:27 INFO - 'log_level': 'info', 09:59:27 INFO - 'log_name': 'talos', 09:59:27 INFO - 'log_to_console': True, 09:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:27 INFO - 'opt_config_files': (), 09:59:27 INFO - 'pip_index': False, 09:59:27 INFO - 'sps_profile': False, 09:59:27 INFO - 'sps_profile_interval': 0, 09:59:27 INFO - 'suite': 'dromaeojs', 09:59:27 INFO - 'system_bits': '32', 09:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:27 INFO - 'title': 'talos-linux64-ix-064', 09:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:27 INFO - 'use_talos_json': True, 09:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:27 INFO - 'work_dir': 'build'} 09:59:27 INFO - ##### 09:59:27 INFO - ##### Running clobber step. 09:59:27 INFO - ##### 09:59:27 INFO - Running pre-action listener: _resource_record_pre_action 09:59:27 INFO - Running main action method: clobber 09:59:27 INFO - rmtree: /builds/slave/test/build 09:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:28 INFO - Running post-action listener: _resource_record_post_action 09:59:28 INFO - ##### 09:59:28 INFO - ##### Finished clobber step (success) 09:59:28 INFO - ##### 09:59:28 INFO - ##### 09:59:28 INFO - ##### Running read-buildbot-config step. 09:59:28 INFO - ##### 09:59:28 INFO - Running pre-action listener: _resource_record_pre_action 09:59:28 INFO - Running main action method: read_buildbot_config 09:59:28 INFO - Using buildbot properties: 09:59:28 INFO - { 09:59:28 INFO - "project": "", 09:59:28 INFO - "product": "firefox", 09:59:28 INFO - "script_repo_revision": "production", 09:59:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:59:28 INFO - "repository": "", 09:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:59:28 INFO - "buildid": "20160621073315", 09:59:28 INFO - "pgo_build": "True", 09:59:28 INFO - "basedir": "/builds/slave/test", 09:59:28 INFO - "buildnumber": 1143, 09:59:28 INFO - "slavename": "talos-linux64-ix-064", 09:59:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:59:28 INFO - "platform": "ubuntu64_hw", 09:59:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:59:28 INFO - "branch": "mozilla-inbound", 09:59:28 INFO - "repo_path": "integration/mozilla-inbound", 09:59:28 INFO - "revision": "14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69", 09:59:28 INFO - "stage_platform": "linux64-pgo", 09:59:28 INFO - "builduid": "c2564c366b334454b14b40f2544bb8a7", 09:59:28 INFO - "slavebuilddir": "test" 09:59:28 INFO - } 09:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:59:28 INFO - Running post-action listener: _resource_record_post_action 09:59:28 INFO - ##### 09:59:28 INFO - ##### Finished read-buildbot-config step (success) 09:59:28 INFO - ##### 09:59:28 INFO - ##### 09:59:28 INFO - ##### Running download-and-extract step. 09:59:28 INFO - ##### 09:59:28 INFO - Running pre-action listener: _resource_record_pre_action 09:59:28 INFO - Running main action method: download_and_extract 09:59:28 INFO - mkdir: /builds/slave/test/build/tests 09:59:28 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')]} 09:59:28 INFO - https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:59:39 INFO - Downloaded 1361 bytes. 09:59:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:59:39 INFO - Using the following test package requirements: 09:59:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:59:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'jsshell-linux-x86_64.zip'], 09:59:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:59:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:59:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:59:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:59:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59:39 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')]} 09:59:39 INFO - https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:52 INFO - Downloaded 24225496 bytes. 09:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:59:53 INFO - Return code: 0 09:59:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:53 INFO - https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:54 INFO - Downloaded 24225496 bytes. 09:59:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:59:56 INFO - Return code: 0 09:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:56 INFO - https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:00 INFO - Downloaded 14405384 bytes. 10:00:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:00:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:00:00 INFO - Return code: 0 10:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:00 INFO - https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:00:02 INFO - Downloaded 60139391 bytes. 10:00:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:02 INFO - mkdir: /builds/slave/test/properties 10:00:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:02 INFO - Contents: 10:00:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:00:03 INFO - Running post-action listener: _resource_record_post_action 10:00:03 INFO - Running post-action listener: set_extra_try_arguments 10:00:03 INFO - ##### 10:00:03 INFO - ##### Finished download-and-extract step (success) 10:00:03 INFO - ##### 10:00:03 INFO - ##### 10:00:03 INFO - ##### Running populate-webroot step. 10:00:03 INFO - ##### 10:00:03 INFO - Running pre-action listener: _resource_record_pre_action 10:00:03 INFO - Running main action method: populate_webroot 10:00:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:03 INFO - '--tppagecycles', 10:00:03 INFO - '7'], 10:00:03 INFO - 'tests': ['tsvgm']}}, 10:00:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['damp', 'tps']}, 10:00:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'tests': ['damp', 'tps']}, 10:00:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['dromaeo_dom']}, 10:00:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['basic_compositor_video']}, 10:00:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['a11yr', 10:00:03 INFO - 'ts_paint', 10:00:03 INFO - 'tpaint', 10:00:03 INFO - 'sessionrestore', 10:00:03 INFO - 'sessionrestore_no_auto_restore', 10:00:03 INFO - 'tabpaint']}, 10:00:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['tsvgx', 10:00:03 INFO - 'tsvgr_opacity', 10:00:03 INFO - 'tart', 10:00:03 INFO - 'tscrollx', 10:00:03 INFO - 'cart']}, 10:00:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:03 INFO - 'tsvgr_opacity', 10:00:03 INFO - 'tart', 10:00:03 INFO - 'tscrollx', 10:00:03 INFO - 'cart']}, 10:00:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'talos_options': ['--disable-e10s'], 10:00:03 INFO - 'tests': ['tp5o']}, 10:00:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'tests': ['tp5o']}, 10:00:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'talos_options': ['--disable-e10s', 10:00:03 INFO - '--xperf_path', 10:00:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:03 INFO - 'tests': ['tp5n']}, 10:00:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:03 INFO - 'talos_options': ['--xperf_path', 10:00:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:03 INFO - 'tests': ['tp5n']}}, 10:00:03 INFO - 'talos.zip': {'path': '', 10:00:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:03 INFO - Running post-action listener: _resource_record_post_action 10:00:03 INFO - ##### 10:00:03 INFO - ##### Finished populate-webroot step (success) 10:00:03 INFO - ##### 10:00:03 INFO - ##### 10:00:03 INFO - ##### Running create-virtualenv step. 10:00:03 INFO - ##### 10:00:03 INFO - Running pre-action listener: _resource_record_pre_action 10:00:03 INFO - Running main action method: create_virtualenv 10:00:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:03 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 10:00:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:03 INFO - Using real prefix '/usr' 10:00:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:06 INFO - Installing pip.................done. 10:00:06 INFO - Return code: 0 10:00:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:06 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 10:00:06 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 10:00:06 INFO - Using env: {'DISPLAY': ':0', 10:00:06 INFO - 'HOME': '/home/cltbld', 10:00:06 INFO - 'LANG': 'en_US.UTF-8', 10:00:06 INFO - 'LANGUAGE': 'en_US:en', 10:00:06 INFO - 'LOGNAME': 'cltbld', 10:00:06 INFO - 'MAIL': '/var/mail/cltbld', 10:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:06 INFO - 'MOZ_NO_REMOTE': '1', 10:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:06 INFO - 'NO_EM_RESTART': '1', 10:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:06 INFO - 'PWD': '/builds/slave/test', 10:00:06 INFO - 'SHELL': '/bin/bash', 10:00:06 INFO - 'SHLVL': '1', 10:00:06 INFO - 'TERM': 'linux', 10:00:06 INFO - 'TMOUT': '86400', 10:00:06 INFO - 'USER': 'cltbld', 10:00:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:06 INFO - '_': '/tools/buildbot/bin/python'} 10:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:06 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 10:00:06 INFO - Cleaning up... 10:00:06 INFO - Return code: 0 10:00:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:06 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:06 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 10:00:06 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 10:00:06 INFO - Using env: {'DISPLAY': ':0', 10:00:06 INFO - 'HOME': '/home/cltbld', 10:00:06 INFO - 'LANG': 'en_US.UTF-8', 10:00:06 INFO - 'LANGUAGE': 'en_US:en', 10:00:06 INFO - 'LOGNAME': 'cltbld', 10:00:06 INFO - 'MAIL': '/var/mail/cltbld', 10:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:06 INFO - 'MOZ_NO_REMOTE': '1', 10:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:06 INFO - 'NO_EM_RESTART': '1', 10:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:06 INFO - 'PWD': '/builds/slave/test', 10:00:06 INFO - 'SHELL': '/bin/bash', 10:00:06 INFO - 'SHLVL': '1', 10:00:06 INFO - 'TERM': 'linux', 10:00:06 INFO - 'TMOUT': '86400', 10:00:06 INFO - 'USER': 'cltbld', 10:00:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:06 INFO - '_': '/tools/buildbot/bin/python'} 10:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:06 INFO - Downloading/unpacking psutil>=3.1.1 10:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:08 INFO - Installing collected packages: psutil 10:00:08 INFO - Running setup.py install for psutil 10:00:08 INFO - building 'psutil._psutil_linux' extension 10:00:08 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 10:00:08 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 10:00:08 INFO - building 'psutil._psutil_posix' extension 10:00:08 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 10:00:09 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 10:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:09 INFO - Successfully installed psutil 10:00:09 INFO - Cleaning up... 10:00:09 INFO - Return code: 0 10:00:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:09 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:09 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 10:00:09 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 10:00:09 INFO - Using env: {'DISPLAY': ':0', 10:00:09 INFO - 'HOME': '/home/cltbld', 10:00:09 INFO - 'LANG': 'en_US.UTF-8', 10:00:09 INFO - 'LANGUAGE': 'en_US:en', 10:00:09 INFO - 'LOGNAME': 'cltbld', 10:00:09 INFO - 'MAIL': '/var/mail/cltbld', 10:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:09 INFO - 'MOZ_NO_REMOTE': '1', 10:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:09 INFO - 'NO_EM_RESTART': '1', 10:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:09 INFO - 'PWD': '/builds/slave/test', 10:00:09 INFO - 'SHELL': '/bin/bash', 10:00:09 INFO - 'SHLVL': '1', 10:00:09 INFO - 'TERM': 'linux', 10:00:09 INFO - 'TMOUT': '86400', 10:00:09 INFO - 'USER': 'cltbld', 10:00:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:09 INFO - '_': '/tools/buildbot/bin/python'} 10:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:11 INFO - Installing collected packages: mozsystemmonitor 10:00:11 INFO - Running setup.py install for mozsystemmonitor 10:00:11 INFO - Successfully installed mozsystemmonitor 10:00:11 INFO - Cleaning up... 10:00:11 INFO - Return code: 0 10:00:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:11 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:11 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 10:00:11 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 10:00:11 INFO - Using env: {'DISPLAY': ':0', 10:00:11 INFO - 'HOME': '/home/cltbld', 10:00:11 INFO - 'LANG': 'en_US.UTF-8', 10:00:11 INFO - 'LANGUAGE': 'en_US:en', 10:00:11 INFO - 'LOGNAME': 'cltbld', 10:00:11 INFO - 'MAIL': '/var/mail/cltbld', 10:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:11 INFO - 'MOZ_NO_REMOTE': '1', 10:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:11 INFO - 'NO_EM_RESTART': '1', 10:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:11 INFO - 'PWD': '/builds/slave/test', 10:00:11 INFO - 'SHELL': '/bin/bash', 10:00:11 INFO - 'SHLVL': '1', 10:00:11 INFO - 'TERM': 'linux', 10:00:11 INFO - 'TMOUT': '86400', 10:00:11 INFO - 'USER': 'cltbld', 10:00:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:11 INFO - '_': '/tools/buildbot/bin/python'} 10:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:11 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:13 INFO - warning: no files found matching '*.txt' 10:00:13 INFO - no previously-included directories found matching 'build' 10:00:13 INFO - no previously-included directories found matching 'dist' 10:00:13 INFO - no previously-included directories found matching '.git*' 10:00:13 INFO - Installing collected packages: jsonschema, functools32 10:00:14 INFO - Running setup.py install for functools32 10:00:14 INFO - warning: no files found matching '*.txt' 10:00:14 INFO - no previously-included directories found matching 'build' 10:00:14 INFO - no previously-included directories found matching 'dist' 10:00:14 INFO - no previously-included directories found matching '.git*' 10:00:14 INFO - Successfully installed jsonschema functools32 10:00:14 INFO - Cleaning up... 10:00:14 INFO - Return code: 0 10:00:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:14 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:14 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 10:00:14 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 10:00:14 INFO - Using env: {'DISPLAY': ':0', 10:00:14 INFO - 'HOME': '/home/cltbld', 10:00:14 INFO - 'LANG': 'en_US.UTF-8', 10:00:14 INFO - 'LANGUAGE': 'en_US:en', 10:00:14 INFO - 'LOGNAME': 'cltbld', 10:00:14 INFO - 'MAIL': '/var/mail/cltbld', 10:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:14 INFO - 'MOZ_NO_REMOTE': '1', 10:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:14 INFO - 'NO_EM_RESTART': '1', 10:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:14 INFO - 'PWD': '/builds/slave/test', 10:00:14 INFO - 'SHELL': '/bin/bash', 10:00:14 INFO - 'SHLVL': '1', 10:00:14 INFO - 'TERM': 'linux', 10:00:14 INFO - 'TMOUT': '86400', 10:00:14 INFO - 'USER': 'cltbld', 10:00:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:14 INFO - '_': '/tools/buildbot/bin/python'} 10:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:14 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:14 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 10:00:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:16 INFO - Downloading docopt-0.6.1.tar.gz 10:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:17 INFO - Running setup.py install for blobuploader 10:00:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:17 INFO - Running setup.py install for requests 10:00:17 INFO - Running setup.py install for docopt 10:00:17 INFO - Successfully installed blobuploader requests docopt 10:00:17 INFO - Cleaning up... 10:00:17 INFO - Return code: 0 10:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:17 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 10:00:17 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 10:00:17 INFO - Using env: {'DISPLAY': ':0', 10:00:17 INFO - 'HOME': '/home/cltbld', 10:00:17 INFO - 'LANG': 'en_US.UTF-8', 10:00:17 INFO - 'LANGUAGE': 'en_US:en', 10:00:17 INFO - 'LOGNAME': 'cltbld', 10:00:17 INFO - 'MAIL': '/var/mail/cltbld', 10:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:17 INFO - 'MOZ_NO_REMOTE': '1', 10:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:17 INFO - 'NO_EM_RESTART': '1', 10:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:17 INFO - 'PWD': '/builds/slave/test', 10:00:17 INFO - 'SHELL': '/bin/bash', 10:00:17 INFO - 'SHLVL': '1', 10:00:17 INFO - 'TERM': 'linux', 10:00:17 INFO - 'TMOUT': '86400', 10:00:17 INFO - 'USER': 'cltbld', 10:00:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:17 INFO - '_': '/tools/buildbot/bin/python'} 10:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:17 INFO - Running setup.py (path:/tmp/pip-eWsdPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:17 INFO - Running setup.py (path:/tmp/pip-KZdrWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:18 INFO - Running setup.py (path:/tmp/pip-SMYYEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:18 INFO - Running setup.py (path:/tmp/pip-0gMHLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:18 INFO - Running setup.py (path:/tmp/pip-o5vk5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:18 INFO - Running setup.py (path:/tmp/pip-arcT1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:18 INFO - Running setup.py (path:/tmp/pip-yNBv8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:18 INFO - Running setup.py (path:/tmp/pip-AsWf2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:18 INFO - Running setup.py (path:/tmp/pip-Nbq1bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:18 INFO - Running setup.py (path:/tmp/pip-ZHsVfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:18 INFO - Running setup.py (path:/tmp/pip-c1EEV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:18 INFO - Running setup.py (path:/tmp/pip-Tkpw6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:18 INFO - Running setup.py (path:/tmp/pip-ox8MxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:18 INFO - Running setup.py (path:/tmp/pip-ZwiyXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:18 INFO - Running setup.py (path:/tmp/pip-eByswo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:19 INFO - Running setup.py (path:/tmp/pip-Lr2cBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:19 INFO - Running setup.py (path:/tmp/pip-VDTtyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:19 INFO - Running setup.py install for manifestparser 10:00:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Running setup.py install for mozcrash 10:00:19 INFO - Running setup.py install for mozdebug 10:00:19 INFO - Running setup.py install for mozdevice 10:00:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Running setup.py install for mozfile 10:00:19 INFO - Running setup.py install for mozhttpd 10:00:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Running setup.py install for mozinfo 10:00:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Running setup.py install for mozInstall 10:00:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:19 INFO - Running setup.py install for mozleak 10:00:20 INFO - Running setup.py install for mozlog 10:00:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Running setup.py install for moznetwork 10:00:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Running setup.py install for mozprocess 10:00:20 INFO - Running setup.py install for mozprofile 10:00:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Running setup.py install for mozrunner 10:00:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Running setup.py install for mozscreenshot 10:00:20 INFO - Running setup.py install for moztest 10:00:20 INFO - Running setup.py install for mozversion 10:00:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:20 INFO - Cleaning up... 10:00:20 INFO - Return code: 0 10:00:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:20 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 10:00:20 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 10:00:20 INFO - Using env: {'DISPLAY': ':0', 10:00:20 INFO - 'HOME': '/home/cltbld', 10:00:20 INFO - 'LANG': 'en_US.UTF-8', 10:00:20 INFO - 'LANGUAGE': 'en_US:en', 10:00:20 INFO - 'LOGNAME': 'cltbld', 10:00:20 INFO - 'MAIL': '/var/mail/cltbld', 10:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:20 INFO - 'MOZ_NO_REMOTE': '1', 10:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:20 INFO - 'NO_EM_RESTART': '1', 10:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:20 INFO - 'PWD': '/builds/slave/test', 10:00:20 INFO - 'SHELL': '/bin/bash', 10:00:20 INFO - 'SHLVL': '1', 10:00:20 INFO - 'TERM': 'linux', 10:00:20 INFO - 'TMOUT': '86400', 10:00:20 INFO - 'USER': 'cltbld', 10:00:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:20 INFO - '_': '/tools/buildbot/bin/python'} 10:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:21 INFO - Running setup.py (path:/tmp/pip-dyoZ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:21 INFO - Running setup.py (path:/tmp/pip-0BzqVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:21 INFO - Running setup.py (path:/tmp/pip-DRSrjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:21 INFO - Running setup.py (path:/tmp/pip-kU6kiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:21 INFO - Running setup.py (path:/tmp/pip-IMc4lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:21 INFO - Running setup.py (path:/tmp/pip-W0Q__d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:21 INFO - Running setup.py (path:/tmp/pip-I1ZgRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:21 INFO - Running setup.py (path:/tmp/pip-16fm7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:21 INFO - Running setup.py (path:/tmp/pip-Zfyyds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:21 INFO - Running setup.py (path:/tmp/pip-TLbEfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:21 INFO - Running setup.py (path:/tmp/pip-c2Zssj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:21 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)) 10:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:21 INFO - Running setup.py (path:/tmp/pip-LBKN4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:22 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)) 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:22 INFO - Running setup.py (path:/tmp/pip-aAHwet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:22 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)) 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:22 INFO - Running setup.py (path:/tmp/pip-QPNaqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:22 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)) 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:22 INFO - Running setup.py (path:/tmp/pip-od15_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:22 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)) 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:22 INFO - Running setup.py (path:/tmp/pip-5Fxxvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:22 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)) 10:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:22 INFO - Running setup.py (path:/tmp/pip-v7altj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:22 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)) 10:00:22 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)) 10:00:22 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)) 10:00:22 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)) 10:00:22 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)) 10:00:22 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)) 10:00:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:24 INFO - Downloading blessings-1.6.tar.gz 10:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:24 INFO - Installing collected packages: blessings 10:00:24 INFO - Running setup.py install for blessings 10:00:24 INFO - Successfully installed blessings 10:00:24 INFO - Cleaning up... 10:00:24 INFO - Return code: 0 10:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:24 INFO - Reading from file tmpfile_stdout 10:00:24 INFO - Current package versions: 10:00:24 INFO - argparse == 1.2.1 10:00:24 INFO - blessings == 1.6 10:00:24 INFO - blobuploader == 1.2.4 10:00:24 INFO - docopt == 0.6.1 10:00:24 INFO - functools32 == 3.2.3-2 10:00:24 INFO - jsonschema == 2.5.1 10:00:24 INFO - manifestparser == 1.1 10:00:24 INFO - mozInstall == 1.12 10:00:24 INFO - mozcrash == 0.17 10:00:24 INFO - mozdebug == 0.1 10:00:24 INFO - mozdevice == 0.48 10:00:24 INFO - mozfile == 1.2 10:00:24 INFO - mozhttpd == 0.7 10:00:24 INFO - mozinfo == 0.9 10:00:24 INFO - mozleak == 0.1 10:00:24 INFO - mozlog == 3.2 10:00:24 INFO - moznetwork == 0.27 10:00:24 INFO - mozprocess == 0.22 10:00:24 INFO - mozprofile == 0.28 10:00:24 INFO - mozrunner == 6.11 10:00:24 INFO - mozscreenshot == 0.1 10:00:24 INFO - mozsystemmonitor == 0.3 10:00:24 INFO - moztest == 0.7 10:00:24 INFO - mozversion == 1.4 10:00:24 INFO - psutil == 3.1.1 10:00:24 INFO - requests == 1.2.3 10:00:24 INFO - wsgiref == 0.1.2 10:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:24 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')]} 10:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:24 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')]} 10:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:24 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:24 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 10:00:24 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 10:00:24 INFO - Using env: {'DISPLAY': ':0', 10:00:24 INFO - 'HOME': '/home/cltbld', 10:00:24 INFO - 'LANG': 'en_US.UTF-8', 10:00:24 INFO - 'LANGUAGE': 'en_US:en', 10:00:24 INFO - 'LOGNAME': 'cltbld', 10:00:24 INFO - 'MAIL': '/var/mail/cltbld', 10:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:24 INFO - 'MOZ_NO_REMOTE': '1', 10:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:24 INFO - 'NO_EM_RESTART': '1', 10:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:24 INFO - 'PWD': '/builds/slave/test', 10:00:24 INFO - 'SHELL': '/bin/bash', 10:00:24 INFO - 'SHLVL': '1', 10:00:24 INFO - 'TERM': 'linux', 10:00:24 INFO - 'TMOUT': '86400', 10:00:24 INFO - 'USER': 'cltbld', 10:00:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:24 INFO - '_': '/tools/buildbot/bin/python'} 10:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 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)) 10:00:24 INFO - Cleaning up... 10:00:25 INFO - Return code: 0 10:00:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:25 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')]} 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:25 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')]} 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:25 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:25 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 10:00:25 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 10:00:25 INFO - Using env: {'DISPLAY': ':0', 10:00:25 INFO - 'HOME': '/home/cltbld', 10:00:25 INFO - 'LANG': 'en_US.UTF-8', 10:00:25 INFO - 'LANGUAGE': 'en_US:en', 10:00:25 INFO - 'LOGNAME': 'cltbld', 10:00:25 INFO - 'MAIL': '/var/mail/cltbld', 10:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:25 INFO - 'MOZ_NO_REMOTE': '1', 10:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:25 INFO - 'NO_EM_RESTART': '1', 10:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:25 INFO - 'PWD': '/builds/slave/test', 10:00:25 INFO - 'SHELL': '/bin/bash', 10:00:25 INFO - 'SHLVL': '1', 10:00:25 INFO - 'TERM': 'linux', 10:00:25 INFO - 'TMOUT': '86400', 10:00:25 INFO - 'USER': 'cltbld', 10:00:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:25 INFO - '_': '/tools/buildbot/bin/python'} 10:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:25 INFO - Cleaning up... 10:00:25 INFO - Return code: 0 10:00:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:00:25 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')]} 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:25 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')]} 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:25 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 0x7f6c79791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', '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 10:00:25 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 10:00:25 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 10:00:25 INFO - Using env: {'DISPLAY': ':0', 10:00:25 INFO - 'HOME': '/home/cltbld', 10:00:25 INFO - 'LANG': 'en_US.UTF-8', 10:00:25 INFO - 'LANGUAGE': 'en_US:en', 10:00:25 INFO - 'LOGNAME': 'cltbld', 10:00:25 INFO - 'MAIL': '/var/mail/cltbld', 10:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:25 INFO - 'MOZ_NO_REMOTE': '1', 10:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:25 INFO - 'NO_EM_RESTART': '1', 10:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:25 INFO - 'PWD': '/builds/slave/test', 10:00:25 INFO - 'SHELL': '/bin/bash', 10:00:25 INFO - 'SHLVL': '1', 10:00:25 INFO - 'TERM': 'linux', 10:00:25 INFO - 'TMOUT': '86400', 10:00:25 INFO - 'USER': 'cltbld', 10:00:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:25 INFO - '_': '/tools/buildbot/bin/python'} 10:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:25 INFO - Downloading/unpacking flake8 10:00:25 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 10:00:25 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 10:00:25 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 10:00:25 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 10:00:25 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 10:00:25 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 10:00:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:00:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:00:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:27 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 10:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:28 INFO - no previously-included directories found matching 'docs/_build' 10:00:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:00:28 INFO - Running setup.py install for pep8 10:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:28 INFO - no previously-included directories found matching 'docs/_build' 10:00:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:00:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:00:28 INFO - Cleaning up... 10:00:28 INFO - Return code: 0 10:00:28 INFO - Running post-action listener: _resource_record_post_action 10:00:28 INFO - Running post-action listener: _start_resource_monitoring 10:00:28 INFO - Starting resource monitoring. 10:00:28 INFO - ##### 10:00:28 INFO - ##### Finished create-virtualenv step (success) 10:00:28 INFO - ##### 10:00:28 INFO - ##### 10:00:28 INFO - ##### Running install step. 10:00:28 INFO - ##### 10:00:28 INFO - Running pre-action listener: _resource_record_pre_action 10:00:28 INFO - Running main action method: install 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:28 INFO - Reading from file tmpfile_stdout 10:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:28 INFO - Reading from file tmpfile_stdout 10:00:28 INFO - Output received: 10:00:28 INFO - Usage: mozinstall [options] installer 10:00:28 INFO - Options: 10:00:28 INFO - -h, --help show this help message and exit 10:00:28 INFO - -d DEST, --destination=DEST 10:00:28 INFO - Directory to install application into. [default: 10:00:28 INFO - "/builds/slave/test"] 10:00:28 INFO - --app=APP Application being installed. [default: firefox] 10:00:28 INFO - mkdir: /builds/slave/test/build/application 10:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:00:45 INFO - Reading from file tmpfile_stdout 10:00:45 INFO - Output received: 10:00:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:45 INFO - Running post-action listener: _resource_record_post_action 10:00:45 INFO - ##### 10:00:45 INFO - ##### Finished install step (success) 10:00:45 INFO - ##### 10:00:45 INFO - ##### 10:00:45 INFO - ##### Running run-tests step. 10:00:45 INFO - ##### 10:00:45 INFO - Running pre-action listener: _resource_record_pre_action 10:00:45 INFO - Running main action method: run_tests 10:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:45 INFO - Python 2.7.3 10:00:45 INFO - Return code: 0 10:00:45 INFO - grabbing minidump binary from tooltool 10:00:45 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')]} 10:00:45 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 0x19361c0>, '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 0x19370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1937550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:45 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 10:00:45 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 10:00:45 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 10:00:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:45 INFO - Return code: 0 10:00:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:00:46 INFO - Return code: 0 10:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:00:46 INFO - Using env: {'DISPLAY': ':0', 10:00:46 INFO - 'HOME': '/home/cltbld', 10:00:46 INFO - 'LANG': 'en_US.UTF-8', 10:00:46 INFO - 'LANGUAGE': 'en_US:en', 10:00:46 INFO - 'LOGNAME': 'cltbld', 10:00:46 INFO - 'MAIL': '/var/mail/cltbld', 10:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:46 INFO - 'MOZ_NO_REMOTE': '1', 10:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:46 INFO - 'NO_EM_RESTART': '1', 10:00:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:46 INFO - 'PWD': '/builds/slave/test', 10:00:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:46 INFO - 'SHELL': '/bin/bash', 10:00:46 INFO - 'SHLVL': '1', 10:00:46 INFO - 'TERM': 'linux', 10:00:46 INFO - 'TMOUT': '86400', 10:00:46 INFO - 'USER': 'cltbld', 10:00:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855', 10:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:46 INFO - '_': '/tools/buildbot/bin/python'} 10:00:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:00:46 INFO - mozversion application_buildid: 20160621073315 10:00:46 INFO - mozversion application_changeset: 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 10:00:46 INFO - mozversion application_display_name: Nightly 10:00:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:46 INFO - mozversion application_name: Firefox 10:00:46 INFO - mozversion application_remotingname: firefox 10:00:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:46 INFO - mozversion application_vendor: Mozilla 10:00:46 INFO - mozversion application_version: 50.0a1 10:00:46 INFO - mozversion platform_buildid: 20160621073315 10:00:46 INFO - mozversion platform_changeset: 14ac8b409bcd40985ef2abe2ee63ad3b08ab7c69 10:00:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:46 INFO - mozversion platform_version: 50.0a1 10:00:46 INFO - using testdate: 1466528446 10:00:46 INFO - actual date: 1466528446 10:00:46 INFO - starting webserver on 'localhost:55574' 10:00:46 INFO - SUITE-START | Running 2 tests 10:00:46 INFO - TEST-START | dromaeo_css 10:00:46 INFO - operating with platform_type : linux_ 10:00:46 INFO - Initialising browser for dromaeo_css test... 10:00:46 INFO - TEST-INFO | started process 26675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2GDkxd/profile http://localhost:55574/getInfo.html) 10:00:51 INFO - PROCESS | 26675 | __metrics Screen width/height:1600/1200 10:00:51 INFO - PROCESS | 26675 | colorDepth:24 10:00:51 INFO - PROCESS | 26675 | Browser inner width/height: 1024/697 10:00:51 INFO - PROCESS | 26675 | __metrics 10:00:52 INFO - PROCESS | 26675 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:52 INFO - PROCESS | 26675 | console.error: PushService: 10:00:53 INFO - PROCESS | 26675 | stateChangeProcessEnqueue: Error transitioning state 10:00:53 INFO - PROCESS | 26675 | UnknownError 10:00:53 INFO - TEST-INFO | 26675: exit 0 10:00:53 INFO - Browser initialized. 10:00:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:53 INFO - TEST-INFO | started process 26759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2GDkxd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:05 INFO - PROCESS | 26759 | RSS: Main: 174481408 10:01:05 INFO - PROCESS | 26759 | 10:01:57 INFO - PROCESS | 26759 | 1466528517103 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] 10:04:04 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55574/tests/dromaeo/cssquery-ext.html) 10:04:06 INFO - PROCESS | 26759 | RSS: Main: 249970688 10:04:06 INFO - PROCESS | 26759 | 10:07:08 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-ext.html (next: http://localhost:55574/tests/dromaeo/cssquery-jquery.html) 10:07:09 INFO - PROCESS | 26759 | RSS: Main: 266985472 10:07:09 INFO - PROCESS | 26759 | 10:10:11 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55574/tests/dromaeo/cssquery-mootools.html) 10:10:11 INFO - PROCESS | 26759 | RSS: Main: 263151616 10:10:11 INFO - PROCESS | 26759 | 10:13:13 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55574/tests/dromaeo/cssquery-prototype.html) 10:13:14 INFO - PROCESS | 26759 | RSS: Main: 256225280 10:13:14 INFO - PROCESS | 26759 | 10:16:16 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55574/tests/dromaeo/cssquery-yui.html) 10:16:17 INFO - PROCESS | 26759 | RSS: Main: 247971840 10:16:17 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:55574/tests/dromaeo/cssquery-yui.html (next: http://localhost:55574/tests/dromaeo/cssquery-dojo.html) 10:19:20 INFO - PROCESS | 26759 | RSS: Main: 290631680 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | __start_tp_report 10:19:20 INFO - PROCESS | 26759 | _x_x_mozilla_page_load 10:19:20 INFO - PROCESS | 26759 | _x_x_mozilla_page_load_details 10:19:20 INFO - PROCESS | 26759 | |i|pagename|runs| 10:19:20 INFO - PROCESS | 26759 | |0;dojo.html;3081.029475715151;3085.969140308597;3093.304006598515;3118.111338268594;3135.2318681922934;5212.244224587433;5250.501202385767;5258.631895767293;5335.706536140511;5372.650777699447;5310.15037593985;5341.626086173969;5343.946560534394;5400.91898621521;5415.729213539327;4823.517648235174;4880.292357608145;4900.093482705693;4908.312836202935;5073.365829271341;5001.049800537904;5027.271045698371;5048.7980480780725;5060.974695126538;5064.949350506503;4793.32893394925;4866.829660961849;4894.632902532324;4917.926231106536;4933.161362568354;4864.659473836833;4936.148944145945;4938.876528086791;4946.925796113062;4982.053409852117;4903.926441103386;4932.136876046678;4940.2342636891335;4947;4988;5231.189165679326;5264.6051546134195;5346.4118946915805;5357.4374690657305;5407.080796264644;5744.798932037401;5757.280339957505;5768.278965129359;5773.9422605773825;5799.768009279624;5570.359408668014;5832.24180856486;5834.737436815353;5853.034249348852;5857.502112320458;5399.892002159935;5435.83692489226;5436.864078398032;5470.234167216593;5478.342598888119;5926.733297001645;6014.398560143951;6015.157877897098;6016.338202797689;6020.488258498077;5540.058190107691;5604.579656525777;5695.943040569624;5706.42935706426;5711.457411545896;5718.228039214736;5777.826665200051;5821.650700957956;5824.271966004249;5830.7959221427045;5706.457886500859;5744.052231381859;5746.770129194785;5749.195112684228;5753.85615359611;5542.8337149885565;5694.430556944355;5755.107958266475;5762.394948530427;5764.942350576524;4318.201132790444;4321.092570560155;4329.523752387235;4352.173087113439;4364.214441400515;3877.7091718121255;3877.786721730332;3890.922181556353;3916.412538119248;3917.0794863207125;5253.658512196695;5349.170878513836;5359.490848369399;5382.703951282717;5437.211604317352;5629.268195134607;5682.488576028095;5704.857378565486;5750.712464376765;5755.107958266475;5370.167624018283;5370.194470829407;5372.91940620891;5374.27447294618;5433.809816656398;4817.590504807131;5000.67495612784;5003.624728145403;5006.123928312531;5039.269305950616;5876.41235876409;6023.156758053876;6030.728617212236;6033.637981721111;6036.456718895321;5857.502112320501;5874.412558744262;5874.530037596896;5876.265466816648;5876.882462350814;5704.743286552198;5858.502027327725;5883.2057672213705;6018.398160183947;6037.034074548052;5615.831525054255;5619.466150715675;5624.240727501735;5625.212470254086;5661.094224923992;5726.198332233407;5728.885422291614;5735.225744524436;5795.072788353843;5801;5453.972730136324;5673.631213971079;5719.656820590778;5795.478406943395;5811.767529298781;5699.2590963174525;5716.685582293014;5720.971395142998;5722.570807189561;5734.541236701138;5624.29696287964;5632.831015069554;5638.464345887134;5639.182318563868;5644.040513112698;5532.08720561119;5550.583706221969;5622.212890195294;5647.068233741386;5690.544756419394;5525.502704756431;5551.805686800943;5602;5618.2415373924;5624.493795558419 10:19:20 INFO - PROCESS | 26759 | |1;ext.html;579.3598074128089;600.6816387314724;622.7789134857126;623.1711823275043;641.9005054216598;30515.54226686599;31119.2220194495;33168.834155829245;33218.99999999997;42553.36169957453;41519.37720934188;45280.3207951881;45368.54631453684;45381.54618453814;45383;8789.692360767374;8984.10158984103;8995.820083598324;9003.729888103368;9006.144416280476;8850.380473366868;8918.821623567525;8952.283817294634;8962.103789621051;9022.188003079722;9006.099390061006;9028.954855225747;9032.006479287273;9038.683646072388;9043.773905652346;9013.459192448441;9028.593713282919;9060.864087038666;9066.048064953184;9069.682561110329;8395.496270223744;8453.577321133918;8459.111793261742;8459.619317130744;8466.619002144918;41721;42051.7897410511;42293;42330.57669423297;42357.36463953043;3425.2806910548816;3569.161247106928;3605.7943860033974;3984.362501999666;4113.958860411388;32125;32251.677483225103;32281.51577726336;32566.511502327485;32568.511472327933;4364.061726728769;4459;4507.2788353863225;4541.72749635023;4598.88502787433;346600;349543;349730;349923;350721;58551.4144858546;58703.70648146817;58932;59014.11478827821;59121.70439147777;60777;60784.39215607876;60897.69551152216;60945.69527152336;60956.695216524524;15577.688446231012;15744.842551574568;15746.842531574766;15747.13390763519;15766.132862692662;13517.32413379327;13581.796273055912;13587.048906576445;13610.638936106508;13620.863791362157;16480.587985300463;17130;17292.567685807957;17358.39245626397;17396.391126310773;5974.4324289192455;6478.740850366027;6557.114789503451;6558.5409021369;6695.832604184837;877.7893305606608;973.99026009739;980.9803803923882;1061.5170097605571;1092.3742724966328;32521;32599.51100733491;32832;33217.335653287286;33722.325553488794;1071.7642118733866;1109.517359948425;1111.9332840029463;1124.0838716446233;1136.653320737183;16656.75014874778;17170.656586868194;17295;17370.739438908426;17610.38363657266;522081;522135;525883;527280;527332;58793.41206587965;59190.40809591849;59302.70348648315;59388.40611593915;59414.217573472866;1224.3510939202058;1330.4678128748385;1368.1244003837553;1382.8522326469006;1384.383949142642;32416.83791581027;34117.31765364728;34288;34338.48492272668;34470.65529344675;50317.74841125771;50763;51213.48786512087;51258.48741512537;51323.74338128285;325728;326383;326875;328224;329206;33140;35474.290514190085;41250.58749412587;41966.58033419627;42083.368749469395;49005;49844.50155498399;50450.49549504458;50712.49287507078;50757.746211268706;38683;41811.37282940697;42521.78739106285;42884.571154289304;43833;40740.388894167205;41925;42146.78926605347;42499.787501062296;42594.361084583135;42123.78938105413;42383;42987.785061075745;43151.784241078596;43219.35170972375;34426;37346.626533734314;37507.24985500329;38272.42591361188;38518.614813852626;28261.57607635846;28316;28779.712202877705;28800.711992880642;28926.421471570873 10:19:20 INFO - PROCESS | 26759 | |2;jquery.html;377.5903145087579;377.91119087014545;393.9724219304649;397.34041491124736;403.4553352973486;17472;19416.708749368772;20157.59684806303;20195.59608807823;20198.6970195447;18873.90563047186;19323.61352772947;19351.612967740635;19396;19742.210311587518;5369.087255166612;5424.321959755041;5647.407022262665;5674.460926212003;5695.943040569583;5585.245991791117;5680.744366503517;5686.772529098831;5691.260136182311;5708.08670612702;5444.482774136451;5649.943500564983;5666.235058267122;5709.743061562219;5710.685912274823;5636.830895073154;5665.716714164296;5683.3464151622675;5692.430756924316;5710.14347847822;5030.446650868402;5077.5684066854365;5078.289039534468;5079.771410286509;5092.898142037176;22529.887350563306;22544.66183007256;22612;23103.53792924149;23114.65328020081;2420.6853109095705;2657.548216803148;3033;3055.7097075777765;3125.890593829228;13857.584272471842;14568.927155364156;14577.12537247758;14940.103593784299;14998.175100369475;1926.402815127315;1933.1011079847938;1933.497290704427;2062.3194345865827;2090.6968489568926;52850;54255;81177.59411202965;81406.18593814105;82214.58892705558;10790.733945871454;10806.891931080589;10843.403612801372;10976.670699879016;11030.779384412266;15041.323140458706;15073.698526029419;15217;15232.314545845464;15240.771388429182;8084.272415482635;8381.832363352822;8453.239208471266;8506.574671266411;8510.48937063778;8193;8212.260896519223;8238.8352232955;8361.372897032747;8375.078741338448;4590.448711868957;4688.929666055012;4709.246520556694;4802.471728109905;4807.278908163734;1908.332083770697;1927.807219278061;1937.1282922684848;1937.4575118966711;1947.3573720672143;915.4644532948166;983.7589790501373;1019.7756493571402;1045.8378951262566;1062.2511129653576;18797.81202187988;18919;19080.618387632447;19585.510362241057;19785.40643780689;959.6065613098596;976.82417164911;979.4906648542718;983.3018556824735;1045.1168762395764;10364.896351036394;10916.836247456136;10925.289856159325;10975.780484390267;11007.834882476769;466526;467458;470081;473582;475743;65577.34422655712;86461.70307445394;86539.56730216308;93649;95220;916.8578870275118;976.8534719792088;994.5474808961905;1028.7428142964259;1033.0289527843802;16463.259153338367;17807.06688102603;17807.46577602674;17811.287548497916;17978.10109494546;39537.80231098826;40488.70152444431;41598.37602435905;41766.1646767069;42847.57219422501;56508.434915650316;56546;56701.43298566961;56741.71629141828;57886.131708025256;8633.136686331567;8836.475790272232;8957;8984.86522702147;9099.090090990849;9875.802483950425;13670.453181872614;13890.791638125638;13983.440662373798;14119.788203177166;8797.560121994004;11107.278026928223;12005.459754310903;12379.319137447526;12503.624891253277;12306.569270075504;12312.445939932904;12350.62948111558;12551.121421500407;12710.555130570385;12103.939480302543;12355.69110772238;12587.496500139892;12614.684632884251;12651.93674031624;8726.91273087261;8872.290216782512;8950.194482496607;8993.96569394528;9260.166585007382;12009.579664712042;12010;12012.039036877204;12045.879541204826;12113.878861211628 10:19:20 INFO - PROCESS | 26759 | |3;mootools.html;1263.9431225594847;1402.929853507325;1445.8554144585542;1526.3894442223109;1700.404858299596;8552.57237138143;8863.51250681213;8867.91132088679;9049.638014479413;9099;8799.252063574604;9011.504367259799;9013.54932253388;9019.63921443143;9022.548872556363;2013.476496111007;2302.735185453669;2318.0380142240992;2361.1735892437596;2371.5019845832394;2313.178821518362;2315.235972129193;2320.0487800002;2320.814334853216;2335.602947498929;2294.919677811277;2325.3140323604493;2373.9169129080487;2375.3705268103968;2376.263358358914;1989.4727897107277;2188.365374041542;2263.128695452246;2285.0174424997244;2288.25631669708;2287.49675071484;2311.780380863832;2321.6633588129625;2341.0635745701684;2342.4963632819026;9048.638054477813;9139.131782480654;9140.131687489678;9142.222911052502;9153.038930912291;5178.715170665612;5324.440933701944;5326.467353264681;5335.1197052486295;5339.332583427072;3107.7513798896034;3277.3772983133126;3313.370459612666;3358.748093892968;3372.4435468147726;1052.5579256712122;1054.7310435838813;1069.668402795136;1111.2943281016533;1122.2480937771713;12666.176698514568;12989.740205195843;12995.610131696065;13025.023123265793;13045.804312935219;4568.794404251817;4618.284165954283;4714.905701885943;4725.220338644154;4737.313089601988;10809.297395669413;10823.13414926804;10841.132709383388;10843.566257349617;10850.348979061282;5301.602379821529;5306.442823503554;5316.282301889273;5316.441773613792;5322.760475778599;4219.219444402734;4581.816727330936;4682.157211701926;4697.989932164601;4762.761861906891;3917.177392747555;3981.3231750602467;3994.2810294147334;4089.161721847014;4125.793710314472;1229.9262044277373;1255.510350963107;1265.202922159034;1268.8731126887421;1281.7885048967003;982.2633025231077;1005.215931573374;1005.9346142500714;1011.4841430870309;1028.5525796278494;6254.906176407358;6304.338044505353;6426.485881129498;6430.971044632836;6435.2599451063725;459.8620413875824;463.6105671236178;470.78343961777966;472.78015722689116;472.9550692684189;4275.273203555403;4491.8540346545715;4494.213512635276;4573.862784116415;4593.908121837545;11173.10615150786;11402.315861048364;11437.199396042364;11539.19225654213;11558.190926635054;11373.943130284295;11412;11424.885751142549;11445.484953177127;11451.427428628534;8018.55897925608;8252.587370631445;8310.750677479686;8489.74530764078;8518.23335899772;6097.664628445478;6542.934570654233;6570.507211959027;6628.138342015507;6668.566543174678;10646.307989980627;10745.409002504624;10800.513976871216;10837.078848297668;10842.403667798031;10483.213758967955;10708.518116684612;10959.178061645567;10971.23201375928;11162.609308674157;7246.4202863771825;7576.659050342638;7732.690692372242;7970.4819186752675;8128.187181281824;9000.864987025068;9010.774730631787;9053.637854485747;9066.456012639263;9067.68263110788;7865.174156713691;8093.3929955252415;8155.184481551797;8158.143394943446;8207.71273005442;7840.059192896889;7845.450818442654;7870.488418252795;7976.521408715495;8103.959480202561;7325.230850760593;7328.743493977685;7376.151742549676;7384.298491643285;7418.480706350504;4309.159713855768;4378.759168245777;5495.230667706444;5508.697021663686;5576.498115169654;5354.518093371616;5436.429174936575;5437.782488700408;5523.861903452445;5579.051561234519 10:19:20 INFO - PROCESS | 26759 | |4;prototype.html;317.6918389162513;328.32365327425504;330.16962339715604;333.60634451347414;334.48155359193254;5048.6465947383695;5186.559142472885;5198.362515807523;5251.84244472666;5313.41552429233;5180.45605211453;5204.698825293676;5226.738663066851;5227.516929458515;5232.9591459330795;4076.7961601919933;4091.9386209206737;4098.323776576861;4110.938335924949;4124.463819703435;3881.8059097045175;3886.3871493330375;4099.5651521967375;4109.383592461125;4129.4012368206595;4052.196772436267;4063.6793042261233;4079.8776036718946;4090.17986995787;4102.917941641165;4051.9335139079135;4064.593540645941;4081.5918408159246;4102.856400025985;4114.259433302004;3404;3656.634336566322;3672.4307732301536;3687.7418580699364;3691.9261614767556;5026.170681837492;5040.974795126001;5049.495050494921;5064.594832413435;5079.619028572872;4598.908021839545;4602.631789456836;4607.677462577621;4633.189191891439;4641.489436162019;5192.740362981874;5400.1899715043055;5410;5414.377346605152;5451.890962180734;3963.4847469829024;3973.403989401584;3980.5223373195113;3991.341428664267;4000.6196313193605;5665.575081868877;5695.202671625976;5709.086546152637;5717;5742.54059675225;4071.063655359284;4085.22380747657;4089.5910408958866;4103.199876024206;4117.444145040381;3962.4650672159464;4058.3912413138264;4083.469149010669;4104.692148088905;4116.732412393185;4600.401947746772;4614.607758340511;4628.514006029386;4643.628509719214;4655.976720116446;5508.091164957737;5513.338399392099;5521.972390138024;5540.2243685884005;5550.389457159709;1307.0523870194033;1318.854925958144;1402.193738600309;1402.8597140286095;1404.3820718883658;887.5207388010402;889.8220355928711;890.1899271662755;901.4140808474544;907.0476000199764;4652.906941861143;4683.735391444291;4708.835190768306;4716.834910778106;4744.786484608201;4923.827666031743;4926.5073492650445;4938.456769755324;4941.654084214142;4985.454509102117;4559.156556037144;4647.907041859144;4666.743329116864;4694.600958918462;4710.152172608895;2741.232454912628;2977.970220297769;2986.283292009902;2998.700129986984;3006.6392032955746;5789.247397838254;5828.125781132864;5828.475437210586;5839.919614871263;5851.21008663825;5544.473275038865;5777.826665200051;5792.82621521355;5794;5797.159411885253;5805.564582656402;5812.418758124154;5817.836432713474;5832.912506312324;5844.503217226584;5594.552435805207;5603.495685388171;5640.520555752642;5642.351129619982;5680.0463758846;5342.450689300214;5595.216669666169;5598.21624972496;5629.155626656035;5703.344115426779;5744.425557444222;5748.425157484218;5749.798757043483;5755.539556835527;5822.73797679097;3867.149227170018;4003.459532963013;4011.3581826907553;4037.394390841397;4058.898527536835;5607.2149899014985;5656;5658.434156584309;5671.432856714296;5672.5745569081655;5530.253415788978;5538.667679939216;5539.947409992089;5561.332640083216;5599.664020158803;5153.278541004337;5472.589555783253;5501.477359650827;5516.172574113915;5520.475554822286;5383.596230282823;5387.218853266176;5391.5763490183235;5396.64921780083;5424.698072462659;5486.369067557282;5528.474794894479;5546.306711661043;5550.084236100998;5565.944340556543;5324.920126198188;5418.3497980241045;5469.972650136724;5470.440924336545;5471.234027236111 10:19:20 INFO - PROCESS | 26759 | |5;yui.html;722.4076257468874;742.1279996004694;750.876105442602;772.08122334422;772.8145245141168;15025.39898404064;16258.024518528897;16286.755698664529;16290.592735181626;16292.185390730461;14638;14790.40838366464;14807.629809254773;14810.629734256621;14817.629559261024;644.194756554306;651.5569412799294;663.2571519897722;663.9302873198317;754.9660265288076;777.8327659553195;782.225596659306;782.9530228186298;782.9608519573999;783.7413653494333;825.7398919340419;830.0454477351034;832.6586099699125;833;833.2792134803382;694.7360003198803;786.9842603147962;828.2090603473669;828.7016673997387;829.2826704900248;594.1384991761962;595.577140230437;596.2249076200965;600.069891667913;600.1747597054051;14752.483663071742;14794.112353258732;14836.70326593473;14852.480163194345;14886.70226595473;13770.380332885044;14090.718185636333;14107.435702571885;14333.928330358282;14378.137311761328;12709.682257943532;12733.299668518228;12780.872191278062;12901.844187795436;13017.934910325388;4475;4485.9551404485865;4543.772811359452;4588.632909367243;4669.7665116744365;80401.19598803995;81568.18431815665;82062.17937820606;82197.58901205455;83991.16008839894;11096.778064438828;11178.27341222818;11286.830697539543;11340.886591134147;11344.716382090513;21733.23933662314;21737.130514779547;21740.673889891663;21767.34697959064;21769.238076667556;8600.311975041981;8723.825523489495;8776.385653004229;8842.513661748537;8902;4460.799264033061;4518.480374756879;4588.426446694163;4601.838935637236;4671.7430541320555;3384.1539615096226;3506.333796578642;3507.4563442666426;3516;3518.5601799775027;541.1187315170226;613.515322894908;622.7415622516605;624.8719012602405;625.680902739606;591.6006695480534;663.9601623902581;732.7325526182905;748.2367984655621;758.859610971972;9273.489958052372;9463.823320636293;10027.949860250652;10041.598336066621;10320.48397580133;592.2580581264684;636.0205283862892;716.7527203114917;728.2608152724988;733.5561984999106;4677.742724150205;4714.434267887876;4752.639246442788;4780.976095119502;4796.304535842353;110545;112006;112033;112155;115792;93594.53202733943;96204;96679;96981;98468;56406.99999999918;66420;69079;84821;88214.55892720495;9178.449293042439;9270.397424167408;9305.581248843682;9368.531573421165;9413;48448;48586.5141348582;49983.50016499789;50371.99256014932;51935;65930.34069659242;72068.63965680137;73825.26174738184;74199.25800741924;77883;12222.442899702086;12293.877061229274;12464.75070498603;12897.290649014394;13288.734225315633;13174.736505270033;13235.205887646773;13399.598012059654;13635;13789.310534473438;12795.42420591057;12973.54592589255;13397;13410.262435566137;13433.19400835953;12638.2417054977;12817.359132043173;12899.419526121159;13567.86432135666;13575.52485662997;12036.097292703258;12136.878631213574;12240.387980601112;12451.813222801846;13260.469581216643;10342.276040677081;10671.626493072705;10687.732806679895;10924.672259832218;11124.110071194447;10090.34412763168;10618.84071738909;10707.357558546511;10731.141508679442;10775.461226938778 10:19:20 INFO - PROCESS | 26759 | __end_tp_report 10:19:20 INFO - PROCESS | 26759 | __start_cc_report 10:19:20 INFO - PROCESS | 26759 | _x_x_mozilla_cycle_collect,982 10:19:20 INFO - PROCESS | 26759 | __end_cc_report 10:19:20 INFO - PROCESS | 26759 | __startTimestamp1466529560686__endTimestamp 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | ------- Summary: start ------- 10:19:20 INFO - PROCESS | 26759 | Number of tests: 6 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#0] dojo.html Cycles:165 Average:5355.39 Median:5570.36 stddev:616.65 (11.1%) stddev-sans-first:592.17 10:19:20 INFO - PROCESS | 26759 | Values: 3081.0 3086.0 3093.3 3118.1 3135.2 5212.2 5250.5 5258.6 5335.7 5372.7 5310.2 5341.6 5343.9 5400.9 5415.7 4823.5 4880.3 4900.1 4908.3 5073.4 5001.0 5027.3 5048.8 5061.0 5064.9 4793.3 4866.8 4894.6 4917.9 4933.2 4864.7 4936.1 4938.9 4946.9 4982.1 4903.9 4932.1 4940.2 4947.0 4988.0 5231.2 5264.6 5346.4 5357.4 5407.1 5744.8 5757.3 5768.3 5773.9 5799.8 5570.4 5832.2 5834.7 5853.0 5857.5 5399.9 5435.8 5436.9 5470.2 5478.3 5926.7 6014.4 6015.2 6016.3 6020.5 5540.1 5604.6 5695.9 5706.4 5711.5 5718.2 5777.8 5821.7 5824.3 5830.8 5706.5 5744.1 5746.8 5749.2 5753.9 5542.8 5694.4 5755.1 5762.4 5764.9 4318.2 4321.1 4329.5 4352.2 4364.2 3877.7 3877.8 3890.9 3916.4 3917.1 5253.7 5349.2 5359.5 5382.7 5437.2 5629.3 5682.5 5704.9 5750.7 5755.1 5370.2 5370.2 5372.9 5374.3 5433.8 4817.6 5000.7 5003.6 5006.1 5039.3 5876.4 6023.2 6030.7 6033.6 6036.5 5857.5 5874.4 5874.5 5876.3 5876.9 5704.7 5858.5 5883.2 6018.4 6037.0 5615.8 5619.5 5624.2 5625.2 5661.1 5726.2 5728.9 5735.2 5795.1 5801.0 5454.0 5673.6 5719.7 5795.5 5811.8 5699.3 5716.7 5721.0 5722.6 5734.5 5624.3 5632.8 5638.5 5639.2 5644.0 5532.1 5550.6 5622.2 5647.1 5690.5 5525.5 5551.8 5602.0 5618.2 5624.5 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#1] ext.html Cycles:180 Average:57218.45 Median:42311.79 stddev:108499.54 (256.4%) stddev-sans-first:108720.58 10:19:20 INFO - PROCESS | 26759 | Values: 579.4 600.7 622.8 623.2 641.9 30515.5 31119.2 33168.8 33219.0 42553.4 41519.4 45280.3 45368.5 45381.5 45383.0 8789.7 8984.1 8995.8 9003.7 9006.1 8850.4 8918.8 8952.3 8962.1 9022.2 9006.1 9029.0 9032.0 9038.7 9043.8 9013.5 9028.6 9060.9 9066.0 9069.7 8395.5 8453.6 8459.1 8459.6 8466.6 41721.0 42051.8 42293.0 42330.6 42357.4 3425.3 3569.2 3605.8 3984.4 4114.0 32125.0 32251.7 32281.5 32566.5 32568.5 4364.1 4459.0 4507.3 4541.7 4598.9 346600.0 349543.0 349730.0 349923.0 350721.0 58551.4 58703.7 58932.0 59014.1 59121.7 60777.0 60784.4 60897.7 60945.7 60956.7 15577.7 15744.8 15746.8 15747.1 15766.1 13517.3 13581.8 13587.0 13610.6 13620.9 16480.6 17130.0 17292.6 17358.4 17396.4 5974.4 6478.7 6557.1 6558.5 6695.8 877.8 974.0 981.0 1061.5 1092.4 32521.0 32599.5 32832.0 33217.3 33722.3 1071.8 1109.5 1111.9 1124.1 1136.7 16656.8 17170.7 17295.0 17370.7 17610.4 522081.0 522135.0 525883.0 527280.0 527332.0 58793.4 59190.4 59302.7 59388.4 59414.2 1224.4 1330.5 1368.1 1382.9 1384.4 32416.8 34117.3 34288.0 34338.5 34470.7 50317.7 50763.0 51213.5 51258.5 51323.7 325728.0 326383.0 326875.0 328224.0 329206.0 33140.0 35474.3 41250.6 41966.6 42083.4 49005.0 49844.5 50450.5 50712.5 50757.7 38683.0 41811.4 42521.8 42884.6 43833.0 40740.4 41925.0 42146.8 42499.8 42594.4 42123.8 42383.0 42987.8 43151.8 43219.4 34426.0 37346.6 37507.2 38272.4 38518.6 28261.6 28316.0 28779.7 28800.7 28926.4 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#2] jquery.html Cycles:180 Average:28138.76 Median:385.94 stddev:77393.28 (20053.1%) stddev-sans-first:77582.32 10:19:20 INFO - PROCESS | 26759 | Values: 377.6 377.9 394.0 397.3 403.5 17472.0 19416.7 20157.6 20195.6 20198.7 18873.9 19323.6 19351.6 19396.0 19742.2 5369.1 5424.3 5647.4 5674.5 5695.9 5585.2 5680.7 5686.8 5691.3 5708.1 5444.5 5649.9 5666.2 5709.7 5710.7 5636.8 5665.7 5683.3 5692.4 5710.1 5030.4 5077.6 5078.3 5079.8 5092.9 22529.9 22544.7 22612.0 23103.5 23114.7 2420.7 2657.5 3033.0 3055.7 3125.9 13857.6 14568.9 14577.1 14940.1 14998.2 1926.4 1933.1 1933.5 2062.3 2090.7 52850.0 54255.0 81177.6 81406.2 82214.6 10790.7 10806.9 10843.4 10976.7 11030.8 15041.3 15073.7 15217.0 15232.3 15240.8 8084.3 8381.8 8453.2 8506.6 8510.5 8193.0 8212.3 8238.8 8361.4 8375.1 4590.4 4688.9 4709.2 4802.5 4807.3 1908.3 1927.8 1937.1 1937.5 1947.4 915.5 983.8 1019.8 1045.8 1062.3 18797.8 18919.0 19080.6 19585.5 19785.4 959.6 976.8 979.5 983.3 1045.1 10364.9 10916.8 10925.3 10975.8 11007.8 466526.0 467458.0 470081.0 473582.0 475743.0 65577.3 86461.7 86539.6 93649.0 95220.0 916.9 976.9 994.5 1028.7 1033.0 16463.3 17807.1 17807.5 17811.3 17978.1 39537.8 40488.7 41598.4 41766.2 42847.6 56508.4 56546.0 56701.4 56741.7 57886.1 8633.1 8836.5 8957.0 8984.9 9099.1 9875.8 13670.5 13890.8 13983.4 14119.8 8797.6 11107.3 12005.5 12379.3 12503.6 12306.6 12312.4 12350.6 12551.1 12710.6 12103.9 12355.7 12587.5 12614.7 12651.9 8726.9 8872.3 8950.2 8994.0 9260.2 12009.6 12010.0 12012.0 12045.9 12113.9 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#3] mootools.html Cycles:180 Average:5986.90 Median:4571.33 stddev:3519.25 (77.0%) stddev-sans-first:3511.22 10:19:20 INFO - PROCESS | 26759 | Values: 1263.9 1402.9 1445.9 1526.4 1700.4 8552.6 8863.5 8867.9 9049.6 9099.0 8799.3 9011.5 9013.5 9019.6 9022.5 2013.5 2302.7 2318.0 2361.2 2371.5 2313.2 2315.2 2320.0 2320.8 2335.6 2294.9 2325.3 2373.9 2375.4 2376.3 1989.5 2188.4 2263.1 2285.0 2288.3 2287.5 2311.8 2321.7 2341.1 2342.5 9048.6 9139.1 9140.1 9142.2 9153.0 5178.7 5324.4 5326.5 5335.1 5339.3 3107.8 3277.4 3313.4 3358.7 3372.4 1052.6 1054.7 1069.7 1111.3 1122.2 12666.2 12989.7 12995.6 13025.0 13045.8 4568.8 4618.3 4714.9 4725.2 4737.3 10809.3 10823.1 10841.1 10843.6 10850.3 5301.6 5306.4 5316.3 5316.4 5322.8 4219.2 4581.8 4682.2 4698.0 4762.8 3917.2 3981.3 3994.3 4089.2 4125.8 1229.9 1255.5 1265.2 1268.9 1281.8 982.3 1005.2 1005.9 1011.5 1028.6 6254.9 6304.3 6426.5 6431.0 6435.3 459.9 463.6 470.8 472.8 473.0 4275.3 4491.9 4494.2 4573.9 4593.9 11173.1 11402.3 11437.2 11539.2 11558.2 11373.9 11412.0 11424.9 11445.5 11451.4 8018.6 8252.6 8310.8 8489.7 8518.2 6097.7 6542.9 6570.5 6628.1 6668.6 10646.3 10745.4 10800.5 10837.1 10842.4 10483.2 10708.5 10959.2 10971.2 11162.6 7246.4 7576.7 7732.7 7970.5 8128.2 9000.9 9010.8 9053.6 9066.5 9067.7 7865.2 8093.4 8155.2 8158.1 8207.7 7840.1 7845.5 7870.5 7976.5 8104.0 7325.2 7328.7 7376.2 7384.3 7418.5 4309.2 4378.8 5495.2 5508.7 5576.5 5354.5 5436.4 5437.8 5523.9 5579.1 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#4] prototype.html Cycles:180 Average:4571.04 Median:5116.45 stddev:1347.15 (26.3%) stddev-sans-first:1312.55 10:19:20 INFO - PROCESS | 26759 | Values: 317.7 328.3 330.2 333.6 334.5 5048.6 5186.6 5198.4 5251.8 5313.4 5180.5 5204.7 5226.7 5227.5 5233.0 4076.8 4091.9 4098.3 4110.9 4124.5 3881.8 3886.4 4099.6 4109.4 4129.4 4052.2 4063.7 4079.9 4090.2 4102.9 4051.9 4064.6 4081.6 4102.9 4114.3 3404.0 3656.6 3672.4 3687.7 3691.9 5026.2 5041.0 5049.5 5064.6 5079.6 4598.9 4602.6 4607.7 4633.2 4641.5 5192.7 5400.2 5410.0 5414.4 5451.9 3963.5 3973.4 3980.5 3991.3 4000.6 5665.6 5695.2 5709.1 5717.0 5742.5 4071.1 4085.2 4089.6 4103.2 4117.4 3962.5 4058.4 4083.5 4104.7 4116.7 4600.4 4614.6 4628.5 4643.6 4656.0 5508.1 5513.3 5522.0 5540.2 5550.4 1307.1 1318.9 1402.2 1402.9 1404.4 887.5 889.8 890.2 901.4 907.0 4652.9 4683.7 4708.8 4716.8 4744.8 4923.8 4926.5 4938.5 4941.7 4985.5 4559.2 4647.9 4666.7 4694.6 4710.2 2741.2 2978.0 2986.3 2998.7 3006.6 5789.2 5828.1 5828.5 5839.9 5851.2 5544.5 5777.8 5792.8 5794.0 5797.2 5805.6 5812.4 5817.8 5832.9 5844.5 5594.6 5603.5 5640.5 5642.4 5680.0 5342.5 5595.2 5598.2 5629.2 5703.3 5744.4 5748.4 5749.8 5755.5 5822.7 3867.1 4003.5 4011.4 4037.4 4058.9 5607.2 5656.0 5658.4 5671.4 5672.6 5530.3 5538.7 5539.9 5561.3 5599.7 5153.3 5472.6 5501.5 5516.2 5520.5 5383.6 5387.2 5391.6 5396.6 5424.7 5486.4 5528.5 5546.3 5550.1 5565.9 5324.9 5418.3 5470.0 5470.4 5471.2 10:19:20 INFO - PROCESS | 26759 | 10:19:20 INFO - PROCESS | 26759 | [#5] yui.html Cycles:180 Average:20277.07 Median:4635.80 stddev:29055.25 (626.8%) stddev-sans-first:29099.65 10:19:20 INFO - PROCESS | 26759 | Values: 722.4 742.1 750.9 772.1 772.8 15025.4 16258.0 16286.8 16290.6 16292.2 14638.0 14790.4 14807.6 14810.6 14817.6 644.2 651.6 663.3 663.9 755.0 777.8 782.2 783.0 783.0 783.7 825.7 830.0 832.7 833.0 833.3 694.7 787.0 828.2 828.7 829.3 594.1 595.6 596.2 600.1 600.2 14752.5 14794.1 14836.7 14852.5 14886.7 13770.4 14090.7 14107.4 14333.9 14378.1 12709.7 12733.3 12780.9 12901.8 13017.9 4475.0 4486.0 4543.8 4588.6 4669.8 80401.2 81568.2 82062.2 82197.6 83991.2 11096.8 11178.3 11286.8 11340.9 11344.7 21733.2 21737.1 21740.7 21767.3 21769.2 8600.3 8723.8 8776.4 8842.5 8902.0 4460.8 4518.5 4588.4 4601.8 4671.7 3384.2 3506.3 3507.5 3516.0 3518.6 541.1 613.5 622.7 624.9 625.7 591.6 664.0 732.7 748.2 758.9 9273.5 9463.8 10027.9 10041.6 10320.5 592.3 636.0 716.8 728.3 733.6 4677.7 4714.4 4752.6 4781.0 4796.3 110545.0 112006.0 112033.0 112155.0 115792.0 93594.5 96204.0 96679.0 96981.0 98468.0 56407.0 66420.0 69079.0 84821.0 88214.6 9178.4 9270.4 9305.6 9368.5 9413.0 48448.0 48586.5 49983.5 50372.0 51935.0 65930.3 72068.6 73825.3 74199.3 77883.0 12222.4 12293.9 12464.8 12897.3 13288.7 13174.7 13235.2 13399.6 13635.0 13789.3 12795.4 12973.5 13397.0 13410.3 13433.2 12638.2 12817.4 12899.4 13567.9 13575.5 12036.1 12136.9 12240.4 12451.8 13260.5 10342.3 10671.6 10687.7 10924.7 11124.1 10090.3 10618.8 10707.4 10731.1 10775.5 10:19:20 INFO - PROCESS | 26759 | -------- Summary: end -------- 10:19:20 INFO - PROCESS | 26759 | 10:19:21 INFO - TEST-INFO | 26759: exit 0 10:19:21 INFO - TEST-OK | dromaeo_css | took 1114624ms 10:19:21 INFO - TEST-START | kraken 10:19:21 INFO - operating with platform_type : linux_ 10:19:21 INFO - Initialising browser for kraken test... 10:19:21 INFO - TEST-INFO | started process 26945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptBViUL/profile http://localhost:55574/getInfo.html) 10:19:25 INFO - PROCESS | 26945 | __metrics Screen width/height:1600/1200 10:19:25 INFO - PROCESS | 26945 | colorDepth:24 10:19:25 INFO - PROCESS | 26945 | Browser inner width/height: 1024/697 10:19:25 INFO - PROCESS | 26945 | __metrics 10:19:27 INFO - PROCESS | 26945 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:27 INFO - TEST-INFO | 26945: exit 0 10:19:27 INFO - Browser initialized. 10:19:27 INFO - Running cycle 1/1 for kraken test... 10:19:27 INFO - TEST-INFO | started process 27029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptBViUL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:39 INFO - PROCESS | 27029 | RSS: Main: 174366720 10:19:39 INFO - PROCESS | 27029 | 10:19:42 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55574/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:43 INFO - PROCESS | 27029 | RSS: Main: 232898560 10:19:43 INFO - PROCESS | 27029 | 10:19:45 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55574/tests/kraken/driver.html?testName=audio-dft) 10:19:46 INFO - PROCESS | 27029 | RSS: Main: 221003776 10:19:46 INFO - PROCESS | 27029 | 10:19:49 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55574/tests/kraken/driver.html?testName=audio-fft) 10:19:50 INFO - PROCESS | 27029 | RSS: Main: 286375936 10:19:50 INFO - PROCESS | 27029 | 10:19:52 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55574/tests/kraken/driver.html?testName=audio-oscillator) 10:19:52 INFO - PROCESS | 27029 | RSS: Main: 198230016 10:19:52 INFO - PROCESS | 27029 | 10:19:55 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:55 INFO - PROCESS | 27029 | RSS: Main: 202326016 10:19:55 INFO - PROCESS | 27029 | 10:19:58 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55574/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:59 INFO - PROCESS | 27029 | RSS: Main: 236748800 10:19:59 INFO - PROCESS | 27029 | 10:20:02 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55574/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:03 INFO - PROCESS | 27029 | RSS: Main: 238600192 10:20:03 INFO - PROCESS | 27029 | 10:20:06 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55574/tests/kraken/driver.html?testName=json-parse-financial) 10:20:06 INFO - PROCESS | 27029 | RSS: Main: 238673920 10:20:06 INFO - PROCESS | 27029 | 10:20:08 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:08 INFO - PROCESS | 27029 | RSS: Main: 228196352 10:20:08 INFO - PROCESS | 27029 | 10:20:10 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:11 INFO - PROCESS | 27029 | RSS: Main: 230100992 10:20:11 INFO - PROCESS | 27029 | 10:20:13 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:13 INFO - PROCESS | 27029 | RSS: Main: 236564480 10:20:13 INFO - PROCESS | 27029 | 10:20:16 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:17 INFO - PROCESS | 27029 | RSS: Main: 239648768 10:20:17 INFO - PROCESS | 27029 | 10:20:19 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:20 INFO - PROCESS | 27029 | RSS: Main: 240271360 10:20:20 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | Cycle 1(1): loaded http://localhost:55574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55574/tests/kraken/driver.html?testName=ai-astar) 10:20:22 INFO - PROCESS | 27029 | RSS: Main: 283496448 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | __start_tp_report 10:20:22 INFO - PROCESS | 27029 | _x_x_mozilla_page_load 10:20:22 INFO - PROCESS | 27029 | _x_x_mozilla_page_load_details 10:20:22 INFO - PROCESS | 27029 | |i|pagename|runs| 10:20:22 INFO - PROCESS | 27029 | |0;ai-astar;110;106;109;111;110;111;109;109;111;111 10:20:22 INFO - PROCESS | 27029 | |1;audio-beat-detection;150;126;127;183;128;127;160;125;156;130 10:20:22 INFO - PROCESS | 27029 | |2;audio-dft;160;160;160;159;160;160;160;161;160;161 10:20:22 INFO - PROCESS | 27029 | |3;audio-fft;75;75;74;137;76;76;76;75;100;76 10:20:22 INFO - PROCESS | 27029 | |4;audio-oscillator;85;85;114;85;85;86;123;84;85;133 10:20:22 INFO - PROCESS | 27029 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;117;117 10:20:22 INFO - PROCESS | 27029 | |6;imaging-darkroom;146;146;145;146;145;145;145;146;145;145 10:20:22 INFO - PROCESS | 27029 | |7;imaging-desaturate;96;95;95;96;95;96;96;95;95;95 10:20:22 INFO - PROCESS | 27029 | |8;json-parse-financial;54;53;55;54;53;53;54;55;53;52 10:20:22 INFO - PROCESS | 27029 | |9;json-stringify-tinderbox;60;62;61;62;62;61;61;62;61;62 10:20:22 INFO - PROCESS | 27029 | |10;stanford-crypto-aes;79;86;81;82;87;84;81;82;117;80 10:20:22 INFO - PROCESS | 27029 | |11;stanford-crypto-ccm;132;125;123;126;121;125;127;123;141;134 10:20:22 INFO - PROCESS | 27029 | |12;stanford-crypto-pbkdf2;163;163;179;170;164;162;164;168;166;161 10:20:22 INFO - PROCESS | 27029 | |13;stanford-crypto-sha256-iterative;64;65;65;67;64;64;64;65;62;62 10:20:22 INFO - PROCESS | 27029 | __end_tp_report 10:20:22 INFO - PROCESS | 27029 | __start_cc_report 10:20:22 INFO - PROCESS | 27029 | _x_x_mozilla_cycle_collect,1612 10:20:22 INFO - PROCESS | 27029 | __end_cc_report 10:20:22 INFO - PROCESS | 27029 | __startTimestamp1466529622445__endTimestamp 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | ------- Summary: start ------- 10:20:22 INFO - PROCESS | 27029 | Number of tests: 14 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.57 (1.4%) stddev-sans-first:1.66 10:20:22 INFO - PROCESS | 27029 | Values: 110.0 106.0 109.0 111.0 110.0 111.0 109.0 109.0 111.0 111.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:140.00 stddev:19.98 (14.3%) stddev-sans-first:20.94 10:20:22 INFO - PROCESS | 27029 | Values: 150.0 126.0 127.0 183.0 128.0 127.0 160.0 125.0 156.0 130.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:20:22 INFO - PROCESS | 27029 | Values: 160.0 160.0 160.0 159.0 160.0 160.0 160.0 161.0 160.0 161.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:20.18 (26.7%) stddev-sans-first:21.14 10:20:22 INFO - PROCESS | 27029 | Values: 75.0 75.0 74.0 137.0 76.0 76.0 76.0 75.0 100.0 76.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:19.06 (22.4%) stddev-sans-first:19.75 10:20:22 INFO - PROCESS | 27029 | Values: 85.0 85.0 114.0 85.0 85.0 86.0 123.0 84.0 85.0 133.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:20:22 INFO - PROCESS | 27029 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:20:22 INFO - PROCESS | 27029 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:20:22 INFO - PROCESS | 27029 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 10:20:22 INFO - PROCESS | 27029 | Values: 54.0 53.0 55.0 54.0 53.0 53.0 54.0 55.0 53.0 52.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 10:20:22 INFO - PROCESS | 27029 | Values: 60.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 61.0 62.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:82.00 stddev:11.22 (13.7%) stddev-sans-first:11.62 10:20:22 INFO - PROCESS | 27029 | Values: 79.0 86.0 81.0 82.0 87.0 84.0 81.0 82.0 117.0 80.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:126.50 stddev:6.17 (4.9%) stddev-sans-first:6.34 10:20:22 INFO - PROCESS | 27029 | Values: 132.0 125.0 123.0 126.0 121.0 125.0 127.0 123.0 141.0 134.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:165.00 stddev:5.33 (3.2%) stddev-sans-first:5.55 10:20:22 INFO - PROCESS | 27029 | Values: 163.0 163.0 179.0 170.0 164.0 162.0 164.0 168.0 166.0 161.0 10:20:22 INFO - PROCESS | 27029 | 10:20:22 INFO - PROCESS | 27029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.48 (2.3%) stddev-sans-first:1.56 10:20:22 INFO - PROCESS | 27029 | Values: 64.0 65.0 65.0 67.0 64.0 64.0 64.0 65.0 62.0 62.0 10:20:22 INFO - PROCESS | 27029 | -------- Summary: end -------- 10:20:22 INFO - PROCESS | 27029 | 10:20:23 INFO - TEST-INFO | 27029: exit 0 10:20:23 INFO - TEST-OK | kraken | took 62001ms 10:20:23 INFO - SUITE-END | took 1176s 10:20:23 INFO - Completed test suite (00:19:36) 10:20:23 INFO - javascript benchmark 10:20:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.029475715151, 3085.969140308597, 3093.304006598515, 3118.111338268594, 3135.2318681922934, 5212.244224587433, 5250.501202385767, 5258.631895767293, 5335.706536140511, 5372.650777699447, 5310.15037593985, 5341.626086173969, 5343.946560534394, 5400.91898621521, 5415.729213539327, 4823.517648235174, 4880.292357608145, 4900.093482705693, 4908.312836202935, 5073.365829271341, 5001.049800537904, 5027.271045698371, 5048.7980480780725, 5060.974695126538, 5064.949350506503, 4793.32893394925, 4866.829660961849, 4894.632902532324, 4917.926231106536, 4933.161362568354, 4864.659473836833, 4936.148944145945, 4938.876528086791, 4946.925796113062, 4982.053409852117, 4903.926441103386, 4932.136876046678, 4940.2342636891335, 4947.0, 4988.0, 5231.189165679326, 5264.6051546134195, 5346.4118946915805, 5357.4374690657305, 5407.080796264644, 5744.798932037401, 5757.280339957505, 5768.278965129359, 5773.9422605773825, 5799.768009279624, 5570.359408668014, 5832.24180856486, 5834.737436815353, 5853.034249348852, 5857.502112320458, 5399.892002159935, 5435.83692489226, 5436.864078398032, 5470.234167216593, 5478.342598888119, 5926.733297001645, 6014.398560143951, 6015.157877897098, 6016.338202797689, 6020.488258498077, 5540.058190107691, 5604.579656525777, 5695.943040569624, 5706.42935706426, 5711.457411545896, 5718.228039214736, 5777.826665200051, 5821.650700957956, 5824.271966004249, 5830.7959221427045, 5706.457886500859, 5744.052231381859, 5746.770129194785, 5749.195112684228, 5753.85615359611, 5542.8337149885565, 5694.430556944355, 5755.107958266475, 5762.394948530427, 5764.942350576524, 4318.201132790444, 4321.092570560155, 4329.523752387235, 4352.173087113439, 4364.214441400515, 3877.7091718121255, 3877.786721730332, 3890.922181556353, 3916.412538119248, 3917.0794863207125, 5253.658512196695, 5349.170878513836, 5359.490848369399, 5382.703951282717, 5437.211604317352, 5629.268195134607, 5682.488576028095, 5704.857378565486, 5750.712464376765, 5755.107958266475, 5370.167624018283, 5370.194470829407, 5372.91940620891, 5374.27447294618, 5433.809816656398, 4817.590504807131, 5000.67495612784, 5003.624728145403, 5006.123928312531, 5039.269305950616, 5876.41235876409, 6023.156758053876, 6030.728617212236, 6033.637981721111, 6036.456718895321, 5857.502112320501, 5874.412558744262, 5874.530037596896, 5876.265466816648, 5876.882462350814, 5704.743286552198, 5858.502027327725, 5883.2057672213705, 6018.398160183947, 6037.034074548052, 5615.831525054255, 5619.466150715675, 5624.240727501735, 5625.212470254086, 5661.094224923992, 5726.198332233407, 5728.885422291614, 5735.225744524436, 5795.072788353843, 5801.0, 5453.972730136324, 5673.631213971079, 5719.656820590778, 5795.478406943395, 5811.767529298781, 5699.2590963174525, 5716.685582293014, 5720.971395142998, 5722.570807189561, 5734.541236701138, 5624.29696287964, 5632.831015069554, 5638.464345887134, 5639.182318563868, 5644.040513112698, 5532.08720561119, 5550.583706221969, 5622.212890195294, 5647.068233741386, 5690.544756419394, 5525.502704756431, 5551.805686800943, 5602.0, 5618.2415373924, 5624.493795558419], "value": 5313.121457224141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3598074128089, 600.6816387314724, 622.7789134857126, 623.1711823275043, 641.9005054216598, 30515.54226686599, 31119.2220194495, 33168.834155829245, 33218.99999999997, 42553.36169957453, 41519.37720934188, 45280.3207951881, 45368.54631453684, 45381.54618453814, 45383.0, 8789.692360767374, 8984.10158984103, 8995.820083598324, 9003.729888103368, 9006.144416280476, 8850.380473366868, 8918.821623567525, 8952.283817294634, 8962.103789621051, 9022.188003079722, 9006.099390061006, 9028.954855225747, 9032.006479287273, 9038.683646072388, 9043.773905652346, 9013.459192448441, 9028.593713282919, 9060.864087038666, 9066.048064953184, 9069.682561110329, 8395.496270223744, 8453.577321133918, 8459.111793261742, 8459.619317130744, 8466.619002144918, 41721.0, 42051.7897410511, 42293.0, 42330.57669423297, 42357.36463953043, 3425.2806910548816, 3569.161247106928, 3605.7943860033974, 3984.362501999666, 4113.958860411388, 32125.0, 32251.677483225103, 32281.51577726336, 32566.511502327485, 32568.511472327933, 4364.061726728769, 4459.0, 4507.2788353863225, 4541.72749635023, 4598.88502787433, 346600.0, 349543.0, 349730.0, 349923.0, 350721.0, 58551.4144858546, 58703.70648146817, 58932.0, 59014.11478827821, 59121.70439147777, 60777.0, 60784.39215607876, 60897.69551152216, 60945.69527152336, 60956.695216524524, 15577.688446231012, 15744.842551574568, 15746.842531574766, 15747.13390763519, 15766.132862692662, 13517.32413379327, 13581.796273055912, 13587.048906576445, 13610.638936106508, 13620.863791362157, 16480.587985300463, 17130.0, 17292.567685807957, 17358.39245626397, 17396.391126310773, 5974.4324289192455, 6478.740850366027, 6557.114789503451, 6558.5409021369, 6695.832604184837, 877.7893305606608, 973.99026009739, 980.9803803923882, 1061.5170097605571, 1092.3742724966328, 32521.0, 32599.51100733491, 32832.0, 33217.335653287286, 33722.325553488794, 1071.7642118733866, 1109.517359948425, 1111.9332840029463, 1124.0838716446233, 1136.653320737183, 16656.75014874778, 17170.656586868194, 17295.0, 17370.739438908426, 17610.38363657266, 522081.0, 522135.0, 525883.0, 527280.0, 527332.0, 58793.41206587965, 59190.40809591849, 59302.70348648315, 59388.40611593915, 59414.217573472866, 1224.3510939202058, 1330.4678128748385, 1368.1244003837553, 1382.8522326469006, 1384.383949142642, 32416.83791581027, 34117.31765364728, 34288.0, 34338.48492272668, 34470.65529344675, 50317.74841125771, 50763.0, 51213.48786512087, 51258.48741512537, 51323.74338128285, 325728.0, 326383.0, 326875.0, 328224.0, 329206.0, 33140.0, 35474.290514190085, 41250.58749412587, 41966.58033419627, 42083.368749469395, 49005.0, 49844.50155498399, 50450.49549504458, 50712.49287507078, 50757.746211268706, 38683.0, 41811.37282940697, 42521.78739106285, 42884.571154289304, 43833.0, 40740.388894167205, 41925.0, 42146.78926605347, 42499.787501062296, 42594.361084583135, 42123.78938105413, 42383.0, 42987.785061075745, 43151.784241078596, 43219.35170972375, 34426.0, 37346.626533734314, 37507.24985500329, 38272.42591361188, 38518.614813852626, 28261.57607635846, 28316.0, 28779.712202877705, 28800.711992880642, 28926.421471570873], "value": 20091.9994832783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5903145087579, 377.91119087014545, 393.9724219304649, 397.34041491124736, 403.4553352973486, 17472.0, 19416.708749368772, 20157.59684806303, 20195.59608807823, 20198.6970195447, 18873.90563047186, 19323.61352772947, 19351.612967740635, 19396.0, 19742.210311587518, 5369.087255166612, 5424.321959755041, 5647.407022262665, 5674.460926212003, 5695.943040569583, 5585.245991791117, 5680.744366503517, 5686.772529098831, 5691.260136182311, 5708.08670612702, 5444.482774136451, 5649.943500564983, 5666.235058267122, 5709.743061562219, 5710.685912274823, 5636.830895073154, 5665.716714164296, 5683.3464151622675, 5692.430756924316, 5710.14347847822, 5030.446650868402, 5077.5684066854365, 5078.289039534468, 5079.771410286509, 5092.898142037176, 22529.887350563306, 22544.66183007256, 22612.0, 23103.53792924149, 23114.65328020081, 2420.6853109095705, 2657.548216803148, 3033.0, 3055.7097075777765, 3125.890593829228, 13857.584272471842, 14568.927155364156, 14577.12537247758, 14940.103593784299, 14998.175100369475, 1926.402815127315, 1933.1011079847938, 1933.497290704427, 2062.3194345865827, 2090.6968489568926, 52850.0, 54255.0, 81177.59411202965, 81406.18593814105, 82214.58892705558, 10790.733945871454, 10806.891931080589, 10843.403612801372, 10976.670699879016, 11030.779384412266, 15041.323140458706, 15073.698526029419, 15217.0, 15232.314545845464, 15240.771388429182, 8084.272415482635, 8381.832363352822, 8453.239208471266, 8506.574671266411, 8510.48937063778, 8193.0, 8212.260896519223, 8238.8352232955, 8361.372897032747, 8375.078741338448, 4590.448711868957, 4688.929666055012, 4709.246520556694, 4802.471728109905, 4807.278908163734, 1908.332083770697, 1927.807219278061, 1937.1282922684848, 1937.4575118966711, 1947.3573720672143, 915.4644532948166, 983.7589790501373, 1019.7756493571402, 1045.8378951262566, 1062.2511129653576, 18797.81202187988, 18919.0, 19080.618387632447, 19585.510362241057, 19785.40643780689, 959.6065613098596, 976.82417164911, 979.4906648542718, 983.3018556824735, 1045.1168762395764, 10364.896351036394, 10916.836247456136, 10925.289856159325, 10975.780484390267, 11007.834882476769, 466526.0, 467458.0, 470081.0, 473582.0, 475743.0, 65577.34422655712, 86461.70307445394, 86539.56730216308, 93649.0, 95220.0, 916.8578870275118, 976.8534719792088, 994.5474808961905, 1028.7428142964259, 1033.0289527843802, 16463.259153338367, 17807.06688102603, 17807.46577602674, 17811.287548497916, 17978.10109494546, 39537.80231098826, 40488.70152444431, 41598.37602435905, 41766.1646767069, 42847.57219422501, 56508.434915650316, 56546.0, 56701.43298566961, 56741.71629141828, 57886.131708025256, 8633.136686331567, 8836.475790272232, 8957.0, 8984.86522702147, 9099.090090990849, 9875.802483950425, 13670.453181872614, 13890.791638125638, 13983.440662373798, 14119.788203177166, 8797.560121994004, 11107.278026928223, 12005.459754310903, 12379.319137447526, 12503.624891253277, 12306.569270075504, 12312.445939932904, 12350.62948111558, 12551.121421500407, 12710.555130570385, 12103.939480302543, 12355.69110772238, 12587.496500139892, 12614.684632884251, 12651.93674031624, 8726.91273087261, 8872.290216782512, 8950.194482496607, 8993.96569394528, 9260.166585007382, 12009.579664712042, 12010.0, 12012.039036877204, 12045.879541204826, 12113.878861211628], "value": 9320.453401962559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.9431225594847, 1402.929853507325, 1445.8554144585542, 1526.3894442223109, 1700.404858299596, 8552.57237138143, 8863.51250681213, 8867.91132088679, 9049.638014479413, 9099.0, 8799.252063574604, 9011.504367259799, 9013.54932253388, 9019.63921443143, 9022.548872556363, 2013.476496111007, 2302.735185453669, 2318.0380142240992, 2361.1735892437596, 2371.5019845832394, 2313.178821518362, 2315.235972129193, 2320.0487800002, 2320.814334853216, 2335.602947498929, 2294.919677811277, 2325.3140323604493, 2373.9169129080487, 2375.3705268103968, 2376.263358358914, 1989.4727897107277, 2188.365374041542, 2263.128695452246, 2285.0174424997244, 2288.25631669708, 2287.49675071484, 2311.780380863832, 2321.6633588129625, 2341.0635745701684, 2342.4963632819026, 9048.638054477813, 9139.131782480654, 9140.131687489678, 9142.222911052502, 9153.038930912291, 5178.715170665612, 5324.440933701944, 5326.467353264681, 5335.1197052486295, 5339.332583427072, 3107.7513798896034, 3277.3772983133126, 3313.370459612666, 3358.748093892968, 3372.4435468147726, 1052.5579256712122, 1054.7310435838813, 1069.668402795136, 1111.2943281016533, 1122.2480937771713, 12666.176698514568, 12989.740205195843, 12995.610131696065, 13025.023123265793, 13045.804312935219, 4568.794404251817, 4618.284165954283, 4714.905701885943, 4725.220338644154, 4737.313089601988, 10809.297395669413, 10823.13414926804, 10841.132709383388, 10843.566257349617, 10850.348979061282, 5301.602379821529, 5306.442823503554, 5316.282301889273, 5316.441773613792, 5322.760475778599, 4219.219444402734, 4581.816727330936, 4682.157211701926, 4697.989932164601, 4762.761861906891, 3917.177392747555, 3981.3231750602467, 3994.2810294147334, 4089.161721847014, 4125.793710314472, 1229.9262044277373, 1255.510350963107, 1265.202922159034, 1268.8731126887421, 1281.7885048967003, 982.2633025231077, 1005.215931573374, 1005.9346142500714, 1011.4841430870309, 1028.5525796278494, 6254.906176407358, 6304.338044505353, 6426.485881129498, 6430.971044632836, 6435.2599451063725, 459.8620413875824, 463.6105671236178, 470.78343961777966, 472.78015722689116, 472.9550692684189, 4275.273203555403, 4491.8540346545715, 4494.213512635276, 4573.862784116415, 4593.908121837545, 11173.10615150786, 11402.315861048364, 11437.199396042364, 11539.19225654213, 11558.190926635054, 11373.943130284295, 11412.0, 11424.885751142549, 11445.484953177127, 11451.427428628534, 8018.55897925608, 8252.587370631445, 8310.750677479686, 8489.74530764078, 8518.23335899772, 6097.664628445478, 6542.934570654233, 6570.507211959027, 6628.138342015507, 6668.566543174678, 10646.307989980627, 10745.409002504624, 10800.513976871216, 10837.078848297668, 10842.403667798031, 10483.213758967955, 10708.518116684612, 10959.178061645567, 10971.23201375928, 11162.609308674157, 7246.4202863771825, 7576.659050342638, 7732.690692372242, 7970.4819186752675, 8128.187181281824, 9000.864987025068, 9010.774730631787, 9053.637854485747, 9066.456012639263, 9067.68263110788, 7865.174156713691, 8093.3929955252415, 8155.184481551797, 8158.143394943446, 8207.71273005442, 7840.059192896889, 7845.450818442654, 7870.488418252795, 7976.521408715495, 8103.959480202561, 7325.230850760593, 7328.743493977685, 7376.151742549676, 7384.298491643285, 7418.480706350504, 4309.159713855768, 4378.759168245777, 5495.230667706444, 5508.697021663686, 5576.498115169654, 5354.518093371616, 5436.429174936575, 5437.782488700408, 5523.861903452445, 5579.051561234519], "value": 4648.077952935064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.6918389162513, 328.32365327425504, 330.16962339715604, 333.60634451347414, 334.48155359193254, 5048.6465947383695, 5186.559142472885, 5198.362515807523, 5251.84244472666, 5313.41552429233, 5180.45605211453, 5204.698825293676, 5226.738663066851, 5227.516929458515, 5232.9591459330795, 4076.7961601919933, 4091.9386209206737, 4098.323776576861, 4110.938335924949, 4124.463819703435, 3881.8059097045175, 3886.3871493330375, 4099.5651521967375, 4109.383592461125, 4129.4012368206595, 4052.196772436267, 4063.6793042261233, 4079.8776036718946, 4090.17986995787, 4102.917941641165, 4051.9335139079135, 4064.593540645941, 4081.5918408159246, 4102.856400025985, 4114.259433302004, 3404.0, 3656.634336566322, 3672.4307732301536, 3687.7418580699364, 3691.9261614767556, 5026.170681837492, 5040.974795126001, 5049.495050494921, 5064.594832413435, 5079.619028572872, 4598.908021839545, 4602.631789456836, 4607.677462577621, 4633.189191891439, 4641.489436162019, 5192.740362981874, 5400.1899715043055, 5410.0, 5414.377346605152, 5451.890962180734, 3963.4847469829024, 3973.403989401584, 3980.5223373195113, 3991.341428664267, 4000.6196313193605, 5665.575081868877, 5695.202671625976, 5709.086546152637, 5717.0, 5742.54059675225, 4071.063655359284, 4085.22380747657, 4089.5910408958866, 4103.199876024206, 4117.444145040381, 3962.4650672159464, 4058.3912413138264, 4083.469149010669, 4104.692148088905, 4116.732412393185, 4600.401947746772, 4614.607758340511, 4628.514006029386, 4643.628509719214, 4655.976720116446, 5508.091164957737, 5513.338399392099, 5521.972390138024, 5540.2243685884005, 5550.389457159709, 1307.0523870194033, 1318.854925958144, 1402.193738600309, 1402.8597140286095, 1404.3820718883658, 887.5207388010402, 889.8220355928711, 890.1899271662755, 901.4140808474544, 907.0476000199764, 4652.906941861143, 4683.735391444291, 4708.835190768306, 4716.834910778106, 4744.786484608201, 4923.827666031743, 4926.5073492650445, 4938.456769755324, 4941.654084214142, 4985.454509102117, 4559.156556037144, 4647.907041859144, 4666.743329116864, 4694.600958918462, 4710.152172608895, 2741.232454912628, 2977.970220297769, 2986.283292009902, 2998.700129986984, 3006.6392032955746, 5789.247397838254, 5828.125781132864, 5828.475437210586, 5839.919614871263, 5851.21008663825, 5544.473275038865, 5777.826665200051, 5792.82621521355, 5794.0, 5797.159411885253, 5805.564582656402, 5812.418758124154, 5817.836432713474, 5832.912506312324, 5844.503217226584, 5594.552435805207, 5603.495685388171, 5640.520555752642, 5642.351129619982, 5680.0463758846, 5342.450689300214, 5595.216669666169, 5598.21624972496, 5629.155626656035, 5703.344115426779, 5744.425557444222, 5748.425157484218, 5749.798757043483, 5755.539556835527, 5822.73797679097, 3867.149227170018, 4003.459532963013, 4011.3581826907553, 4037.394390841397, 4058.898527536835, 5607.2149899014985, 5656.0, 5658.434156584309, 5671.432856714296, 5672.5745569081655, 5530.253415788978, 5538.667679939216, 5539.947409992089, 5561.332640083216, 5599.664020158803, 5153.278541004337, 5472.589555783253, 5501.477359650827, 5516.172574113915, 5520.475554822286, 5383.596230282823, 5387.218853266176, 5391.5763490183235, 5396.64921780083, 5424.698072462659, 5486.369067557282, 5528.474794894479, 5546.306711661043, 5550.084236100998, 5565.944340556543, 5324.920126198188, 5418.3497980241045, 5469.972650136724, 5470.440924336545, 5471.234027236111], "value": 4140.575251047006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.4076257468874, 742.1279996004694, 750.876105442602, 772.08122334422, 772.8145245141168, 15025.39898404064, 16258.024518528897, 16286.755698664529, 16290.592735181626, 16292.185390730461, 14638.0, 14790.40838366464, 14807.629809254773, 14810.629734256621, 14817.629559261024, 644.194756554306, 651.5569412799294, 663.2571519897722, 663.9302873198317, 754.9660265288076, 777.8327659553195, 782.225596659306, 782.9530228186298, 782.9608519573999, 783.7413653494333, 825.7398919340419, 830.0454477351034, 832.6586099699125, 833.0, 833.2792134803382, 694.7360003198803, 786.9842603147962, 828.2090603473669, 828.7016673997387, 829.2826704900248, 594.1384991761962, 595.577140230437, 596.2249076200965, 600.069891667913, 600.1747597054051, 14752.483663071742, 14794.112353258732, 14836.70326593473, 14852.480163194345, 14886.70226595473, 13770.380332885044, 14090.718185636333, 14107.435702571885, 14333.928330358282, 14378.137311761328, 12709.682257943532, 12733.299668518228, 12780.872191278062, 12901.844187795436, 13017.934910325388, 4475.0, 4485.9551404485865, 4543.772811359452, 4588.632909367243, 4669.7665116744365, 80401.19598803995, 81568.18431815665, 82062.17937820606, 82197.58901205455, 83991.16008839894, 11096.778064438828, 11178.27341222818, 11286.830697539543, 11340.886591134147, 11344.716382090513, 21733.23933662314, 21737.130514779547, 21740.673889891663, 21767.34697959064, 21769.238076667556, 8600.311975041981, 8723.825523489495, 8776.385653004229, 8842.513661748537, 8902.0, 4460.799264033061, 4518.480374756879, 4588.426446694163, 4601.838935637236, 4671.7430541320555, 3384.1539615096226, 3506.333796578642, 3507.4563442666426, 3516.0, 3518.5601799775027, 541.1187315170226, 613.515322894908, 622.7415622516605, 624.8719012602405, 625.680902739606, 591.6006695480534, 663.9601623902581, 732.7325526182905, 748.2367984655621, 758.859610971972, 9273.489958052372, 9463.823320636293, 10027.949860250652, 10041.598336066621, 10320.48397580133, 592.2580581264684, 636.0205283862892, 716.7527203114917, 728.2608152724988, 733.5561984999106, 4677.742724150205, 4714.434267887876, 4752.639246442788, 4780.976095119502, 4796.304535842353, 110545.0, 112006.0, 112033.0, 112155.0, 115792.0, 93594.53202733943, 96204.0, 96679.0, 96981.0, 98468.0, 56406.99999999918, 66420.0, 69079.0, 84821.0, 88214.55892720495, 9178.449293042439, 9270.397424167408, 9305.581248843682, 9368.531573421165, 9413.0, 48448.0, 48586.5141348582, 49983.50016499789, 50371.99256014932, 51935.0, 65930.34069659242, 72068.63965680137, 73825.26174738184, 74199.25800741924, 77883.0, 12222.442899702086, 12293.877061229274, 12464.75070498603, 12897.290649014394, 13288.734225315633, 13174.736505270033, 13235.205887646773, 13399.598012059654, 13635.0, 13789.310534473438, 12795.42420591057, 12973.54592589255, 13397.0, 13410.262435566137, 13433.19400835953, 12638.2417054977, 12817.359132043173, 12899.419526121159, 13567.86432135666, 13575.52485662997, 12036.097292703258, 12136.878631213574, 12240.387980601112, 12451.813222801846, 13260.469581216643, 10342.276040677081, 10671.626493072705, 10687.732806679895, 10924.672259832218, 11124.110071194447, 10090.34412763168, 10618.84071738909, 10707.357558546511, 10731.141508679442, 10775.461226938778], "value": 7395.5307701874135, "unit": "score"}], "name": "dromaeo_css", "value": 7219.823383557896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 109.0, 111.0, 110.0, 111.0, 109.0, 109.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 127.0, 183.0, 128.0, 127.0, 160.0, 125.0, 156.0, 130.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 137.0, 76.0, 76.0, 76.0, 75.0, 100.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 114.0, 85.0, 85.0, 86.0, 123.0, 84.0, 85.0, 133.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 54.0, 53.0, 53.0, 54.0, 55.0, 53.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 81.0, 82.0, 87.0, 84.0, 81.0, 82.0, 117.0, 80.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 123.0, 126.0, 121.0, 125.0, 127.0, 123.0, 141.0, 134.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 179.0, 170.0, 164.0, 162.0, 164.0, 168.0, 166.0, 161.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 67.0, 64.0, 64.0, 64.0, 65.0, 62.0, 62.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1507.8000000000002, "alertThreshold": 2.0}]} 10:20:23 INFO - Return code: 0 10:20:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:23 INFO - # TBPL SUCCESS # 10:20:23 INFO - Running post-action listener: _resource_record_post_action 10:20:23 INFO - ##### 10:20:23 INFO - ##### Finished run-tests step (success) 10:20:23 INFO - ##### 10:20:23 INFO - Running post-run listener: _resource_record_post_run 10:20:23 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 419139584; Read time: 240; Write time: 282504 10:20:23 INFO - TinderboxPrint: CPU usage
13.2% 10:20:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 10:20:23 INFO - TinderboxPrint: I/O write bytes / time
419,139,584 / 282,504 10:20:23 INFO - TinderboxPrint: CPU idle
8,278.2 (86.8%) 10:20:23 INFO - TinderboxPrint: CPU user
1,208.9 (12.7%) 10:20:23 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129896448; Read time: 0; Write time: 98736 10:20:23 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289243136; Read time: 240; Write time: 183768 10:20:24 INFO - Running post-run listener: _upload_blobber_files 10:20:24 INFO - Blob upload gear active. 10:20:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:24 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 10:20:24 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:24 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:24 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:25 INFO - (blobuploader) - INFO - Done attempting. 10:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:29 INFO - (blobuploader) - INFO - Done attempting. 10:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:30 INFO - (blobuploader) - INFO - Done attempting. 10:20:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:30 INFO - Return code: 0 10:20:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c1c9689680e143190fd39df71cd437261692283537612832e6ac81014b3f58255494ff4dbcb5ba19f1ad8faec56ffbd78b199cb36038a453a17e2f3dbeaf936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6bf46b46f0a0c7d6be50524f32365322e240a8ae5fb5ba0f3ec01cbf4059ebfb2f150687b54e26225e5423b0d1b745d739658e64e6bfb25abbcd6dd86b0e375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9eb7029205ca3f479c7e44638c497736d387f009d9d9a0bd3e0565b14a9548a97ff2612301bf994f0a7caeca4cc74acf55c592be358ede161bb2d370d2d139ed"} 10:20:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:30 INFO - Contents: 10:20:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c1c9689680e143190fd39df71cd437261692283537612832e6ac81014b3f58255494ff4dbcb5ba19f1ad8faec56ffbd78b199cb36038a453a17e2f3dbeaf936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6bf46b46f0a0c7d6be50524f32365322e240a8ae5fb5ba0f3ec01cbf4059ebfb2f150687b54e26225e5423b0d1b745d739658e64e6bfb25abbcd6dd86b0e375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9eb7029205ca3f479c7e44638c497736d387f009d9d9a0bd3e0565b14a9548a97ff2612301bf994f0a7caeca4cc74acf55c592be358ede161bb2d370d2d139ed"} 10:20:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:30 INFO - Copying logs to upload dir... 10:20:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.910668 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-21 10:20:30.123425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 10:20:30.127077) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c1c9689680e143190fd39df71cd437261692283537612832e6ac81014b3f58255494ff4dbcb5ba19f1ad8faec56ffbd78b199cb36038a453a17e2f3dbeaf936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6bf46b46f0a0c7d6be50524f32365322e240a8ae5fb5ba0f3ec01cbf4059ebfb2f150687b54e26225e5423b0d1b745d739658e64e6bfb25abbcd6dd86b0e375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9eb7029205ca3f479c7e44638c497736d387f009d9d9a0bd3e0565b14a9548a97ff2612301bf994f0a7caeca4cc74acf55c592be358ede161bb2d370d2d139ed"} build_url:https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/Yd6iKUKNQs6mWsKvUmTV7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c1c9689680e143190fd39df71cd437261692283537612832e6ac81014b3f58255494ff4dbcb5ba19f1ad8faec56ffbd78b199cb36038a453a17e2f3dbeaf936", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d6bf46b46f0a0c7d6be50524f32365322e240a8ae5fb5ba0f3ec01cbf4059ebfb2f150687b54e26225e5423b0d1b745d739658e64e6bfb25abbcd6dd86b0e375", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9eb7029205ca3f479c7e44638c497736d387f009d9d9a0bd3e0565b14a9548a97ff2612301bf994f0a7caeca4cc74acf55c592be358ede161bb2d370d2d139ed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 10:20:30.152847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:20:30.153185) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466526730.782755-370545855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 10:20:30.236512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 10:20:30.236836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 10:20:30.237170) ========= ========= Total master_lag: 0.16 =========