builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1468234785.4 results: success (0) buildid: 20160711004013 builduid: f8014511038842949361daa4c20680d8 revision: 496264b64d722c9e8c6713d4244536b258979c16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.404807) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.405332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.405625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.420841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.421211) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 03:59:45-- 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% 42.3M=0s 2016-07-11 03:59:45 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114842 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.550511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.550821) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017245 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.599943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:45.600311) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 496264b64d722c9e8c6713d4244536b258979c16 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 496264b64d722c9e8c6713d4244536b258979c16 --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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 03:59:46,078 truncating revision to first 12 chars 2016-07-11 03:59:46,078 Setting DEBUG logging. 2016-07-11 03:59:46,078 attempt 1/10 2016-07-11 03:59:46,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/496264b64d72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 03:59:46,386 unpacking tar archive at: mozilla-aurora-496264b64d72/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637332 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:46.251915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:46.252341) ========= script_repo_revision: 496264b64d722c9e8c6713d4244536b258979c16 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:46.252787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:46.253129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 03:59:46.262630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-11 03:59:46.263014) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:46 INFO - MultiFileLogger online at 20160711 03:59:46 in /builds/slave/test 03:59:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:59:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:46 INFO - {'append_to_log': False, 03:59:46 INFO - 'base_work_dir': '/builds/slave/test', 03:59:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:59:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:46 INFO - 'branch': 'Mozilla-Aurora', 03:59:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:46 INFO - 'config_files': ('talos/linux_config.py',), 03:59:46 INFO - 'default_actions': ('clobber', 03:59:46 INFO - 'read-buildbot-config', 03:59:46 INFO - 'download-and-extract', 03:59:46 INFO - 'populate-webroot', 03:59:46 INFO - 'create-virtualenv', 03:59:46 INFO - 'install', 03:59:46 INFO - 'run-tests'), 03:59:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:46 INFO - 'download_minidump_stackwalk': True, 03:59:46 INFO - 'download_symbols': 'ondemand', 03:59:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:46 INFO - 'installer_path': 'installer.exe', 03:59:46 INFO - 'log_level': 'info', 03:59:46 INFO - 'log_name': 'talos', 03:59:46 INFO - 'log_to_console': True, 03:59:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:46 INFO - 'opt_config_files': (), 03:59:46 INFO - 'pip_index': False, 03:59:46 INFO - 'sps_profile': False, 03:59:46 INFO - 'sps_profile_interval': 0, 03:59:46 INFO - 'suite': 'dromaeojs-e10s', 03:59:46 INFO - 'system_bits': '32', 03:59:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:46 INFO - 'title': 'talos-linux64-ix-046', 03:59:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:46 INFO - 'use_talos_json': True, 03:59:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:46 INFO - 'work_dir': 'build'} 03:59:46 INFO - ##### 03:59:46 INFO - ##### Running clobber step. 03:59:46 INFO - ##### 03:59:46 INFO - Running pre-action listener: _resource_record_pre_action 03:59:46 INFO - Running main action method: clobber 03:59:46 INFO - rmtree: /builds/slave/test/build 03:59:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:47 INFO - Running post-action listener: _resource_record_post_action 03:59:47 INFO - ##### 03:59:47 INFO - ##### Finished clobber step (success) 03:59:47 INFO - ##### 03:59:47 INFO - ##### 03:59:47 INFO - ##### Running read-buildbot-config step. 03:59:47 INFO - ##### 03:59:47 INFO - Running pre-action listener: _resource_record_pre_action 03:59:47 INFO - Running main action method: read_buildbot_config 03:59:47 INFO - Using buildbot properties: 03:59:47 INFO - { 03:59:47 INFO - "project": "", 03:59:47 INFO - "product": "firefox", 03:59:47 INFO - "script_repo_revision": "production", 03:59:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:59:47 INFO - "repository": "", 03:59:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:59:47 INFO - "buildid": "20160711004013", 03:59:47 INFO - "stage_platform": "linux64-pgo", 03:59:47 INFO - "basedir": "/builds/slave/test", 03:59:47 INFO - "nightly_build": "True", 03:59:47 INFO - "buildnumber": 438, 03:59:47 INFO - "slavename": "talos-linux64-ix-046", 03:59:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:47 INFO - "platform": "ubuntu64_hw", 03:59:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:59:47 INFO - "branch": "mozilla-aurora", 03:59:47 INFO - "repo_path": "releases/mozilla-aurora", 03:59:47 INFO - "revision": "496264b64d722c9e8c6713d4244536b258979c16", 03:59:47 INFO - "pgo_build": "True", 03:59:47 INFO - "builduid": "f8014511038842949361daa4c20680d8", 03:59:47 INFO - "slavebuilddir": "test" 03:59:47 INFO - } 03:59:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:59:47 INFO - Running post-action listener: _resource_record_post_action 03:59:47 INFO - ##### 03:59:47 INFO - ##### Finished read-buildbot-config step (success) 03:59:47 INFO - ##### 03:59:47 INFO - ##### 03:59:47 INFO - ##### Running download-and-extract step. 03:59:47 INFO - ##### 03:59:47 INFO - Running pre-action listener: _resource_record_pre_action 03:59:47 INFO - Running main action method: download_and_extract 03:59:47 INFO - mkdir: /builds/slave/test/build/tests 03:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:47 INFO - https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:59:48 INFO - Downloaded 1361 bytes. 03:59:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:59:48 INFO - Using the following test package requirements: 03:59:48 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:48 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:48 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:59:48 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'jsshell-linux-x86_64.zip'], 03:59:48 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:48 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:59:48 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:59:48 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:59:48 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:48 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:59:48 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:48 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:48 INFO - https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:50 INFO - Downloaded 24526451 bytes. 03:59:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:51 INFO - Return code: 0 03:59:51 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:51 INFO - https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:59:52 INFO - Downloaded 24526451 bytes. 03:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:59:54 INFO - Return code: 0 03:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:54 INFO - https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:59:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:59:55 INFO - Downloaded 10833369 bytes. 03:59:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:59:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:59:56 INFO - Return code: 0 03: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')]} 03:59:56 INFO - https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:59:57 INFO - Downloaded 63609406 bytes. 03:59:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:59:57 INFO - mkdir: /builds/slave/test/properties 03:59:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:57 INFO - Contents: 03:59:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:59:58 INFO - Running post-action listener: _resource_record_post_action 03:59:58 INFO - Running post-action listener: set_extra_try_arguments 03:59:58 INFO - ##### 03:59:58 INFO - ##### Finished download-and-extract step (success) 03:59:58 INFO - ##### 03:59:58 INFO - ##### 03:59:58 INFO - ##### Running populate-webroot step. 03:59:58 INFO - ##### 03:59:58 INFO - Running pre-action listener: _resource_record_pre_action 03:59:58 INFO - Running main action method: populate_webroot 03:59:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:59:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:59:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:59:58 INFO - '--tppagecycles', 03:59:58 INFO - '7'], 03:59:58 INFO - 'tests': ['tsvgm']}}, 03:59:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:59:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:59:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['damp', 'tps']}, 03:59:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'tests': ['damp', 'tps']}, 03:59:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['dromaeo_dom']}, 03:59:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['a11yr', 03:59:58 INFO - 'ts_paint', 03:59:58 INFO - 'tpaint', 03:59:58 INFO - 'sessionrestore', 03:59:58 INFO - 'sessionrestore_no_auto_restore', 03:59:58 INFO - 'tabpaint']}, 03:59:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['tsvgx', 03:59:58 INFO - 'tsvgr_opacity', 03:59:58 INFO - 'tart', 03:59:58 INFO - 'tscrollx', 03:59:58 INFO - 'cart']}, 03:59:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:58 INFO - 'tsvgr_opacity', 03:59:58 INFO - 'tart', 03:59:58 INFO - 'tscrollx', 03:59:58 INFO - 'cart']}, 03:59:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'talos_options': ['--disable-e10s'], 03:59:58 INFO - 'tests': ['tp5o']}, 03:59:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'tests': ['tp5o']}, 03:59:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'talos_options': ['--disable-e10s', 03:59:58 INFO - '--xperf_path', 03:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:58 INFO - 'tests': ['tp5n']}, 03:59:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:59:58 INFO - 'talos_options': ['--xperf_path', 03:59:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:58 INFO - 'tests': ['tp5n']}}, 03:59:58 INFO - 'talos.zip': {'path': '', 03:59:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:59:58 INFO - Running post-action listener: _resource_record_post_action 03:59:58 INFO - ##### 03:59:58 INFO - ##### Finished populate-webroot step (success) 03:59:58 INFO - ##### 03:59:58 INFO - ##### 03:59:58 INFO - ##### Running create-virtualenv step. 03:59:58 INFO - ##### 03:59:58 INFO - Running pre-action listener: _resource_record_pre_action 03:59:58 INFO - Running main action method: create_virtualenv 03:59:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:58 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 03:59:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:58 INFO - Using real prefix '/usr' 03:59:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:00 INFO - Installing pip.................done. 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'DISPLAY': ':0', 04:00:00 INFO - 'HOME': '/home/cltbld', 04:00:00 INFO - 'LANG': 'en_US.UTF-8', 04:00:00 INFO - 'LANGUAGE': 'en_US:en', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MAIL': '/var/mail/cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SHLVL': '1', 04:00:00 INFO - 'TERM': 'linux', 04:00:00 INFO - 'TMOUT': '86400', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - '_': '/tools/buildbot/bin/python'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:00 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'DISPLAY': ':0', 04:00:00 INFO - 'HOME': '/home/cltbld', 04:00:00 INFO - 'LANG': 'en_US.UTF-8', 04:00:00 INFO - 'LANGUAGE': 'en_US:en', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MAIL': '/var/mail/cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SHLVL': '1', 04:00:00 INFO - 'TERM': 'linux', 04:00:00 INFO - 'TMOUT': '86400', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - '_': '/tools/buildbot/bin/python'} 04:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:01 INFO - Downloading/unpacking psutil>=3.1.1 04:00:01 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 04:00:01 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 04:00:01 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 04:00:01 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 04:00:01 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 04:00:01 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 04:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:03 INFO - Installing collected packages: psutil 04:00:03 INFO - Running setup.py install for psutil 04:00:03 INFO - building 'psutil._psutil_linux' extension 04:00:03 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 04:00:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:00:03 INFO - building 'psutil._psutil_posix' extension 04:00:03 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 04:00:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:03 INFO - Successfully installed psutil 04:00:03 INFO - Cleaning up... 04:00:03 INFO - Return code: 0 04:00:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:00:03 INFO - Using env: {'DISPLAY': ':0', 04:00:03 INFO - 'HOME': '/home/cltbld', 04:00:03 INFO - 'LANG': 'en_US.UTF-8', 04:00:03 INFO - 'LANGUAGE': 'en_US:en', 04:00:03 INFO - 'LOGNAME': 'cltbld', 04:00:03 INFO - 'MAIL': '/var/mail/cltbld', 04:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:03 INFO - 'MOZ_NO_REMOTE': '1', 04:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:03 INFO - 'NO_EM_RESTART': '1', 04:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:03 INFO - 'PWD': '/builds/slave/test', 04:00:03 INFO - 'SHELL': '/bin/bash', 04:00:03 INFO - 'SHLVL': '1', 04:00:03 INFO - 'TERM': 'linux', 04:00:03 INFO - 'TMOUT': '86400', 04:00:03 INFO - 'USER': 'cltbld', 04:00:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:03 INFO - '_': '/tools/buildbot/bin/python'} 04:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:05 INFO - Installing collected packages: mozsystemmonitor 04:00:05 INFO - Running setup.py install for mozsystemmonitor 04:00:06 INFO - Successfully installed mozsystemmonitor 04:00:06 INFO - Cleaning up... 04:00:06 INFO - Return code: 0 04:00:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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', '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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04: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 jsonschema==2.5.1 04:00:06 INFO - Using env: {'DISPLAY': ':0', 04:00:06 INFO - 'HOME': '/home/cltbld', 04:00:06 INFO - 'LANG': 'en_US.UTF-8', 04:00:06 INFO - 'LANGUAGE': 'en_US:en', 04:00:06 INFO - 'LOGNAME': 'cltbld', 04:00:06 INFO - 'MAIL': '/var/mail/cltbld', 04:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:06 INFO - 'MOZ_NO_REMOTE': '1', 04:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:06 INFO - 'NO_EM_RESTART': '1', 04:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:06 INFO - 'PWD': '/builds/slave/test', 04:00:06 INFO - 'SHELL': '/bin/bash', 04:00:06 INFO - 'SHLVL': '1', 04:00:06 INFO - 'TERM': 'linux', 04:00:06 INFO - 'TMOUT': '86400', 04:00:06 INFO - 'USER': 'cltbld', 04:00:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:06 INFO - '_': '/tools/buildbot/bin/python'} 04:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:06 INFO - Downloading/unpacking jsonschema==2.5.1 04: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 04: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 04: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 04: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 04: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 04: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 04:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:08 INFO - warning: no files found matching '*.txt' 04:00:08 INFO - no previously-included directories found matching 'build' 04:00:08 INFO - no previously-included directories found matching 'dist' 04:00:08 INFO - no previously-included directories found matching '.git*' 04:00:08 INFO - Installing collected packages: jsonschema, functools32 04:00:08 INFO - Running setup.py install for functools32 04:00:08 INFO - warning: no files found matching '*.txt' 04:00:08 INFO - no previously-included directories found matching 'build' 04:00:08 INFO - no previously-included directories found matching 'dist' 04:00:08 INFO - no previously-included directories found matching '.git*' 04:00:08 INFO - Successfully installed jsonschema functools32 04:00:08 INFO - Cleaning up... 04:00:08 INFO - Return code: 0 04:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:08 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:08 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 04:00:08 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 04:00:08 INFO - Using env: {'DISPLAY': ':0', 04:00:08 INFO - 'HOME': '/home/cltbld', 04:00:08 INFO - 'LANG': 'en_US.UTF-8', 04:00:08 INFO - 'LANGUAGE': 'en_US:en', 04:00:08 INFO - 'LOGNAME': 'cltbld', 04:00:08 INFO - 'MAIL': '/var/mail/cltbld', 04:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:08 INFO - 'MOZ_NO_REMOTE': '1', 04:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:08 INFO - 'NO_EM_RESTART': '1', 04:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:08 INFO - 'PWD': '/builds/slave/test', 04:00:08 INFO - 'SHELL': '/bin/bash', 04:00:08 INFO - 'SHLVL': '1', 04:00:08 INFO - 'TERM': 'linux', 04:00:08 INFO - 'TMOUT': '86400', 04:00:08 INFO - 'USER': 'cltbld', 04:00:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:08 INFO - '_': '/tools/buildbot/bin/python'} 04:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04: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 04: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 04: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 04: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 04: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 04: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 04:00:11 INFO - Downloading docopt-0.6.1.tar.gz 04:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:11 INFO - Running setup.py install for blobuploader 04:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:11 INFO - Running setup.py install for requests 04:00:12 INFO - Running setup.py install for docopt 04:00:12 INFO - Successfully installed blobuploader requests docopt 04:00:12 INFO - Cleaning up... 04:00:12 INFO - Return code: 0 04:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:12 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')]} 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:12 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')]} 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:12 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:12 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 04:00:12 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 04:00:12 INFO - Using env: {'DISPLAY': ':0', 04:00:12 INFO - 'HOME': '/home/cltbld', 04:00:12 INFO - 'LANG': 'en_US.UTF-8', 04:00:12 INFO - 'LANGUAGE': 'en_US:en', 04:00:12 INFO - 'LOGNAME': 'cltbld', 04:00:12 INFO - 'MAIL': '/var/mail/cltbld', 04:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:12 INFO - 'MOZ_NO_REMOTE': '1', 04:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:12 INFO - 'NO_EM_RESTART': '1', 04:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:12 INFO - 'PWD': '/builds/slave/test', 04:00:12 INFO - 'SHELL': '/bin/bash', 04:00:12 INFO - 'SHLVL': '1', 04:00:12 INFO - 'TERM': 'linux', 04:00:12 INFO - 'TMOUT': '86400', 04:00:12 INFO - 'USER': 'cltbld', 04:00:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:12 INFO - '_': '/tools/buildbot/bin/python'} 04:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:12 INFO - Running setup.py (path:/tmp/pip-ksfKux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:12 INFO - Running setup.py (path:/tmp/pip-ziPsyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:12 INFO - Running setup.py (path:/tmp/pip-xW2qL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:12 INFO - Running setup.py (path:/tmp/pip-U0jkV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:12 INFO - Running setup.py (path:/tmp/pip-cF18vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:12 INFO - Running setup.py (path:/tmp/pip-en9Gv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:12 INFO - Running setup.py (path:/tmp/pip-RmQ_u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:13 INFO - Running setup.py (path:/tmp/pip-2defIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:13 INFO - Running setup.py (path:/tmp/pip-9bFT9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:13 INFO - Running setup.py (path:/tmp/pip-GsO3tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:13 INFO - Running setup.py (path:/tmp/pip-Y8uRtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:13 INFO - Running setup.py (path:/tmp/pip-fzoJEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:13 INFO - Running setup.py (path:/tmp/pip-3ErDeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:13 INFO - Running setup.py (path:/tmp/pip-9HRyOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:13 INFO - Running setup.py (path:/tmp/pip-v5m9Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:13 INFO - Running setup.py (path:/tmp/pip-GiCyjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:13 INFO - Running setup.py (path:/tmp/pip-cZSy1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:13 INFO - Running setup.py install for manifestparser 04:00:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:13 INFO - Running setup.py install for mozcrash 04:00:13 INFO - Running setup.py install for mozdebug 04:00:14 INFO - Running setup.py install for mozdevice 04:00:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozfile 04:00:14 INFO - Running setup.py install for mozhttpd 04:00:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozinfo 04:00:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozInstall 04:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozleak 04:00:14 INFO - Running setup.py install for mozlog 04:00:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for moznetwork 04:00:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:14 INFO - Running setup.py install for mozprocess 04:00:15 INFO - Running setup.py install for mozprofile 04:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:15 INFO - Running setup.py install for mozrunner 04:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:15 INFO - Running setup.py install for mozscreenshot 04:00:15 INFO - Running setup.py install for moztest 04:00:15 INFO - Running setup.py install for mozversion 04:00:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:15 INFO - Cleaning up... 04:00:15 INFO - Return code: 0 04:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:15 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:15 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 04:00:15 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 04:00:15 INFO - Using env: {'DISPLAY': ':0', 04:00:15 INFO - 'HOME': '/home/cltbld', 04:00:15 INFO - 'LANG': 'en_US.UTF-8', 04:00:15 INFO - 'LANGUAGE': 'en_US:en', 04:00:15 INFO - 'LOGNAME': 'cltbld', 04:00:15 INFO - 'MAIL': '/var/mail/cltbld', 04:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:15 INFO - 'MOZ_NO_REMOTE': '1', 04:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:15 INFO - 'NO_EM_RESTART': '1', 04:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:15 INFO - 'PWD': '/builds/slave/test', 04:00:15 INFO - 'SHELL': '/bin/bash', 04:00:15 INFO - 'SHLVL': '1', 04:00:15 INFO - 'TERM': 'linux', 04:00:15 INFO - 'TMOUT': '86400', 04:00:15 INFO - 'USER': 'cltbld', 04:00:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:15 INFO - '_': '/tools/buildbot/bin/python'} 04:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:15 INFO - Running setup.py (path:/tmp/pip-RDJKrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:15 INFO - Running setup.py (path:/tmp/pip-Fjav54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:15 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)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:15 INFO - Running setup.py (path:/tmp/pip-bMiODg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:16 INFO - Running setup.py (path:/tmp/pip-PeJsNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:16 INFO - Running setup.py (path:/tmp/pip-eQS9t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:16 INFO - Running setup.py (path:/tmp/pip-2yaUGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:16 INFO - Running setup.py (path:/tmp/pip-l5wbgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:16 INFO - Running setup.py (path:/tmp/pip-INLeA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:16 INFO - Running setup.py (path:/tmp/pip-GpqDzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:16 INFO - Running setup.py (path:/tmp/pip-ki_9U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:16 INFO - Running setup.py (path:/tmp/pip-k2VuC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:16 INFO - Running setup.py (path:/tmp/pip-h3Yc3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:16 INFO - Running setup.py (path:/tmp/pip-2k4T9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:16 INFO - Running setup.py (path:/tmp/pip-S0PVzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:16 INFO - Running setup.py (path:/tmp/pip-BERFKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:16 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)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:16 INFO - Running setup.py (path:/tmp/pip-DhT0pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:16 INFO - Running setup.py (path:/tmp/pip-BCE1bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:17 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)) 04:00:17 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)) 04:00:17 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)) 04:00:17 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)) 04:00:17 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)) 04:00:17 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)) 04:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:18 INFO - Downloading blessings-1.6.tar.gz 04:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:19 INFO - Installing collected packages: blessings 04:00:19 INFO - Running setup.py install for blessings 04:00:19 INFO - Successfully installed blessings 04:00:19 INFO - Cleaning up... 04:00:19 INFO - Return code: 0 04:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:19 INFO - Reading from file tmpfile_stdout 04:00:19 INFO - Current package versions: 04:00:19 INFO - argparse == 1.2.1 04:00:19 INFO - blessings == 1.6 04:00:19 INFO - blobuploader == 1.2.4 04:00:19 INFO - docopt == 0.6.1 04:00:19 INFO - functools32 == 3.2.3-2 04:00:19 INFO - jsonschema == 2.5.1 04:00:19 INFO - manifestparser == 1.1 04:00:19 INFO - mozInstall == 1.12 04:00:19 INFO - mozcrash == 0.17 04:00:19 INFO - mozdebug == 0.1 04:00:19 INFO - mozdevice == 0.48 04:00:19 INFO - mozfile == 1.2 04:00:19 INFO - mozhttpd == 0.7 04:00:19 INFO - mozinfo == 0.9 04:00:19 INFO - mozleak == 0.1 04:00:19 INFO - mozlog == 3.2 04:00:19 INFO - moznetwork == 0.27 04:00:19 INFO - mozprocess == 0.22 04:00:19 INFO - mozprofile == 0.28 04:00:19 INFO - mozrunner == 6.11 04:00:19 INFO - mozscreenshot == 0.1 04:00:19 INFO - mozsystemmonitor == 0.3 04:00:19 INFO - moztest == 0.7 04:00:19 INFO - mozversion == 1.4 04:00:19 INFO - psutil == 3.1.1 04:00:19 INFO - requests == 1.2.3 04:00:19 INFO - wsgiref == 0.1.2 04:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:19 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')]} 04:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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')]} 04:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:19 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 04:00:19 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 04:00:19 INFO - Using env: {'DISPLAY': ':0', 04:00:19 INFO - 'HOME': '/home/cltbld', 04:00:19 INFO - 'LANG': 'en_US.UTF-8', 04:00:19 INFO - 'LANGUAGE': 'en_US:en', 04:00:19 INFO - 'LOGNAME': 'cltbld', 04:00:19 INFO - 'MAIL': '/var/mail/cltbld', 04:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:19 INFO - 'MOZ_NO_REMOTE': '1', 04:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:19 INFO - 'NO_EM_RESTART': '1', 04:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:19 INFO - 'PWD': '/builds/slave/test', 04:00:19 INFO - 'SHELL': '/bin/bash', 04:00:19 INFO - 'SHLVL': '1', 04:00:19 INFO - 'TERM': 'linux', 04:00:19 INFO - 'TMOUT': '86400', 04:00:19 INFO - 'USER': 'cltbld', 04:00:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:19 INFO - '_': '/tools/buildbot/bin/python'} 04:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 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)) 04:00:19 INFO - Cleaning up... 04:00:19 INFO - Return code: 0 04:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:19 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')]} 04:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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')]} 04:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:19 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 04:00:19 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 04:00:19 INFO - Using env: {'DISPLAY': ':0', 04:00:19 INFO - 'HOME': '/home/cltbld', 04:00:19 INFO - 'LANG': 'en_US.UTF-8', 04:00:19 INFO - 'LANGUAGE': 'en_US:en', 04:00:19 INFO - 'LOGNAME': 'cltbld', 04:00:19 INFO - 'MAIL': '/var/mail/cltbld', 04:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:19 INFO - 'MOZ_NO_REMOTE': '1', 04:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:19 INFO - 'NO_EM_RESTART': '1', 04:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:19 INFO - 'PWD': '/builds/slave/test', 04:00:19 INFO - 'SHELL': '/bin/bash', 04:00:19 INFO - 'SHLVL': '1', 04:00:19 INFO - 'TERM': 'linux', 04:00:19 INFO - 'TMOUT': '86400', 04:00:19 INFO - 'USER': 'cltbld', 04:00:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:19 INFO - '_': '/tools/buildbot/bin/python'} 04:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:19 INFO - Cleaning up... 04:00:19 INFO - Return code: 0 04:00:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:00:19 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')]} 04:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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')]} 04:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:19 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 0x7f0eaee29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, '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': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', '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 04:00:19 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 04:00:19 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 04:00:19 INFO - Using env: {'DISPLAY': ':0', 04:00:19 INFO - 'HOME': '/home/cltbld', 04:00:19 INFO - 'LANG': 'en_US.UTF-8', 04:00:19 INFO - 'LANGUAGE': 'en_US:en', 04:00:19 INFO - 'LOGNAME': 'cltbld', 04:00:19 INFO - 'MAIL': '/var/mail/cltbld', 04:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:19 INFO - 'MOZ_NO_REMOTE': '1', 04:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:19 INFO - 'NO_EM_RESTART': '1', 04:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:19 INFO - 'PWD': '/builds/slave/test', 04:00:19 INFO - 'SHELL': '/bin/bash', 04:00:19 INFO - 'SHLVL': '1', 04:00:19 INFO - 'TERM': 'linux', 04:00:19 INFO - 'TMOUT': '86400', 04:00:19 INFO - 'USER': 'cltbld', 04:00:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:19 INFO - '_': '/tools/buildbot/bin/python'} 04:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:20 INFO - Downloading/unpacking flake8 04:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:00:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04: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 04: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 04: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 04: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 04: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 04: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 04:00:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:00:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04: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 04: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 04: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 04: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 04: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 04: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 04:00:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04: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 04: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 04: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 04: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 04: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 04: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 04:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:22 INFO - no previously-included directories found matching 'docs/_build' 04:00:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:00:22 INFO - Running setup.py install for pep8 04:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:00:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:00:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:00:22 INFO - no previously-included directories found matching 'docs/_build' 04:00:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:00:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:00:22 INFO - Cleaning up... 04:00:22 INFO - Return code: 0 04:00:22 INFO - Running post-action listener: _resource_record_post_action 04:00:22 INFO - Running post-action listener: _start_resource_monitoring 04:00:23 INFO - Starting resource monitoring. 04:00:23 INFO - ##### 04:00:23 INFO - ##### Finished create-virtualenv step (success) 04:00:23 INFO - ##### 04:00:23 INFO - ##### 04:00:23 INFO - ##### Running install step. 04:00:23 INFO - ##### 04:00:23 INFO - Running pre-action listener: _resource_record_pre_action 04:00:23 INFO - Running main action method: install 04:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:23 INFO - Reading from file tmpfile_stdout 04:00:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:23 INFO - Reading from file tmpfile_stdout 04:00:23 INFO - Output received: 04:00:23 INFO - Usage: mozinstall [options] installer 04:00:23 INFO - Options: 04:00:23 INFO - -h, --help show this help message and exit 04:00:23 INFO - -d DEST, --destination=DEST 04:00:23 INFO - Directory to install application into. [default: 04:00:23 INFO - "/builds/slave/test"] 04:00:23 INFO - --app=APP Application being installed. [default: firefox] 04:00:23 INFO - mkdir: /builds/slave/test/build/application 04:00:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:00:39 INFO - Reading from file tmpfile_stdout 04:00:39 INFO - Output received: 04:00:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:39 INFO - Running post-action listener: _resource_record_post_action 04:00:39 INFO - ##### 04:00:39 INFO - ##### Finished install step (success) 04:00:39 INFO - ##### 04:00:39 INFO - ##### 04:00:39 INFO - ##### Running run-tests step. 04:00:39 INFO - ##### 04:00:39 INFO - Running pre-action listener: _resource_record_pre_action 04:00:39 INFO - Running main action method: run_tests 04:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:39 INFO - Python 2.7.3 04:00:39 INFO - Return code: 0 04:00:39 INFO - grabbing minidump binary from tooltool 04:00: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')]} 04:00:39 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 0x227f1c0>, '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 0x22800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:39 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 04:00:39 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 04:00:39 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 04:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:39 INFO - Return code: 0 04:00:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:00:40 INFO - Return code: 0 04:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:00:40 INFO - Using env: {'DISPLAY': ':0', 04:00:40 INFO - 'HOME': '/home/cltbld', 04:00:40 INFO - 'LANG': 'en_US.UTF-8', 04:00:40 INFO - 'LANGUAGE': 'en_US:en', 04:00:40 INFO - 'LOGNAME': 'cltbld', 04:00:40 INFO - 'MAIL': '/var/mail/cltbld', 04:00:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:40 INFO - 'MOZ_NO_REMOTE': '1', 04:00:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:40 INFO - 'NO_EM_RESTART': '1', 04:00:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:40 INFO - 'PWD': '/builds/slave/test', 04:00:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:40 INFO - 'SHELL': '/bin/bash', 04:00:40 INFO - 'SHLVL': '1', 04:00:40 INFO - 'TERM': 'linux', 04:00:40 INFO - 'TMOUT': '86400', 04:00:40 INFO - 'USER': 'cltbld', 04:00:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490', 04:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:40 INFO - '_': '/tools/buildbot/bin/python'} 04:00:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:00:40 INFO - mozversion application_buildid: 20160711004013 04:00:40 INFO - mozversion application_changeset: 496264b64d722c9e8c6713d4244536b258979c16 04:00:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:00:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:40 INFO - mozversion application_name: Firefox 04:00:40 INFO - mozversion application_remotingname: firefox-dev 04:00:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:00:40 INFO - mozversion application_vendor: Mozilla 04:00:40 INFO - mozversion application_version: 49.0a2 04:00:40 INFO - mozversion platform_buildid: 20160711004013 04:00:40 INFO - mozversion platform_changeset: 496264b64d722c9e8c6713d4244536b258979c16 04:00:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:00:40 INFO - mozversion platform_version: 49.0a2 04:00:40 INFO - using testdate: 1468234840 04:00:40 INFO - actual date: 1468234840 04:00:40 INFO - starting webserver on 'localhost:53203' 04:00:40 INFO - SUITE-START | Running 2 tests 04:00:40 INFO - TEST-START | dromaeo_css 04:00:40 INFO - operating with platform_type : linux_ 04:00:40 INFO - Initialising browser for dromaeo_css test... 04:00:40 INFO - TEST-INFO | started process 12484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwh9l9q/profile http://localhost:53203/getInfo.html) 04:00:44 INFO - PROCESS | 12484 | __metrics Screen width/height:1600/1200 04:00:44 INFO - PROCESS | 12484 | colorDepth:24 04:00:44 INFO - PROCESS | 12484 | Browser inner width/height: 1024/697 04:00:44 INFO - PROCESS | 12484 | __metrics 04:00:45 ERROR - PROCESS | 12484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:00:46 INFO - TEST-INFO | 12484: exit 0 04:00:46 INFO - Browser initialized. 04:00:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:46 INFO - TEST-INFO | started process 12613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwh9l9q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:58 INFO - PROCESS | 12613 | RSS: Main: 156086272 04:00:58 INFO - PROCESS | 12613 | 04:01:47 INFO - PROCESS | 12613 | 1468234907801 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] 04:03:55 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53203/tests/dromaeo/cssquery-ext.html) 04:03:56 INFO - PROCESS | 12613 | RSS: Main: 160112640 04:03:56 INFO - PROCESS | 12613 | 04:06:58 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-ext.html (next: http://localhost:53203/tests/dromaeo/cssquery-jquery.html) 04:06:58 INFO - PROCESS | 12613 | RSS: Main: 157970432 04:06:58 INFO - PROCESS | 12613 | 04:10:00 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53203/tests/dromaeo/cssquery-mootools.html) 04:10:01 INFO - PROCESS | 12613 | RSS: Main: 157052928 04:10:01 INFO - PROCESS | 12613 | 04:13:03 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53203/tests/dromaeo/cssquery-prototype.html) 04:13:03 INFO - PROCESS | 12613 | RSS: Main: 157081600 04:13:03 INFO - PROCESS | 12613 | 04:16:06 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53203/tests/dromaeo/cssquery-yui.html) 04:16:06 INFO - PROCESS | 12613 | RSS: Main: 158625792 04:16:06 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | Cycle 1(1): loaded http://localhost:53203/tests/dromaeo/cssquery-yui.html (next: http://localhost:53203/tests/dromaeo/cssquery-dojo.html) 04:19:09 INFO - PROCESS | 12613 | RSS: Main: 159346688 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | __start_tp_report 04:19:09 INFO - PROCESS | 12613 | _x_x_mozilla_page_load 04:19:09 INFO - PROCESS | 12613 | _x_x_mozilla_page_load_details 04:19:09 INFO - PROCESS | 12613 | |i|pagename|runs| 04:19:09 INFO - PROCESS | 12613 | |0;dojo.html;3305.4545999910015;3316.353311104335;3326.234965957828;3352.4971254311868;3354.6645335466455;5312.203169524573;5353.437889021655;5379.058664733676;5409.134538473845;5412.107002344608;5413.323334583177;5441.075017247068;5458.863528411792;5515.4760297771645;5526.115821468566;4965.379327584043;4981.825636102737;5052.242163675442;5068.8225912093085;5076.314697515825;4949.208126699728;4961.9751901240625;5014.147594908856;5040.59675225981;5070.29015937769;4991.500849915015;5026.597872170236;5032.597392208633;5038.6724862883975;5069.695818250917;5028.472010438906;5090.160123579605;5091.745412729349;5102.107131252016;5131.461196574381;4826.22780355145;4850.5877000455;5015.799368025311;5025.296458495814;5063.924041139386;5280.947190528084;5360.222767698662;5373.865653358697;5393.514583687487;5422.8915421691345;5862.325832529271;5893.469587737124;5899.498542623882;5910.881782364371;5913.822585322448;5775.451332123442;5849.502792262663;5890.528757699374;5965.940340596582;5972.940270597325;5469.507744303032;5554.361248456439;5557.360903496109;5558.194061861048;5591.6365436246515;6033.487153591994;6042.365551617105;6046.153538504613;6049.3950604939155;6050;5591.161325801162;5596.552275817925;5687.345955215121;5821.446962538552;5823.213866128019;5761.48146666802;5770.942290577124;5772.595918285764;5779.624324418899;5780.393058728857;5660.066089095336;5670.5180059695385;5707.3721890592005;5720.513756330759;5730.255066841284;5579.2746942897165;5726.3700992890745;5760.6255593386295;5806.245188125601;5865.032269675456;4583.449986001701;4621.006483605974;4621.815127394933;4633.930491042637;4645.326427668037;4146.834126634961;4159.188958153131;4159.272127377697;4177.060161463707;4187.497500299984;5612.887742245132;5721.971390143022;5727.914081288784;5738.569607279471;5796.8550786229835;5755.22304488897;5848.473637372657;5882.617629854046;5888.263967004124;5903.793367232126;5785.0454674978155;5787.160861675117;5793.102069179284;5793.913091303634;5798.362180160179;5046.924296135561;5070.264811602297;5090.541851233407;5165.457626949192;5183.248428977777;6241.282252541016;6252.187215661935;6257.906131408033;6262.1546091278005;6263.78076767311;5877.9118313225335;5890.4698577128265;5898;5918.230630018243;5941.881162376815;5904.0553511437965;5926.051831706906;6116.122740413025;6207.875842483035;6249.78125765596;5874.089516125007;5874.089516125007;5897.705114744332;5903.498202652822;5925.348211696796;5967.731452084753;5983.252093488314;5984;5992.760289588367;5999.130126131774;5658.20785090096;5742.196092546963;5768.913466297925;5794.420557944172;5827.358990511125;5763.884722305615;5791.913121303268;5809.099589563624;5832.562557808266;5838.532917366685;5629.958457685341;5682.744276507649;5697.971510142423;5744.109663002241;5757.0788673811985;5553.805616803393;5725.141228815711;5725.7137143141845;5837.241158649348;5868.530517558671;5676.403977582459;5716.228309178207;5725.971370143123;5726.627769194989;5730.598858079894 04:19:09 INFO - PROCESS | 12613 | |1;ext.html;611.1138848669427;660.5475249454124;664.3157547725841;675.4933799650261;684.6987325576749;42517.78741106294;47101.7644911775;47480.76259618706;47606.28590571144;47659;46803;47412.762936185354;47478.52521474784;47772.76113619436;47862.28206576904;8968.192862642361;9085.909140908572;9128.361014728971;9135.771605709877;9140.908590914105;9033;9040.186383225508;9086.636534538644;9092.727218183432;9119.908800911971;9073;9097.590608422604;9099.135582119688;9145.542722863864;9145.954270228673;9071.319651026199;9096.317776166781;9126.087391260888;9138.908610913872;9159.633614655406;8956.149165829236;8997.820043599157;9002.504862232574;9017.098290170996;9037.05110963346;43325.13349732988;43718;43747.34378984318;43806.780966094964;43841.561584384064;3700.5559332880225;3716.3310604091253;3822.73240873139;3870.4581358609817;4274.252005898987;34121;34466.483002754976;34529;34641.48037779435;34716.65283347159;4700.835470758507;4724.929126063112;4726.409198850144;4737.597304229144;4796.9446721721515;368123;368530;369920;371900.14049929846;372735;63752.68123659445;64095.359046408936;64219.67890160519;64237.67881160658;64346.35653643497;38518;38519.614803851604;38544.61455385466;40907;41603.7919810399;18676.25294988185;18687;18777.718334225;18929.43211703651;18996;14090.154590724589;14168.64578385528;14170.149791012573;14199.290035498183;14228.928855355656;21098.367048988555;21208.787912120682;21356.78643213548;21511.67732484014;21568.56862862734;7808.5314881107315;7835.647395867086;7878.881816772753;8037.276645101969;8039.477433966774;1029.6859457865273;1042.723678225271;1109.4563663804677;1145.9427028648533;1200.7058270723553;33314.3337133256;33842.661573384445;33904.660953390645;34363.14092147716;34426.65573344234;1167.3696204049888;1185.046037939467;1198.9940050299692;1246.5512415530402;1246.8067449545335;17524.91237543804;17804;17968.9101554494;18002.729959050626;18076.728849067276;596417;997045;1029395;1042619;1060009;63086;64121;64147.67926160339;64279;64437;1492.3135357735564;1501.8648321651103;1504.0524469584311;1504.5110339139824;1507.2388443836012;33236.335273294884;33497.66502334945;34046.48930266098;34290;34669.13327166841;55250.72374638101;60600.39399605947;62746.68626656837;62756.37243627505;68178.65910670414;575393;582060;582966;586770;587205;47752;47805.760971196316;48037.75981120072;48288;48332.27501587549;53038.46961530335;53286.46713532815;53729.46270537245;54327;54664.726676366365;43523.12953740971;43943.946446157825;44653.330200047676;48966.51033489619;49429.50570494393;45068.32397514106;45325.54674453345;45424.55857550044;45696;45877.31184032175;44741.77629111834;45394.54605453903;45699.08601828011;45769.313460298785;45804.541954581364;38372.808135959145;38562.421563676005;38682.419763703;39290.410643840936;39358.40962385509;29812.552811707406;30582.235444114074;30619.996201861373;30786.53820192654;30945.381092378477 04:19:09 INFO - PROCESS | 12613 | |2;jquery.html;426.15621070280827;433.93490976353553;434.5806296923468;436.16474451425523;438.67099675243566;18752.812471875295;20159.697604535926;20537.28119515817;21266.89366553165;21315.36053918381;19690.212391504323;19935.003249837522;20069.59860802783;20420.693689594667;20525.07637156328;5558.277423934893;5710.257666503348;5753.1370294455955;5818.679972601505;5819.709014549277;5558.166275058733;5762.711864406784;5769.16347129666;5790.073588225885;5820.330661973885;5710.914336284959;5717.028105222102;5721.6853073080965;5721.799737009205;5723.055695810186;5495.093309603931;5700.7173385988235;5782;5784.797532086357;5804.564657650651;5138.332016837787;5150.793968241303;5169.896602067975;5194.454582268845;5242.18746094356;21576.784232157635;22608.773912260833;23945.760542394528;24827.751722482724;24979.62530562043;2227.3095340444515;2272.6022945984387;2286.8970896309706;2399.5320912422085;2488.489859578782;10650;10996.395198264092;11396.71508212293;13564.728705425934;14623.63440913975;2016.3749237736201;2054.209129485144;2071.161179722215;2116.6719158530454;2139.3368055902565;64086;85416.57291713564;85601.57199213964;86009.56995214983;88359.55820220857;11630.185886987829;11906.702332441586;11914.46384912681;11934.522619095313;12035.578754743718;16981.745273820903;17066.31734730597;17102.230399632048;17126.314947402214;17147.399841005506;8713.651453941771;8725.171108744658;8725.647524633692;8888.955555222183;8896;8052.516848989079;8072.112067672669;8186.877196842052;8292;8306.62620182081;5024.371953505812;5045.217991211368;5065.898682026339;5108.795648174106;5128.717920514333;2128.61684896717;2138.337115494202;2149.000714667687;2199.2522542335682;2208.3374987504008;1014.5485259059648;1093.814051611228;1125.178619607691;1132.9773404531863;1144.6337172105013;19753.604927901648;20015.09932053061;20347.69478457824;20398.28605998783;20690.379288621367;1087.9619213327496;1101.7025403141267;1104;1131.5869707556683;1154.9480273387717;11071.889281107247;11101.83347249792;11143.500203258161;11143.609973650884;11172.944135279435;526398;530151;533239;546830;549886;97994.51002745083;98049.50975245079;100057.99826005232;102420.48789756153;103336;1055.577768892449;1069.6523629820183;1078.3152698036804;1088.216484131424;1090.3076546393097;17359.56601084983;17866.821331786516;17877.73183402224;17902.28390864403;18153.183106759963;37773.43339849849;41250.58749412587;42203.57796422119;42590.361144583476;42950.35574466448;47987.5201247997;61509.692451537456;61774.69112654408;61867;61909.69045154745;8707.825843483222;9037.593308301011;9194.95402522983;9256;9514.476703781358;13093.672658183621;13265.336733163496;13445.327733613476;13532.661683457993;13745.450181993008;12019.579314723942;12139.757204855678;12207.206531575419;12269.38653067361;12331.876681233432;9821.85267220978;11782.941085294862;11799.174057816213;11926.821097683714;12099.88252055869;12144.14990950625;12305.384730763604;12431.129820912449;12481.56314528987;12635.494580217057;8970.955145224492;9046.502442365732;9174.174324310845;9299.860502092339;9428.10433008863;9565.33042687033;12269.57056503018;12278.877211227773;12448;12612.49550017989 04:19:09 INFO - PROCESS | 12613 | |3;mootools.html;1524.8551387618177;1571.3321838218758;1769.9734503982443;1890.3572785253011;1905.8951757653324;8068.798280043002;9283.535823208846;9299.442033477988;9910.603575856967;9942.801143977116;9368.672096476625;9632.711018669452;9655.951720241388;9745.463999480025;9767.56045977931;2374.9050037998504;2409.722881868581;2418.564658361503;2423.672804171432;2429.829911906167;2401.135591187171;2417.153996101368;2454.717707463638;2455.177515532299;2455.2020593307248;2445.8532488050687;2457.3979375053136;2462.9901740286487;2470.3330100872754;2471.1104002559064;2420.3586049696846;2438.46353802165;2459.9016039358403;2460.1266550374626;2460.5694003549306;2417.951640967171;2420.298113547069;2436.707595088583;2457.496213276274;2468.4816188600416;9640.951795240979;9658.130768230823;9665.323427360088;9675.419474831533;9678.70963871085;5626.690532020778;5655.4344565543115;5673.375928647845;5673.404292549264;5748.109043098327;3488.2573514900287;3563.198280386918;3582.0686621478603;3588.1567831559564;3634.9273014539826;1242.1491278474275;1291.8062290656383;1299.1880074953153;1305.2560040776762;1318.861519540444;13574.457021719021;13631.863681363158;13664;13683.589492315246;13724.862751372459;4793.856184314476;4879.609631229493;4886.706797592155;4933.087378834927;4960.925586116211;11372.090232781358;11471.713207169887;11494.367809770376;11579.536818527333;11592.88407115935;5549.972250138804;5620.297462817148;5623.409541998031;5677.943220567741;5678.858028549237;4621.491635920046;5126.128558145049;5188.040212560612;5198.6880787152895;5305.575553955674;4349.630281426114;4351.0645211279725;4360.149770794665;4409.911801764011;4438.068005718771;1362.203111179951;1390.5480718766441;1396.0785881318484;1404.0733116143297;1404.5505438259659;916.3906002508257;1085.5223701571283;1086.4947799273375;1088.1899674434976;1119.9888001120048;6631.204255489276;6689.364510371507;6699.162604674416;6811.318868113149;6858.039874417585;485.09771824406573;486.4527406667499;491.31216297183516;494.83175720255286;498.95010498949813;4461.397711308931;4468.262736648417;4471.083427897273;4491.910161796811;4492.663050271242;11773.293602383885;12342.382880855921;12350.876491235153;12368.876311236772;12422.56521021778;11677.06583473337;12030.939845300718;12087.758244835055;12241;12251.877481225252;8978.86531702025;9115.772105697411;9201.49391783445;9251.814963700688;9255.49094799779;6607.3062328456745;6613.437857782143;6652.334766523309;6913.239543650094;6948.166220053626;11080.889191107986;11093.611723589636;11266.042386397248;11401.543938242377;11473.827892581785;11262.493187806733;11430.828537571777;11496.597619083292;11612.709682258012;11629.53481860716;7683.039620047494;7952.6421311039985;8112.797180070545;8503.872441913252;8664.740057798275;8980.46117232968;9018.639254429749;9035.141661542142;9040.638374464948;9050.185483306534;7824.139344671968;8147.470414423044;8156.918430815853;8184.7953801155445;8280.544570048705;7825.804354890945;7977.880331795144;8056.476329038594;8086.636101375335;8282.461639993382;7628;7675.961620191863;7708.653110609924;7730.845383092419;7733.419993500623;5798.246227990334;5810.535157187331;5818.534517238695;5823.155642431739;5963.552733544915;5875.20684707559;5926.407359264212;5928.584999050197;5953.821385358447;5978.940210597838 04:19:09 INFO - PROCESS | 12613 | |4;prototype.html;349.8915336245763;352.2057759751761;353.4433267603524;355.0449291406117;356.35499745460703;5677.233573467581;5691.772329106836;5703.686297253649;5705.942940570593;5717.3139223293265;5576.470235327648;5602.271704678386;5604.495595396414;5604.691741954191;5621.4940655341015;3953.683705303576;4318;4379.474463064436;4414.690971631987;4432.844850430236;4393.209222339978;4404.713693609921;4408.258737798567;4420.845270415536;4436.29019356903;4372.322290045032;4382.167388196249;4394.494633117184;4396.318570621543;4403.427554417921;4269.957300426987;4363.956360436387;4364.236258654739;4379.233634114017;4383.649308055348;3865.4588357629955;3883.1262965832743;3890.630390112935;3892.5134358205223;3892.9805350973347;5378.300820893298;5389.541888939445;5408.3509978802795;5446.937847119813;5463.808766693186;4786.353842231289;4981.153203955337;4994.975025124888;5013.54607163922;5021.924671129899;5890.70546472679;5927.3776253493625;5958.582899197015;5961.539422841388;5991.370906054889;4237;4237.915241695179;4267.359896015591;4278.422412974271;4283.400323954649;5989.221401217814;6111.2055432793895;6133.938660613426;6136.281841084459;6182.258129024501;4308.202982448194;4308.89227769302;4329.588689074533;4334.696571240046;4334.913301733947;4337.024169561823;4370.519242883281;4388.495323037828;4405.7797110144365;4412.536683648235;4861.43951574767;4974.726390048582;4978.228374601942;5006.4730257271885;5021.84934451967;5933.762649494059;5937.465628093492;5955.612885162451;6009.819705408845;6010.789622363196;1512.1834209526733;1513.402206128573;1543.938242470311;1545.7526795712631;1545.7604071368955;933.4632586262926;959.040959040959;972.9854052189223;1024.1755386913458;1041.1098510773331;5839.532837373;5839.591228613956;5859;5862.794802181903;5912.822615321547;6019.886321030624;6020.668863212478;6080.604760690541;6098.878022439526;6121.846953826101;5611.691356975324;5730.684812335361;5777.959967205859;5794.942050579524;5816.912746308809;3238.417084924736;3243.2378391078078;3247.5128730690585;3263.2005158735788;3272.8199949002556;6060.636361818305;6359.7456101755415;6364.459020983269;6384.457321127757;6447.709853056624;6116.510679145657;6142.723577439026;6164.260288765377;6191.9164146274225;6227.750889964351;6143.96928015366;6319.304876463677;6346.873062538723;6354.618722876642;6407.583507072025;6121.755129794937;6123.050927106306;6139.26328840542;6147.44672979434;6149.600275982047;6052.576319657582;6058.84852878664;6063.211782468251;6069.666168360783;6070.3019152798;6259.561830671809;6446.967765161145;6462.063000864942;6541.672916354259;6581.10431410178;4308.892277693083;4324.443200447773;4354.869353919387;4369.558045844927;4377.43093397869;5957.553183511167;6127.448529632355;6128.387161283836;6146.078088286793;6185.628862268279;5944.454441845065;5961.374055724086;6020.6989650516425;6044.274687037584;6054.84862878414;5914.911276330772;5938.109283607493;5970.880582388415;5981.730822112929;6009.579329446897;5635.295588051494;5728.856778580569;5763.510101641407;5874.619464425942;5926.762929482772;6004.489618382312;6016.2479690038745;6025.1564780931585;6037.275526936795;6040.214772079602;5561;5821.09772985188;5826.766929322949;5896.936072374635;5961.940380596138 04:19:09 INFO - PROCESS | 12613 | |5;yui.html;620.3052581109158;642.1170890026214;704.9541779784314;712.1952194020756;734.4528326396834;13832.100913440632;14474.782878256834;14609.05041172323;14609.634759131013;14668.486602968898;13341.733165336711;13393.06248562601;13408.396622152002;13409.463621455154;13427.798583021262;695.0581961442249;825.8637324841424;871.70362076894;872.520113937335;879.3624622148923;868.1622234543696;874.6195404998814;876.1632640828026;876.2551830943679;877.8507653698887;929.1219797291562;931.3340961212732;932.0586207929972;932.202966463674;934.2666007184362;920.3327587499076;920.6639576554576;920.769807548113;922.1101636920337;923.7829110159107;677.14003215916;679.0289885463785;679.5616827146463;680.7957612716166;683.4737252315739;13847.376868040861;13850.653733656638;13864.306784660726;13868.583942481742;13869.306534673327;14349.641258968504;15251.313690883826;15331.156786376745;15355.769663455058;15447.5365739028;12116.394180291038;12893.664687397762;12999.285039322833;13010.869891301156;13215.471381144742;4458.821647134111;4463.285874260136;4483.775811209426;4576.405067341258;4677.134730074947;78156;79386;79884.20115798883;82317;83380;10371.170306375472;10442.63450779219;11045.558177672803;11163.106951443864;11396.886031139748;19527.804721952598;19535.218591256475;19763.60472790536;19854.305099321453;19895;8876.068012858557;8886.155815197675;8940.955295223483;8979.551022448852;9014;4635.7450340230935;4653.767311634405;4678.555537223959;4744.928826067612;4790.5448982346625;3392.8473218705217;3494.685478306965;3500.2649443616615;3501.124718820295;3522.7181825453904;618.4155972605935;646.1309538670481;652.2499126005132;653.4315145823165;666.6533402630605;707.5966698981634;709.9041629380071;833.4540875726409;854.8119413729094;862.8188080503039;9826.950865245628;10096.848547271797;10179.491025448846;10218.948905255425;10413.739656508496;701.9613921234381;708.8086216721559;713.169157931015;717.587387252332;725.7205975699288;4708.741019243906;4733.621310295168;4773.212419950669;4792.9281060784115;4856.150173719585;111126;114123;119750.20999159936;120548.39725801315;123827;102199;102325;103543;103889.48055259827;105144.47427762965;87517;88584;89809;91600.08399916049;91653.5417322909;9411.46071435669;9484.620615175316;9488.33581649278;9507.66723164686;9524.809503810024;52620.47379526309;53118.73440632772;54839.72580137074;55178.44821551733;55917.16124258221;78165;79142.2085779158;81120;81150.59424703075;81209.12745235304;12009.339486328336;12200.572979945659;12230.327331996825;12243.142979991315;12311.076669249664;13950;14081;14101.858981410054;14444.494442694455;14717;12866.549670761853;12959.481620735065;13607.115537490032;13710.24593647359;13821.101628394123;13554.254516001714;13564.457421703022;13581.185128892299;13616.183029017895;14043.578692639237;12799.872001279868;12817.551385701456;13079.476820927437;13513.797293040809;13946.232957187452;10548.789024219319;11228.326300422;11259.49332280033;11372.384770338473;11480.712982175512;11364.43177841088;11371.692255390735;11445.542178312775;11784.646460606196;11793.11551633648 04:19:09 INFO - PROCESS | 12613 | __end_tp_report 04:19:09 INFO - PROCESS | 12613 | __start_cc_report 04:19:09 INFO - PROCESS | 12613 | _x_x_mozilla_cycle_collect,343 04:19:09 INFO - PROCESS | 12613 | __end_cc_report 04:19:09 INFO - PROCESS | 12613 | __startTimestamp1468235949388__endTimestamp 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | ------- Summary: start ------- 04:19:09 INFO - PROCESS | 12613 | Number of tests: 6 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#0] dojo.html Cycles:165 Average:5486.86 Median:5725.14 stddev:593.14 (10.4%) stddev-sans-first:569.74 04:19:09 INFO - PROCESS | 12613 | Values: 3305.5 3316.4 3326.2 3352.5 3354.7 5312.2 5353.4 5379.1 5409.1 5412.1 5413.3 5441.1 5458.9 5515.5 5526.1 4965.4 4981.8 5052.2 5068.8 5076.3 4949.2 4962.0 5014.1 5040.6 5070.3 4991.5 5026.6 5032.6 5038.7 5069.7 5028.5 5090.2 5091.7 5102.1 5131.5 4826.2 4850.6 5015.8 5025.3 5063.9 5280.9 5360.2 5373.9 5393.5 5422.9 5862.3 5893.5 5899.5 5910.9 5913.8 5775.5 5849.5 5890.5 5965.9 5972.9 5469.5 5554.4 5557.4 5558.2 5591.6 6033.5 6042.4 6046.2 6049.4 6050.0 5591.2 5596.6 5687.3 5821.4 5823.2 5761.5 5770.9 5772.6 5779.6 5780.4 5660.1 5670.5 5707.4 5720.5 5730.3 5579.3 5726.4 5760.6 5806.2 5865.0 4583.4 4621.0 4621.8 4633.9 4645.3 4146.8 4159.2 4159.3 4177.1 4187.5 5612.9 5722.0 5727.9 5738.6 5796.9 5755.2 5848.5 5882.6 5888.3 5903.8 5785.0 5787.2 5793.1 5793.9 5798.4 5046.9 5070.3 5090.5 5165.5 5183.2 6241.3 6252.2 6257.9 6262.2 6263.8 5877.9 5890.5 5898.0 5918.2 5941.9 5904.1 5926.1 6116.1 6207.9 6249.8 5874.1 5874.1 5897.7 5903.5 5925.3 5967.7 5983.3 5984.0 5992.8 5999.1 5658.2 5742.2 5768.9 5794.4 5827.4 5763.9 5791.9 5809.1 5832.6 5838.5 5630.0 5682.7 5698.0 5744.1 5757.1 5553.8 5725.1 5725.7 5837.2 5868.5 5676.4 5716.2 5726.0 5726.6 5730.6 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#1] ext.html Cycles:180 Average:78190.66 Median:45409.55 stddev:184602.74 (406.5%) stddev-sans-first:185028.70 04:19:09 INFO - PROCESS | 12613 | Values: 611.1 660.5 664.3 675.5 684.7 42517.8 47101.8 47480.8 47606.3 47659.0 46803.0 47412.8 47478.5 47772.8 47862.3 8968.2 9085.9 9128.4 9135.8 9140.9 9033.0 9040.2 9086.6 9092.7 9119.9 9073.0 9097.6 9099.1 9145.5 9146.0 9071.3 9096.3 9126.1 9138.9 9159.6 8956.1 8997.8 9002.5 9017.1 9037.1 43325.1 43718.0 43747.3 43806.8 43841.6 3700.6 3716.3 3822.7 3870.5 4274.3 34121.0 34466.5 34529.0 34641.5 34716.7 4700.8 4724.9 4726.4 4737.6 4796.9 368123.0 368530.0 369920.0 371900.1 372735.0 63752.7 64095.4 64219.7 64237.7 64346.4 38518.0 38519.6 38544.6 40907.0 41603.8 18676.3 18687.0 18777.7 18929.4 18996.0 14090.2 14168.6 14170.1 14199.3 14228.9 21098.4 21208.8 21356.8 21511.7 21568.6 7808.5 7835.6 7878.9 8037.3 8039.5 1029.7 1042.7 1109.5 1145.9 1200.7 33314.3 33842.7 33904.7 34363.1 34426.7 1167.4 1185.0 1199.0 1246.6 1246.8 17524.9 17804.0 17968.9 18002.7 18076.7 596417.0 997045.0 1029395.0 1042619.0 1060009.0 63086.0 64121.0 64147.7 64279.0 64437.0 1492.3 1501.9 1504.1 1504.5 1507.2 33236.3 33497.7 34046.5 34290.0 34669.1 55250.7 60600.4 62746.7 62756.4 68178.7 575393.0 582060.0 582966.0 586770.0 587205.0 47752.0 47805.8 48037.8 48288.0 48332.3 53038.5 53286.5 53729.5 54327.0 54664.7 43523.1 43943.9 44653.3 48966.5 49429.5 45068.3 45325.5 45424.6 45696.0 45877.3 44741.8 45394.5 45699.1 45769.3 45804.5 38372.8 38562.4 38682.4 39290.4 39358.4 29812.6 30582.2 30620.0 30786.5 30945.4 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#2] jquery.html Cycles:180 Average:30960.07 Median:2203.79 stddev:88509.33 (4016.2%) stddev-sans-first:88727.93 04:19:09 INFO - PROCESS | 12613 | Values: 426.2 433.9 434.6 436.2 438.7 18752.8 20159.7 20537.3 21266.9 21315.4 19690.2 19935.0 20069.6 20420.7 20525.1 5558.3 5710.3 5753.1 5818.7 5819.7 5558.2 5762.7 5769.2 5790.1 5820.3 5710.9 5717.0 5721.7 5721.8 5723.1 5495.1 5700.7 5782.0 5784.8 5804.6 5138.3 5150.8 5169.9 5194.5 5242.2 21576.8 22608.8 23945.8 24827.8 24979.6 2227.3 2272.6 2286.9 2399.5 2488.5 10650.0 10996.4 11396.7 13564.7 14623.6 2016.4 2054.2 2071.2 2116.7 2139.3 64086.0 85416.6 85601.6 86009.6 88359.6 11630.2 11906.7 11914.5 11934.5 12035.6 16981.7 17066.3 17102.2 17126.3 17147.4 8713.7 8725.2 8725.6 8889.0 8896.0 8052.5 8072.1 8186.9 8292.0 8306.6 5024.4 5045.2 5065.9 5108.8 5128.7 2128.6 2138.3 2149.0 2199.3 2208.3 1014.5 1093.8 1125.2 1133.0 1144.6 19753.6 20015.1 20347.7 20398.3 20690.4 1088.0 1101.7 1104.0 1131.6 1154.9 11071.9 11101.8 11143.5 11143.6 11172.9 526398.0 530151.0 533239.0 546830.0 549886.0 97994.5 98049.5 100058.0 102420.5 103336.0 1055.6 1069.7 1078.3 1088.2 1090.3 17359.6 17866.8 17877.7 17902.3 18153.2 37773.4 41250.6 42203.6 42590.4 42950.4 47987.5 61509.7 61774.7 61867.0 61909.7 8707.8 9037.6 9195.0 9256.0 9514.5 13093.7 13265.3 13445.3 13532.7 13745.5 12019.6 12139.8 12207.2 12269.4 12331.9 9821.9 11782.9 11799.2 11926.8 12099.9 12144.1 12305.4 12431.1 12481.6 12635.5 8971.0 9046.5 9174.2 9299.9 9428.1 9565.3 12269.6 12278.9 12448.0 12612.5 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#3] mootools.html Cycles:180 Average:6338.42 Median:2639.48 stddev:3685.69 (139.6%) stddev-sans-first:3678.28 04:19:09 INFO - PROCESS | 12613 | Values: 1524.9 1571.3 1770.0 1890.4 1905.9 8068.8 9283.5 9299.4 9910.6 9942.8 9368.7 9632.7 9656.0 9745.5 9767.6 2374.9 2409.7 2418.6 2423.7 2429.8 2401.1 2417.2 2454.7 2455.2 2455.2 2445.9 2457.4 2463.0 2470.3 2471.1 2420.4 2438.5 2459.9 2460.1 2460.6 2418.0 2420.3 2436.7 2457.5 2468.5 9641.0 9658.1 9665.3 9675.4 9678.7 5626.7 5655.4 5673.4 5673.4 5748.1 3488.3 3563.2 3582.1 3588.2 3634.9 1242.1 1291.8 1299.2 1305.3 1318.9 13574.5 13631.9 13664.0 13683.6 13724.9 4793.9 4879.6 4886.7 4933.1 4960.9 11372.1 11471.7 11494.4 11579.5 11592.9 5550.0 5620.3 5623.4 5677.9 5678.9 4621.5 5126.1 5188.0 5198.7 5305.6 4349.6 4351.1 4360.1 4409.9 4438.1 1362.2 1390.5 1396.1 1404.1 1404.6 916.4 1085.5 1086.5 1088.2 1120.0 6631.2 6689.4 6699.2 6811.3 6858.0 485.1 486.5 491.3 494.8 499.0 4461.4 4468.3 4471.1 4491.9 4492.7 11773.3 12342.4 12350.9 12368.9 12422.6 11677.1 12030.9 12087.8 12241.0 12251.9 8978.9 9115.8 9201.5 9251.8 9255.5 6607.3 6613.4 6652.3 6913.2 6948.2 11080.9 11093.6 11266.0 11401.5 11473.8 11262.5 11430.8 11496.6 11612.7 11629.5 7683.0 7952.6 8112.8 8503.9 8664.7 8980.5 9018.6 9035.1 9040.6 9050.2 7824.1 8147.5 8156.9 8184.8 8280.5 7825.8 7977.9 8056.5 8086.6 8282.5 7628.0 7676.0 7708.7 7730.8 7733.4 5798.2 5810.5 5818.5 5823.2 5963.6 5875.2 5926.4 5928.6 5953.8 5978.9 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#4] prototype.html Cycles:180 Average:5008.15 Median:5729.77 stddev:1485.79 (25.9%) stddev-sans-first:1448.24 04:19:09 INFO - PROCESS | 12613 | Values: 349.9 352.2 353.4 355.0 356.4 5677.2 5691.8 5703.7 5705.9 5717.3 5576.5 5602.3 5604.5 5604.7 5621.5 3953.7 4318.0 4379.5 4414.7 4432.8 4393.2 4404.7 4408.3 4420.8 4436.3 4372.3 4382.2 4394.5 4396.3 4403.4 4270.0 4364.0 4364.2 4379.2 4383.6 3865.5 3883.1 3890.6 3892.5 3893.0 5378.3 5389.5 5408.4 5446.9 5463.8 4786.4 4981.2 4995.0 5013.5 5021.9 5890.7 5927.4 5958.6 5961.5 5991.4 4237.0 4237.9 4267.4 4278.4 4283.4 5989.2 6111.2 6133.9 6136.3 6182.3 4308.2 4308.9 4329.6 4334.7 4334.9 4337.0 4370.5 4388.5 4405.8 4412.5 4861.4 4974.7 4978.2 5006.5 5021.8 5933.8 5937.5 5955.6 6009.8 6010.8 1512.2 1513.4 1543.9 1545.8 1545.8 933.5 959.0 973.0 1024.2 1041.1 5839.5 5839.6 5859.0 5862.8 5912.8 6019.9 6020.7 6080.6 6098.9 6121.8 5611.7 5730.7 5778.0 5794.9 5816.9 3238.4 3243.2 3247.5 3263.2 3272.8 6060.6 6359.7 6364.5 6384.5 6447.7 6116.5 6142.7 6164.3 6191.9 6227.8 6144.0 6319.3 6346.9 6354.6 6407.6 6121.8 6123.1 6139.3 6147.4 6149.6 6052.6 6058.8 6063.2 6069.7 6070.3 6259.6 6447.0 6462.1 6541.7 6581.1 4308.9 4324.4 4354.9 4369.6 4377.4 5957.6 6127.4 6128.4 6146.1 6185.6 5944.5 5961.4 6020.7 6044.3 6054.8 5914.9 5938.1 5970.9 5981.7 6009.6 5635.3 5728.9 5763.5 5874.6 5926.8 6004.5 6016.2 6025.2 6037.3 6040.2 5561.0 5821.1 5826.8 5896.9 5961.9 04:19:09 INFO - PROCESS | 12613 | 04:19:09 INFO - PROCESS | 12613 | [#5] yui.html Cycles:180 Average:21365.24 Median:4473.53 stddev:31324.43 (700.2%) stddev-sans-first:31373.57 04:19:09 INFO - PROCESS | 12613 | Values: 620.3 642.1 705.0 712.2 734.5 13832.1 14474.8 14609.1 14609.6 14668.5 13341.7 13393.1 13408.4 13409.5 13427.8 695.1 825.9 871.7 872.5 879.4 868.2 874.6 876.2 876.3 877.9 929.1 931.3 932.1 932.2 934.3 920.3 920.7 920.8 922.1 923.8 677.1 679.0 679.6 680.8 683.5 13847.4 13850.7 13864.3 13868.6 13869.3 14349.6 15251.3 15331.2 15355.8 15447.5 12116.4 12893.7 12999.3 13010.9 13215.5 4458.8 4463.3 4483.8 4576.4 4677.1 78156.0 79386.0 79884.2 82317.0 83380.0 10371.2 10442.6 11045.6 11163.1 11396.9 19527.8 19535.2 19763.6 19854.3 19895.0 8876.1 8886.2 8941.0 8979.6 9014.0 4635.7 4653.8 4678.6 4744.9 4790.5 3392.8 3494.7 3500.3 3501.1 3522.7 618.4 646.1 652.2 653.4 666.7 707.6 709.9 833.5 854.8 862.8 9827.0 10096.8 10179.5 10218.9 10413.7 702.0 708.8 713.2 717.6 725.7 4708.7 4733.6 4773.2 4792.9 4856.2 111126.0 114123.0 119750.2 120548.4 123827.0 102199.0 102325.0 103543.0 103889.5 105144.5 87517.0 88584.0 89809.0 91600.1 91653.5 9411.5 9484.6 9488.3 9507.7 9524.8 52620.5 53118.7 54839.7 55178.4 55917.2 78165.0 79142.2 81120.0 81150.6 81209.1 12009.3 12200.6 12230.3 12243.1 12311.1 13950.0 14081.0 14101.9 14444.5 14717.0 12866.5 12959.5 13607.1 13710.2 13821.1 13554.3 13564.5 13581.2 13616.2 14043.6 12799.9 12817.6 13079.5 13513.8 13946.2 10548.8 11228.3 11259.5 11372.4 11480.7 11364.4 11371.7 11445.5 11784.6 11793.1 04:19:09 INFO - PROCESS | 12613 | -------- Summary: end -------- 04:19:09 INFO - PROCESS | 12613 | 04:19:10 INFO - TEST-INFO | 12613: exit 0 04:19:10 INFO - TEST-OK | dromaeo_css | took 1109769ms 04:19:10 INFO - TEST-START | kraken 04:19:10 INFO - operating with platform_type : linux_ 04:19:10 INFO - Initialising browser for kraken test... 04:19:10 INFO - TEST-INFO | started process 12861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMQzwv/profile http://localhost:53203/getInfo.html) 04:19:14 INFO - PROCESS | 12861 | __metrics Screen width/height:1600/1200 04:19:14 INFO - PROCESS | 12861 | colorDepth:24 04:19:14 INFO - PROCESS | 12861 | Browser inner width/height: 1024/697 04:19:14 INFO - PROCESS | 12861 | __metrics 04:19:15 ERROR - PROCESS | 12861 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:19:16 INFO - TEST-INFO | 12861: exit 0 04:19:16 INFO - Browser initialized. 04:19:16 INFO - Running cycle 1/1 for kraken test... 04:19:16 INFO - TEST-INFO | started process 12989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMQzwv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:27 INFO - PROCESS | 12989 | RSS: Main: 155762688 04:19:27 INFO - PROCESS | 12989 | 04:19:30 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53203/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:31 INFO - PROCESS | 12989 | RSS: Main: 160288768 04:19:31 INFO - PROCESS | 12989 | 04:19:33 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53203/tests/kraken/driver.html?testName=audio-dft) 04:19:34 INFO - PROCESS | 12989 | RSS: Main: 160038912 04:19:34 INFO - PROCESS | 12989 | 04:19:37 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53203/tests/kraken/driver.html?testName=audio-fft) 04:19:38 INFO - PROCESS | 12989 | RSS: Main: 161054720 04:19:38 INFO - PROCESS | 12989 | 04:19:40 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53203/tests/kraken/driver.html?testName=audio-oscillator) 04:19:40 INFO - PROCESS | 12989 | RSS: Main: 160694272 04:19:40 INFO - PROCESS | 12989 | 04:19:43 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:43 INFO - PROCESS | 12989 | RSS: Main: 160514048 04:19:43 INFO - PROCESS | 12989 | 04:19:46 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53203/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:47 INFO - PROCESS | 12989 | RSS: Main: 159838208 04:19:47 INFO - PROCESS | 12989 | 04:19:50 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53203/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:51 INFO - PROCESS | 12989 | RSS: Main: 158048256 04:19:51 INFO - PROCESS | 12989 | 04:19:54 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53203/tests/kraken/driver.html?testName=json-parse-financial) 04:19:54 INFO - PROCESS | 12989 | RSS: Main: 158756864 04:19:54 INFO - PROCESS | 12989 | 04:19:56 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:57 INFO - PROCESS | 12989 | RSS: Main: 158371840 04:19:57 INFO - PROCESS | 12989 | 04:19:58 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:59 INFO - PROCESS | 12989 | RSS: Main: 158183424 04:19:59 INFO - PROCESS | 12989 | 04:20:01 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:02 INFO - PROCESS | 12989 | RSS: Main: 159547392 04:20:02 INFO - PROCESS | 12989 | 04:20:04 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:05 INFO - PROCESS | 12989 | RSS: Main: 159879168 04:20:05 INFO - PROCESS | 12989 | 04:20:07 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:08 INFO - PROCESS | 12989 | RSS: Main: 159559680 04:20:08 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | Cycle 1(1): loaded http://localhost:53203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53203/tests/kraken/driver.html?testName=ai-astar) 04:20:10 INFO - PROCESS | 12989 | RSS: Main: 159907840 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | __start_tp_report 04:20:10 INFO - PROCESS | 12989 | _x_x_mozilla_page_load 04:20:10 INFO - PROCESS | 12989 | _x_x_mozilla_page_load_details 04:20:10 INFO - PROCESS | 12989 | |i|pagename|runs| 04:20:10 INFO - PROCESS | 12989 | |0;ai-astar;115;105;111;111;111;111;110;110;112;112 04:20:10 INFO - PROCESS | 12989 | |1;audio-beat-detection;162;126;164;169;127;150;155;133;172;125 04:20:10 INFO - PROCESS | 12989 | |2;audio-dft;162;162;161;161;161;163;161;161;166;162 04:20:10 INFO - PROCESS | 12989 | |3;audio-fft;75;76;76;193;76;75;74;80;169;76 04:20:10 INFO - PROCESS | 12989 | |4;audio-oscillator;84;85;154;86;85;85;153;85;86;142 04:20:10 INFO - PROCESS | 12989 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;119;118;117 04:20:10 INFO - PROCESS | 12989 | |6;imaging-darkroom;147;149;147;147;147;146;147;146;150;147 04:20:10 INFO - PROCESS | 12989 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;96;96 04:20:10 INFO - PROCESS | 12989 | |8;json-parse-financial;57;55;55;60;68;57;56;55;55;55 04:20:10 INFO - PROCESS | 12989 | |9;json-stringify-tinderbox;61;60;59;59;60;59;59;60;60;60 04:20:10 INFO - PROCESS | 12989 | |10;stanford-crypto-aes;81;75;83;81;81;77;78;77;108;77 04:20:10 INFO - PROCESS | 12989 | |11;stanford-crypto-ccm;131;132;124;117;125;127;124;125;124;120 04:20:10 INFO - PROCESS | 12989 | |12;stanford-crypto-pbkdf2;161;164;154;153;154;155;156;154;165;154 04:20:10 INFO - PROCESS | 12989 | |13;stanford-crypto-sha256-iterative;62;62;62;63;62;62;61;73;66;61 04:20:10 INFO - PROCESS | 12989 | __end_tp_report 04:20:10 INFO - PROCESS | 12989 | __start_cc_report 04:20:10 INFO - PROCESS | 12989 | _x_x_mozilla_cycle_collect,868 04:20:10 INFO - PROCESS | 12989 | __end_cc_report 04:20:10 INFO - PROCESS | 12989 | __startTimestamp1468236010513__endTimestamp 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | ------- Summary: start ------- 04:20:10 INFO - PROCESS | 12989 | Number of tests: 14 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:2.12 04:20:10 INFO - PROCESS | 12989 | Values: 115.0 105.0 111.0 111.0 111.0 111.0 110.0 110.0 112.0 112.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:158.50 stddev:18.86 (11.9%) stddev-sans-first:19.34 04:20:10 INFO - PROCESS | 12989 | Values: 162.0 126.0 164.0 169.0 127.0 150.0 155.0 133.0 172.0 125.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 04:20:10 INFO - PROCESS | 12989 | Values: 162.0 162.0 161.0 161.0 161.0 163.0 161.0 161.0 166.0 162.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:44.66 (58.8%) stddev-sans-first:46.65 04:20:10 INFO - PROCESS | 12989 | Values: 75.0 76.0 76.0 193.0 76.0 75.0 74.0 80.0 169.0 76.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:85.00 stddev:31.33 (36.9%) stddev-sans-first:32.34 04:20:10 INFO - PROCESS | 12989 | Values: 84.0 85.0 154.0 86.0 85.0 85.0 153.0 85.0 86.0 142.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:20:10 INFO - PROCESS | 12989 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 118.0 117.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.25 (0.9%) stddev-sans-first:1.32 04:20:10 INFO - PROCESS | 12989 | Values: 147.0 149.0 147.0 147.0 147.0 146.0 147.0 146.0 150.0 147.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:20:10 INFO - PROCESS | 12989 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.50 stddev:4.08 (7.2%) stddev-sans-first:4.33 04:20:10 INFO - PROCESS | 12989 | Values: 57.0 55.0 55.0 60.0 68.0 57.0 56.0 55.0 55.0 55.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 04:20:10 INFO - PROCESS | 12989 | Values: 61.0 60.0 59.0 59.0 60.0 59.0 59.0 60.0 60.0 60.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:79.50 stddev:9.54 (12.0%) stddev-sans-first:10.12 04:20:10 INFO - PROCESS | 12989 | Values: 81.0 75.0 83.0 81.0 81.0 77.0 78.0 77.0 108.0 77.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.00 stddev:4.48 (3.6%) stddev-sans-first:4.18 04:20:10 INFO - PROCESS | 12989 | Values: 131.0 132.0 124.0 117.0 125.0 127.0 124.0 125.0 124.0 120.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:155.50 stddev:4.55 (2.9%) stddev-sans-first:4.59 04:20:10 INFO - PROCESS | 12989 | Values: 161.0 164.0 154.0 153.0 154.0 155.0 156.0 154.0 165.0 154.0 04:20:10 INFO - PROCESS | 12989 | 04:20:10 INFO - PROCESS | 12989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:62.00 stddev:3.66 (5.9%) stddev-sans-first:3.84 04:20:10 INFO - PROCESS | 12989 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 61.0 73.0 66.0 61.0 04:20:10 INFO - PROCESS | 12989 | -------- Summary: end -------- 04:20:10 INFO - PROCESS | 12989 | 04:20:11 INFO - TEST-INFO | 12989: exit 0 04:20:11 INFO - TEST-OK | kraken | took 61307ms 04:20:11 INFO - SUITE-END | took 1171s 04:20:11 INFO - Completed test suite (00:19:31) 04:20:11 INFO - javascript benchmark 04:20:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7659.044569871002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.4545999910015, 3316.353311104335, 3326.234965957828, 3352.4971254311868, 3354.6645335466455, 5312.203169524573, 5353.437889021655, 5379.058664733676, 5409.134538473845, 5412.107002344608, 5413.323334583177, 5441.075017247068, 5458.863528411792, 5515.4760297771645, 5526.115821468566, 4965.379327584043, 4981.825636102737, 5052.242163675442, 5068.8225912093085, 5076.314697515825, 4949.208126699728, 4961.9751901240625, 5014.147594908856, 5040.59675225981, 5070.29015937769, 4991.500849915015, 5026.597872170236, 5032.597392208633, 5038.6724862883975, 5069.695818250917, 5028.472010438906, 5090.160123579605, 5091.745412729349, 5102.107131252016, 5131.461196574381, 4826.22780355145, 4850.5877000455, 5015.799368025311, 5025.296458495814, 5063.924041139386, 5280.947190528084, 5360.222767698662, 5373.865653358697, 5393.514583687487, 5422.8915421691345, 5862.325832529271, 5893.469587737124, 5899.498542623882, 5910.881782364371, 5913.822585322448, 5775.451332123442, 5849.502792262663, 5890.528757699374, 5965.940340596582, 5972.940270597325, 5469.507744303032, 5554.361248456439, 5557.360903496109, 5558.194061861048, 5591.6365436246515, 6033.487153591994, 6042.365551617105, 6046.153538504613, 6049.3950604939155, 6050.0, 5591.161325801162, 5596.552275817925, 5687.345955215121, 5821.446962538552, 5823.213866128019, 5761.48146666802, 5770.942290577124, 5772.595918285764, 5779.624324418899, 5780.393058728857, 5660.066089095336, 5670.5180059695385, 5707.3721890592005, 5720.513756330759, 5730.255066841284, 5579.2746942897165, 5726.3700992890745, 5760.6255593386295, 5806.245188125601, 5865.032269675456, 4583.449986001701, 4621.006483605974, 4621.815127394933, 4633.930491042637, 4645.326427668037, 4146.834126634961, 4159.188958153131, 4159.272127377697, 4177.060161463707, 4187.497500299984, 5612.887742245132, 5721.971390143022, 5727.914081288784, 5738.569607279471, 5796.8550786229835, 5755.22304488897, 5848.473637372657, 5882.617629854046, 5888.263967004124, 5903.793367232126, 5785.0454674978155, 5787.160861675117, 5793.102069179284, 5793.913091303634, 5798.362180160179, 5046.924296135561, 5070.264811602297, 5090.541851233407, 5165.457626949192, 5183.248428977777, 6241.282252541016, 6252.187215661935, 6257.906131408033, 6262.1546091278005, 6263.78076767311, 5877.9118313225335, 5890.4698577128265, 5898.0, 5918.230630018243, 5941.881162376815, 5904.0553511437965, 5926.051831706906, 6116.122740413025, 6207.875842483035, 6249.78125765596, 5874.089516125007, 5874.089516125007, 5897.705114744332, 5903.498202652822, 5925.348211696796, 5967.731452084753, 5983.252093488314, 5984.0, 5992.760289588367, 5999.130126131774, 5658.20785090096, 5742.196092546963, 5768.913466297925, 5794.420557944172, 5827.358990511125, 5763.884722305615, 5791.913121303268, 5809.099589563624, 5832.562557808266, 5838.532917366685, 5629.958457685341, 5682.744276507649, 5697.971510142423, 5744.109663002241, 5757.0788673811985, 5553.805616803393, 5725.141228815711, 5725.7137143141845, 5837.241158649348, 5868.530517558671, 5676.403977582459, 5716.228309178207, 5725.971370143123, 5726.627769194989, 5730.598858079894], "value": 5449.647193186722, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.1138848669427, 660.5475249454124, 664.3157547725841, 675.4933799650261, 684.6987325576749, 42517.78741106294, 47101.7644911775, 47480.76259618706, 47606.28590571144, 47659.0, 46803.0, 47412.762936185354, 47478.52521474784, 47772.76113619436, 47862.28206576904, 8968.192862642361, 9085.909140908572, 9128.361014728971, 9135.771605709877, 9140.908590914105, 9033.0, 9040.186383225508, 9086.636534538644, 9092.727218183432, 9119.908800911971, 9073.0, 9097.590608422604, 9099.135582119688, 9145.542722863864, 9145.954270228673, 9071.319651026199, 9096.317776166781, 9126.087391260888, 9138.908610913872, 9159.633614655406, 8956.149165829236, 8997.820043599157, 9002.504862232574, 9017.098290170996, 9037.05110963346, 43325.13349732988, 43718.0, 43747.34378984318, 43806.780966094964, 43841.561584384064, 3700.5559332880225, 3716.3310604091253, 3822.73240873139, 3870.4581358609817, 4274.252005898987, 34121.0, 34466.483002754976, 34529.0, 34641.48037779435, 34716.65283347159, 4700.835470758507, 4724.929126063112, 4726.409198850144, 4737.597304229144, 4796.9446721721515, 368123.0, 368530.0, 369920.0, 371900.14049929846, 372735.0, 63752.68123659445, 64095.359046408936, 64219.67890160519, 64237.67881160658, 64346.35653643497, 38518.0, 38519.614803851604, 38544.61455385466, 40907.0, 41603.7919810399, 18676.25294988185, 18687.0, 18777.718334225, 18929.43211703651, 18996.0, 14090.154590724589, 14168.64578385528, 14170.149791012573, 14199.290035498183, 14228.928855355656, 21098.367048988555, 21208.787912120682, 21356.78643213548, 21511.67732484014, 21568.56862862734, 7808.5314881107315, 7835.647395867086, 7878.881816772753, 8037.276645101969, 8039.477433966774, 1029.6859457865273, 1042.723678225271, 1109.4563663804677, 1145.9427028648533, 1200.7058270723553, 33314.3337133256, 33842.661573384445, 33904.660953390645, 34363.14092147716, 34426.65573344234, 1167.3696204049888, 1185.046037939467, 1198.9940050299692, 1246.5512415530402, 1246.8067449545335, 17524.91237543804, 17804.0, 17968.9101554494, 18002.729959050626, 18076.728849067276, 596417.0, 997045.0, 1029395.0, 1042619.0, 1060009.0, 63086.0, 64121.0, 64147.67926160339, 64279.0, 64437.0, 1492.3135357735564, 1501.8648321651103, 1504.0524469584311, 1504.5110339139824, 1507.2388443836012, 33236.335273294884, 33497.66502334945, 34046.48930266098, 34290.0, 34669.13327166841, 55250.72374638101, 60600.39399605947, 62746.68626656837, 62756.37243627505, 68178.65910670414, 575393.0, 582060.0, 582966.0, 586770.0, 587205.0, 47752.0, 47805.760971196316, 48037.75981120072, 48288.0, 48332.27501587549, 53038.46961530335, 53286.46713532815, 53729.46270537245, 54327.0, 54664.726676366365, 43523.12953740971, 43943.946446157825, 44653.330200047676, 48966.51033489619, 49429.50570494393, 45068.32397514106, 45325.54674453345, 45424.55857550044, 45696.0, 45877.31184032175, 44741.77629111834, 45394.54605453903, 45699.08601828011, 45769.313460298785, 45804.541954581364, 38372.808135959145, 38562.421563676005, 38682.419763703, 39290.410643840936, 39358.40962385509, 29812.552811707406, 30582.235444114074, 30619.996201861373, 30786.53820192654, 30945.381092378477], "value": 22168.560841925726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.15621070280827, 433.93490976353553, 434.5806296923468, 436.16474451425523, 438.67099675243566, 18752.812471875295, 20159.697604535926, 20537.28119515817, 21266.89366553165, 21315.36053918381, 19690.212391504323, 19935.003249837522, 20069.59860802783, 20420.693689594667, 20525.07637156328, 5558.277423934893, 5710.257666503348, 5753.1370294455955, 5818.679972601505, 5819.709014549277, 5558.166275058733, 5762.711864406784, 5769.16347129666, 5790.073588225885, 5820.330661973885, 5710.914336284959, 5717.028105222102, 5721.6853073080965, 5721.799737009205, 5723.055695810186, 5495.093309603931, 5700.7173385988235, 5782.0, 5784.797532086357, 5804.564657650651, 5138.332016837787, 5150.793968241303, 5169.896602067975, 5194.454582268845, 5242.18746094356, 21576.784232157635, 22608.773912260833, 23945.760542394528, 24827.751722482724, 24979.62530562043, 2227.3095340444515, 2272.6022945984387, 2286.8970896309706, 2399.5320912422085, 2488.489859578782, 10650.0, 10996.395198264092, 11396.71508212293, 13564.728705425934, 14623.63440913975, 2016.3749237736201, 2054.209129485144, 2071.161179722215, 2116.6719158530454, 2139.3368055902565, 64086.0, 85416.57291713564, 85601.57199213964, 86009.56995214983, 88359.55820220857, 11630.185886987829, 11906.702332441586, 11914.46384912681, 11934.522619095313, 12035.578754743718, 16981.745273820903, 17066.31734730597, 17102.230399632048, 17126.314947402214, 17147.399841005506, 8713.651453941771, 8725.171108744658, 8725.647524633692, 8888.955555222183, 8896.0, 8052.516848989079, 8072.112067672669, 8186.877196842052, 8292.0, 8306.62620182081, 5024.371953505812, 5045.217991211368, 5065.898682026339, 5108.795648174106, 5128.717920514333, 2128.61684896717, 2138.337115494202, 2149.000714667687, 2199.2522542335682, 2208.3374987504008, 1014.5485259059648, 1093.814051611228, 1125.178619607691, 1132.9773404531863, 1144.6337172105013, 19753.604927901648, 20015.09932053061, 20347.69478457824, 20398.28605998783, 20690.379288621367, 1087.9619213327496, 1101.7025403141267, 1104.0, 1131.5869707556683, 1154.9480273387717, 11071.889281107247, 11101.83347249792, 11143.500203258161, 11143.609973650884, 11172.944135279435, 526398.0, 530151.0, 533239.0, 546830.0, 549886.0, 97994.51002745083, 98049.50975245079, 100057.99826005232, 102420.48789756153, 103336.0, 1055.577768892449, 1069.6523629820183, 1078.3152698036804, 1088.216484131424, 1090.3076546393097, 17359.56601084983, 17866.821331786516, 17877.73183402224, 17902.28390864403, 18153.183106759963, 37773.43339849849, 41250.58749412587, 42203.57796422119, 42590.361144583476, 42950.35574466448, 47987.5201247997, 61509.692451537456, 61774.69112654408, 61867.0, 61909.69045154745, 8707.825843483222, 9037.593308301011, 9194.95402522983, 9256.0, 9514.476703781358, 13093.672658183621, 13265.336733163496, 13445.327733613476, 13532.661683457993, 13745.450181993008, 12019.579314723942, 12139.757204855678, 12207.206531575419, 12269.38653067361, 12331.876681233432, 9821.85267220978, 11782.941085294862, 11799.174057816213, 11926.821097683714, 12099.88252055869, 12144.14990950625, 12305.384730763604, 12431.129820912449, 12481.56314528987, 12635.494580217057, 8970.955145224492, 9046.502442365732, 9174.174324310845, 9299.860502092339, 9428.10433008863, 9565.33042687033, 12269.57056503018, 12278.877211227773, 12448.0, 12612.49550017989], "value": 9669.131079814737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.8551387618177, 1571.3321838218758, 1769.9734503982443, 1890.3572785253011, 1905.8951757653324, 8068.798280043002, 9283.535823208846, 9299.442033477988, 9910.603575856967, 9942.801143977116, 9368.672096476625, 9632.711018669452, 9655.951720241388, 9745.463999480025, 9767.56045977931, 2374.9050037998504, 2409.722881868581, 2418.564658361503, 2423.672804171432, 2429.829911906167, 2401.135591187171, 2417.153996101368, 2454.717707463638, 2455.177515532299, 2455.2020593307248, 2445.8532488050687, 2457.3979375053136, 2462.9901740286487, 2470.3330100872754, 2471.1104002559064, 2420.3586049696846, 2438.46353802165, 2459.9016039358403, 2460.1266550374626, 2460.5694003549306, 2417.951640967171, 2420.298113547069, 2436.707595088583, 2457.496213276274, 2468.4816188600416, 9640.951795240979, 9658.130768230823, 9665.323427360088, 9675.419474831533, 9678.70963871085, 5626.690532020778, 5655.4344565543115, 5673.375928647845, 5673.404292549264, 5748.109043098327, 3488.2573514900287, 3563.198280386918, 3582.0686621478603, 3588.1567831559564, 3634.9273014539826, 1242.1491278474275, 1291.8062290656383, 1299.1880074953153, 1305.2560040776762, 1318.861519540444, 13574.457021719021, 13631.863681363158, 13664.0, 13683.589492315246, 13724.862751372459, 4793.856184314476, 4879.609631229493, 4886.706797592155, 4933.087378834927, 4960.925586116211, 11372.090232781358, 11471.713207169887, 11494.367809770376, 11579.536818527333, 11592.88407115935, 5549.972250138804, 5620.297462817148, 5623.409541998031, 5677.943220567741, 5678.858028549237, 4621.491635920046, 5126.128558145049, 5188.040212560612, 5198.6880787152895, 5305.575553955674, 4349.630281426114, 4351.0645211279725, 4360.149770794665, 4409.911801764011, 4438.068005718771, 1362.203111179951, 1390.5480718766441, 1396.0785881318484, 1404.0733116143297, 1404.5505438259659, 916.3906002508257, 1085.5223701571283, 1086.4947799273375, 1088.1899674434976, 1119.9888001120048, 6631.204255489276, 6689.364510371507, 6699.162604674416, 6811.318868113149, 6858.039874417585, 485.09771824406573, 486.4527406667499, 491.31216297183516, 494.83175720255286, 498.95010498949813, 4461.397711308931, 4468.262736648417, 4471.083427897273, 4491.910161796811, 4492.663050271242, 11773.293602383885, 12342.382880855921, 12350.876491235153, 12368.876311236772, 12422.56521021778, 11677.06583473337, 12030.939845300718, 12087.758244835055, 12241.0, 12251.877481225252, 8978.86531702025, 9115.772105697411, 9201.49391783445, 9251.814963700688, 9255.49094799779, 6607.3062328456745, 6613.437857782143, 6652.334766523309, 6913.239543650094, 6948.166220053626, 11080.889191107986, 11093.611723589636, 11266.042386397248, 11401.543938242377, 11473.827892581785, 11262.493187806733, 11430.828537571777, 11496.597619083292, 11612.709682258012, 11629.53481860716, 7683.039620047494, 7952.6421311039985, 8112.797180070545, 8503.872441913252, 8664.740057798275, 8980.46117232968, 9018.639254429749, 9035.141661542142, 9040.638374464948, 9050.185483306534, 7824.139344671968, 8147.470414423044, 8156.918430815853, 8184.7953801155445, 8280.544570048705, 7825.804354890945, 7977.880331795144, 8056.476329038594, 8086.636101375335, 8282.461639993382, 7628.0, 7675.961620191863, 7708.653110609924, 7730.845383092419, 7733.419993500623, 5798.246227990334, 5810.535157187331, 5818.534517238695, 5823.155642431739, 5963.552733544915, 5875.20684707559, 5926.407359264212, 5928.584999050197, 5953.821385358447, 5978.940210597838], "value": 4960.053417730471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8915336245763, 352.2057759751761, 353.4433267603524, 355.0449291406117, 356.35499745460703, 5677.233573467581, 5691.772329106836, 5703.686297253649, 5705.942940570593, 5717.3139223293265, 5576.470235327648, 5602.271704678386, 5604.495595396414, 5604.691741954191, 5621.4940655341015, 3953.683705303576, 4318.0, 4379.474463064436, 4414.690971631987, 4432.844850430236, 4393.209222339978, 4404.713693609921, 4408.258737798567, 4420.845270415536, 4436.29019356903, 4372.322290045032, 4382.167388196249, 4394.494633117184, 4396.318570621543, 4403.427554417921, 4269.957300426987, 4363.956360436387, 4364.236258654739, 4379.233634114017, 4383.649308055348, 3865.4588357629955, 3883.1262965832743, 3890.630390112935, 3892.5134358205223, 3892.9805350973347, 5378.300820893298, 5389.541888939445, 5408.3509978802795, 5446.937847119813, 5463.808766693186, 4786.353842231289, 4981.153203955337, 4994.975025124888, 5013.54607163922, 5021.924671129899, 5890.70546472679, 5927.3776253493625, 5958.582899197015, 5961.539422841388, 5991.370906054889, 4237.0, 4237.915241695179, 4267.359896015591, 4278.422412974271, 4283.400323954649, 5989.221401217814, 6111.2055432793895, 6133.938660613426, 6136.281841084459, 6182.258129024501, 4308.202982448194, 4308.89227769302, 4329.588689074533, 4334.696571240046, 4334.913301733947, 4337.024169561823, 4370.519242883281, 4388.495323037828, 4405.7797110144365, 4412.536683648235, 4861.43951574767, 4974.726390048582, 4978.228374601942, 5006.4730257271885, 5021.84934451967, 5933.762649494059, 5937.465628093492, 5955.612885162451, 6009.819705408845, 6010.789622363196, 1512.1834209526733, 1513.402206128573, 1543.938242470311, 1545.7526795712631, 1545.7604071368955, 933.4632586262926, 959.040959040959, 972.9854052189223, 1024.1755386913458, 1041.1098510773331, 5839.532837373, 5839.591228613956, 5859.0, 5862.794802181903, 5912.822615321547, 6019.886321030624, 6020.668863212478, 6080.604760690541, 6098.878022439526, 6121.846953826101, 5611.691356975324, 5730.684812335361, 5777.959967205859, 5794.942050579524, 5816.912746308809, 3238.417084924736, 3243.2378391078078, 3247.5128730690585, 3263.2005158735788, 3272.8199949002556, 6060.636361818305, 6359.7456101755415, 6364.459020983269, 6384.457321127757, 6447.709853056624, 6116.510679145657, 6142.723577439026, 6164.260288765377, 6191.9164146274225, 6227.750889964351, 6143.96928015366, 6319.304876463677, 6346.873062538723, 6354.618722876642, 6407.583507072025, 6121.755129794937, 6123.050927106306, 6139.26328840542, 6147.44672979434, 6149.600275982047, 6052.576319657582, 6058.84852878664, 6063.211782468251, 6069.666168360783, 6070.3019152798, 6259.561830671809, 6446.967765161145, 6462.063000864942, 6541.672916354259, 6581.10431410178, 4308.892277693083, 4324.443200447773, 4354.869353919387, 4369.558045844927, 4377.43093397869, 5957.553183511167, 6127.448529632355, 6128.387161283836, 6146.078088286793, 6185.628862268279, 5944.454441845065, 5961.374055724086, 6020.6989650516425, 6044.274687037584, 6054.84862878414, 5914.911276330772, 5938.109283607493, 5970.880582388415, 5981.730822112929, 6009.579329446897, 5635.295588051494, 5728.856778580569, 5763.510101641407, 5874.619464425942, 5926.762929482772, 6004.489618382312, 6016.2479690038745, 6025.1564780931585, 6037.275526936795, 6040.214772079602, 5561.0, 5821.09772985188, 5826.766929322949, 5896.936072374635, 5961.940380596138], "value": 4533.11601977202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.3052581109158, 642.1170890026214, 704.9541779784314, 712.1952194020756, 734.4528326396834, 13832.100913440632, 14474.782878256834, 14609.05041172323, 14609.634759131013, 14668.486602968898, 13341.733165336711, 13393.06248562601, 13408.396622152002, 13409.463621455154, 13427.798583021262, 695.0581961442249, 825.8637324841424, 871.70362076894, 872.520113937335, 879.3624622148923, 868.1622234543696, 874.6195404998814, 876.1632640828026, 876.2551830943679, 877.8507653698887, 929.1219797291562, 931.3340961212732, 932.0586207929972, 932.202966463674, 934.2666007184362, 920.3327587499076, 920.6639576554576, 920.769807548113, 922.1101636920337, 923.7829110159107, 677.14003215916, 679.0289885463785, 679.5616827146463, 680.7957612716166, 683.4737252315739, 13847.376868040861, 13850.653733656638, 13864.306784660726, 13868.583942481742, 13869.306534673327, 14349.641258968504, 15251.313690883826, 15331.156786376745, 15355.769663455058, 15447.5365739028, 12116.394180291038, 12893.664687397762, 12999.285039322833, 13010.869891301156, 13215.471381144742, 4458.821647134111, 4463.285874260136, 4483.775811209426, 4576.405067341258, 4677.134730074947, 78156.0, 79386.0, 79884.20115798883, 82317.0, 83380.0, 10371.170306375472, 10442.63450779219, 11045.558177672803, 11163.106951443864, 11396.886031139748, 19527.804721952598, 19535.218591256475, 19763.60472790536, 19854.305099321453, 19895.0, 8876.068012858557, 8886.155815197675, 8940.955295223483, 8979.551022448852, 9014.0, 4635.7450340230935, 4653.767311634405, 4678.555537223959, 4744.928826067612, 4790.5448982346625, 3392.8473218705217, 3494.685478306965, 3500.2649443616615, 3501.124718820295, 3522.7181825453904, 618.4155972605935, 646.1309538670481, 652.2499126005132, 653.4315145823165, 666.6533402630605, 707.5966698981634, 709.9041629380071, 833.4540875726409, 854.8119413729094, 862.8188080503039, 9826.950865245628, 10096.848547271797, 10179.491025448846, 10218.948905255425, 10413.739656508496, 701.9613921234381, 708.8086216721559, 713.169157931015, 717.587387252332, 725.7205975699288, 4708.741019243906, 4733.621310295168, 4773.212419950669, 4792.9281060784115, 4856.150173719585, 111126.0, 114123.0, 119750.20999159936, 120548.39725801315, 123827.0, 102199.0, 102325.0, 103543.0, 103889.48055259827, 105144.47427762965, 87517.0, 88584.0, 89809.0, 91600.08399916049, 91653.5417322909, 9411.46071435669, 9484.620615175316, 9488.33581649278, 9507.66723164686, 9524.809503810024, 52620.47379526309, 53118.73440632772, 54839.72580137074, 55178.44821551733, 55917.16124258221, 78165.0, 79142.2085779158, 81120.0, 81150.59424703075, 81209.12745235304, 12009.339486328336, 12200.572979945659, 12230.327331996825, 12243.142979991315, 12311.076669249664, 13950.0, 14081.0, 14101.858981410054, 14444.494442694455, 14717.0, 12866.549670761853, 12959.481620735065, 13607.115537490032, 13710.24593647359, 13821.101628394123, 13554.254516001714, 13564.457421703022, 13581.185128892299, 13616.183029017895, 14043.578692639237, 12799.872001279868, 12817.551385701456, 13079.476820927437, 13513.797293040809, 13946.232957187452, 10548.789024219319, 11228.326300422, 11259.49332280033, 11372.384770338473, 11480.712982175512, 11364.43177841088, 11371.692255390735, 11445.542178312775, 11784.646460606196, 11793.11551633648], "value": 7684.7052313731965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 105.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 164.0, 169.0, 127.0, 150.0, 155.0, 133.0, 172.0, 125.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 166.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 193.0, 76.0, 75.0, 74.0, 80.0, 169.0, 76.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 154.0, 86.0, 85.0, 85.0, 153.0, 85.0, 86.0, 142.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 150.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 60.0, 68.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 83.0, 81.0, 81.0, 77.0, 78.0, 77.0, 108.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 124.0, 117.0, 125.0, 127.0, 124.0, 125.0, 124.0, 120.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 154.0, 153.0, 154.0, 155.0, 156.0, 154.0, 165.0, 154.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 73.0, 66.0, 61.0], "value": 63.4, "unit": "score"}]}]} 04:20:11 INFO - Return code: 0 04:20:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:11 ERROR - # TBPL SUCCESS # 04:20:11 INFO - Running post-action listener: _resource_record_post_action 04:20:11 INFO - ##### 04:20:11 INFO - ##### Finished run-tests step (success) 04:20:11 INFO - ##### 04:20:11 INFO - Running post-run listener: _resource_record_post_run 04:20:11 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 294912; Write bytes: 511127552; Read time: 252; Write time: 532272 04:20:11 INFO - TinderboxPrint: CPU usage
13.3% 04:20:11 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 252 04:20:11 INFO - TinderboxPrint: I/O write bytes / time
511,127,552 / 532,272 04:20:11 INFO - TinderboxPrint: CPU idle
8,214.0 (86.7%) 04:20:11 INFO - TinderboxPrint: CPU user
1,209.2 (12.8%) 04:20:11 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 263290880; Read time: 0; Write time: 300604 04:20:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 246972416; Read time: 240; Write time: 231644 04:20:12 INFO - Running post-run listener: _upload_blobber_files 04:20:12 INFO - Blob upload gear active. 04:20:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:12 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 04:20:12 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:20:12 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:20:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:13 INFO - (blobuploader) - INFO - Done attempting. 04:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:14 INFO - (blobuploader) - INFO - Done attempting. 04:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:17 INFO - (blobuploader) - INFO - Done attempting. 04:20:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:17 INFO - Return code: 0 04:20:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef7d4f0ab04eda917b2d984c74af13ea817614bdb443cccf9b3082caa6024e8a301d21460bd7240359043eea35a0675d5139b9bd112d8feea3c3ac080d5c4a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0f9f161bc205fac6c53b5bf1fe4d8afa5f0d8dd95ab0cdcc6591a442450a09fbe9df4b9506d71d29e84fdb5b87148e0ec086f63686324f9e282f5da68876f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0777a6a289e1553e3f1ecbb0f76e5531269b0c3fdd71d6a356604b1b5378a8c8a3715b25de3a7938949f1282d5f855e783db16490b78bb1919161d26327e70d"} 04:20:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:17 INFO - Contents: 04:20:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef7d4f0ab04eda917b2d984c74af13ea817614bdb443cccf9b3082caa6024e8a301d21460bd7240359043eea35a0675d5139b9bd112d8feea3c3ac080d5c4a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0f9f161bc205fac6c53b5bf1fe4d8afa5f0d8dd95ab0cdcc6591a442450a09fbe9df4b9506d71d29e84fdb5b87148e0ec086f63686324f9e282f5da68876f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0777a6a289e1553e3f1ecbb0f76e5531269b0c3fdd71d6a356604b1b5378a8c8a3715b25de3a7938949f1282d5f855e783db16490b78bb1919161d26327e70d"} 04:20:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:17 INFO - Copying logs to upload dir... 04:20:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.114324 ========= master_lag: 0.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-11 04:20:17.976546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:20:17.981564) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef7d4f0ab04eda917b2d984c74af13ea817614bdb443cccf9b3082caa6024e8a301d21460bd7240359043eea35a0675d5139b9bd112d8feea3c3ac080d5c4a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0f9f161bc205fac6c53b5bf1fe4d8afa5f0d8dd95ab0cdcc6591a442450a09fbe9df4b9506d71d29e84fdb5b87148e0ec086f63686324f9e282f5da68876f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0777a6a289e1553e3f1ecbb0f76e5531269b0c3fdd71d6a356604b1b5378a8c8a3715b25de3a7938949f1282d5f855e783db16490b78bb1919161d26327e70d"} build_url:https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/ZvTFaGTTSWKWRF3E2fqmmA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef7d4f0ab04eda917b2d984c74af13ea817614bdb443cccf9b3082caa6024e8a301d21460bd7240359043eea35a0675d5139b9bd112d8feea3c3ac080d5c4a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a0f9f161bc205fac6c53b5bf1fe4d8afa5f0d8dd95ab0cdcc6591a442450a09fbe9df4b9506d71d29e84fdb5b87148e0ec086f63686324f9e282f5da68876f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0777a6a289e1553e3f1ecbb0f76e5531269b0c3fdd71d6a356604b1b5378a8c8a3715b25de3a7938949f1282d5f855e783db16490b78bb1919161d26327e70d"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:20:18.147087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:20:18.147456) ========= 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=652eb03db935cfc1c15ebda0000001ad-1468234784.911952-1188318490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:20:18.166170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:20:18.167369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:20:18.167755) ========= ========= Total master_lag: 0.83 =========