builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1465470192.87 results: success (0) buildid: 20160609013053 builduid: d2352613ff5e4319a0f77be92bf18f88 revision: da40184c044a47a0a8d812dad4f8e1215ae3a025 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:12.873148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:12.873563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:12.873842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.058965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.059237) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 04:03:13-- 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% 71.0M=0s 2016-06-09 04:03:13 (71.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.191774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.192138) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021869 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.244864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:13.245181) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev da40184c044a47a0a8d812dad4f8e1215ae3a025 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev da40184c044a47a0a8d812dad4f8e1215ae3a025 --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=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:03:13,401 truncating revision to first 12 chars 2016-06-09 04:03:13,401 Setting DEBUG logging. 2016-06-09 04:03:13,402 attempt 1/10 2016-06-09 04:03:13,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/da40184c044a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 04:03:14,042 unpacking tar archive at: mozilla-inbound-da40184c044a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.952209 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:14.211144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:14.211479) ========= script_repo_revision: da40184c044a47a0a8d812dad4f8e1215ae3a025 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:14.211945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:14.212262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:03:14.223031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 04:03:14.223361) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:03:14 INFO - MultiFileLogger online at 20160609 04:03:14 in /builds/slave/test 04:03:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:03:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:03:14 INFO - {'append_to_log': False, 04:03:14 INFO - 'base_work_dir': '/builds/slave/test', 04:03:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:03:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:03:14 INFO - 'branch': 'Mozilla-Inbound', 04:03:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:03:14 INFO - 'config_files': ('talos/linux_config.py',), 04:03:14 INFO - 'default_actions': ('clobber', 04:03:14 INFO - 'read-buildbot-config', 04:03:14 INFO - 'download-and-extract', 04:03:14 INFO - 'populate-webroot', 04:03:14 INFO - 'create-virtualenv', 04:03:14 INFO - 'install', 04:03:14 INFO - 'run-tests'), 04:03:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:03:14 INFO - 'download_minidump_stackwalk': True, 04:03:14 INFO - 'download_symbols': 'ondemand', 04:03:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:03:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:03:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:03:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:03:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:03:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:03:14 INFO - 'installer_path': 'installer.exe', 04:03:14 INFO - 'log_level': 'info', 04:03:14 INFO - 'log_name': 'talos', 04:03:14 INFO - 'log_to_console': True, 04:03:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:03:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:03:14 INFO - 'opt_config_files': (), 04:03:14 INFO - 'pip_index': False, 04:03:14 INFO - 'sps_profile': False, 04:03:14 INFO - 'sps_profile_interval': 0, 04:03:14 INFO - 'suite': 'dromaeojs-e10s', 04:03:14 INFO - 'system_bits': '32', 04:03:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:03:14 INFO - 'title': 'talos-linux64-ix-061', 04:03:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:03:14 INFO - 'use_talos_json': True, 04:03:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:03:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:03:14 INFO - 'work_dir': 'build'} 04:03:14 INFO - ##### 04:03:14 INFO - ##### Running clobber step. 04:03:14 INFO - ##### 04:03:14 INFO - Running pre-action listener: _resource_record_pre_action 04:03:14 INFO - Running main action method: clobber 04:03:14 INFO - rmtree: /builds/slave/test/build 04:03:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:03:14 INFO - Running post-action listener: _resource_record_post_action 04:03:14 INFO - ##### 04:03:14 INFO - ##### Finished clobber step (success) 04:03:14 INFO - ##### 04:03:14 INFO - ##### 04:03:14 INFO - ##### Running read-buildbot-config step. 04:03:14 INFO - ##### 04:03:14 INFO - Running pre-action listener: _resource_record_pre_action 04:03:14 INFO - Running main action method: read_buildbot_config 04:03:14 INFO - Using buildbot properties: 04:03:14 INFO - { 04:03:14 INFO - "project": "", 04:03:14 INFO - "product": "firefox", 04:03:14 INFO - "script_repo_revision": "production", 04:03:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:03:14 INFO - "repository": "", 04:03:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:03:14 INFO - "buildid": "20160609013053", 04:03:14 INFO - "pgo_build": "True", 04:03:14 INFO - "basedir": "/builds/slave/test", 04:03:14 INFO - "buildnumber": 672, 04:03:14 INFO - "slavename": "talos-linux64-ix-061", 04:03:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:03:14 INFO - "platform": "ubuntu64_hw", 04:03:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:03:14 INFO - "branch": "mozilla-inbound", 04:03:14 INFO - "repo_path": "integration/mozilla-inbound", 04:03:14 INFO - "revision": "da40184c044a47a0a8d812dad4f8e1215ae3a025", 04:03:14 INFO - "stage_platform": "linux64-pgo", 04:03:14 INFO - "builduid": "d2352613ff5e4319a0f77be92bf18f88", 04:03:14 INFO - "slavebuilddir": "test" 04:03:14 INFO - } 04:03:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:03:14 INFO - Running post-action listener: _resource_record_post_action 04:03:14 INFO - ##### 04:03:14 INFO - ##### Finished read-buildbot-config step (success) 04:03:14 INFO - ##### 04:03:14 INFO - ##### 04:03:14 INFO - ##### Running download-and-extract step. 04:03:14 INFO - ##### 04:03:14 INFO - Running pre-action listener: _resource_record_pre_action 04:03:14 INFO - Running main action method: download_and_extract 04:03:14 INFO - mkdir: /builds/slave/test/build/tests 04:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:14 INFO - https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:03:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:03:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:03:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:03:19 INFO - Downloaded 1361 bytes. 04:03:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:03:19 INFO - Using the following test package requirements: 04:03:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:03:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:03:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:03:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'jsshell-linux-x86_64.zip'], 04:03:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:03:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:03:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:03:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:03:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:03:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:03:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:03:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:03: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:03:19 INFO - https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:03:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:03:21 INFO - Downloaded 24452135 bytes. 04:03:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:03:22 INFO - Return code: 0 04:03:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:03:22 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:03:22 INFO - https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:03:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:03:23 INFO - Downloaded 24452135 bytes. 04:03:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:03:25 INFO - Return code: 0 04:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:25 INFO - https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:03:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:03:26 INFO - Downloaded 10833377 bytes. 04:03:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:03:26 INFO - Return code: 0 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:26 INFO - https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:03:28 INFO - Downloaded 59355161 bytes. 04:03:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:03:28 INFO - mkdir: /builds/slave/test/properties 04:03:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:03:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:03:28 INFO - Contents: 04:03:28 INFO - build_url:https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:03:29 INFO - Running post-action listener: _resource_record_post_action 04:03:29 INFO - Running post-action listener: set_extra_try_arguments 04:03:29 INFO - ##### 04:03:29 INFO - ##### Finished download-and-extract step (success) 04:03:29 INFO - ##### 04:03:29 INFO - ##### 04:03:29 INFO - ##### Running populate-webroot step. 04:03:29 INFO - ##### 04:03:29 INFO - Running pre-action listener: _resource_record_pre_action 04:03:29 INFO - Running main action method: populate_webroot 04:03:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:03:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:03:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:03:29 INFO - '--tppagecycles', 04:03:29 INFO - '7'], 04:03:29 INFO - 'tests': ['tsvgm']}}, 04:03:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:03:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:03:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:03:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:03:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['damp', 'tps']}, 04:03:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'tests': ['damp', 'tps']}, 04:03:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['dromaeo_dom']}, 04:03:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['a11yr', 04:03:29 INFO - 'ts_paint', 04:03:29 INFO - 'tpaint', 04:03:29 INFO - 'sessionrestore', 04:03:29 INFO - 'sessionrestore_no_auto_restore', 04:03:29 INFO - 'tabpaint']}, 04:03:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['tsvgx', 04:03:29 INFO - 'tsvgr_opacity', 04:03:29 INFO - 'tart', 04:03:29 INFO - 'tscrollx', 04:03:29 INFO - 'cart']}, 04:03:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:03:29 INFO - 'tsvgr_opacity', 04:03:29 INFO - 'tart', 04:03:29 INFO - 'tscrollx', 04:03:29 INFO - 'cart']}, 04:03:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'talos_options': ['--disable-e10s'], 04:03:29 INFO - 'tests': ['tp5o']}, 04:03:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'tests': ['tp5o']}, 04:03:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'talos_options': ['--disable-e10s', 04:03:29 INFO - '--xperf_path', 04:03:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:29 INFO - 'tests': ['tp5n']}, 04:03:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:29 INFO - 'talos_options': ['--xperf_path', 04:03:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:29 INFO - 'tests': ['tp5n']}}, 04:03:29 INFO - 'talos.zip': {'path': '', 04:03:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:03:29 INFO - Running post-action listener: _resource_record_post_action 04:03:29 INFO - ##### 04:03:29 INFO - ##### Finished populate-webroot step (success) 04:03:29 INFO - ##### 04:03:29 INFO - ##### 04:03:29 INFO - ##### Running create-virtualenv step. 04:03:29 INFO - ##### 04:03:29 INFO - Running pre-action listener: _resource_record_pre_action 04:03:29 INFO - Running main action method: create_virtualenv 04:03:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:03:29 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 04:03:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:03:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:29 INFO - Using real prefix '/usr' 04:03:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:03:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:32 INFO - Installing pip.................done. 04:03:32 INFO - Return code: 0 04:03:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:03:32 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:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:32 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:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:32 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:32 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:03:32 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:03:32 INFO - Using env: {'DISPLAY': ':0', 04:03:32 INFO - 'HOME': '/home/cltbld', 04:03:32 INFO - 'LANG': 'en_US.UTF-8', 04:03:32 INFO - 'LANGUAGE': 'en_US:en', 04:03:32 INFO - 'LOGNAME': 'cltbld', 04:03:32 INFO - 'MAIL': '/var/mail/cltbld', 04:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:32 INFO - 'MOZ_NO_REMOTE': '1', 04:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:32 INFO - 'NO_EM_RESTART': '1', 04:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:32 INFO - 'PWD': '/builds/slave/test', 04:03:32 INFO - 'SHELL': '/bin/bash', 04:03:32 INFO - 'SHLVL': '1', 04:03:32 INFO - 'TERM': 'linux', 04:03:32 INFO - 'TMOUT': '86400', 04:03:32 INFO - 'USER': 'cltbld', 04:03:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:32 INFO - '_': '/tools/buildbot/bin/python'} 04:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:32 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:03:32 INFO - Cleaning up... 04:03:32 INFO - Return code: 0 04:03:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:03:32 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:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:32 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:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:32 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:32 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:03:32 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:03:32 INFO - Using env: {'DISPLAY': ':0', 04:03:32 INFO - 'HOME': '/home/cltbld', 04:03:32 INFO - 'LANG': 'en_US.UTF-8', 04:03:32 INFO - 'LANGUAGE': 'en_US:en', 04:03:32 INFO - 'LOGNAME': 'cltbld', 04:03:32 INFO - 'MAIL': '/var/mail/cltbld', 04:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:32 INFO - 'MOZ_NO_REMOTE': '1', 04:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:32 INFO - 'NO_EM_RESTART': '1', 04:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:32 INFO - 'PWD': '/builds/slave/test', 04:03:32 INFO - 'SHELL': '/bin/bash', 04:03:32 INFO - 'SHLVL': '1', 04:03:32 INFO - 'TERM': 'linux', 04:03:32 INFO - 'TMOUT': '86400', 04:03:32 INFO - 'USER': 'cltbld', 04:03:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:32 INFO - '_': '/tools/buildbot/bin/python'} 04:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:32 INFO - Downloading/unpacking psutil>=3.1.1 04:03:32 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:03:32 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:03:32 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:03:32 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:03:32 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:03:32 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:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:34 INFO - Installing collected packages: psutil 04:03:34 INFO - Running setup.py install for psutil 04:03:34 INFO - building 'psutil._psutil_linux' extension 04:03:34 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:03:34 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:03:34 INFO - building 'psutil._psutil_posix' extension 04:03:34 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:03:34 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:03:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:35 INFO - Successfully installed psutil 04:03:35 INFO - Cleaning up... 04:03:35 INFO - Return code: 0 04:03:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:35 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:35 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:03:35 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:03:35 INFO - Using env: {'DISPLAY': ':0', 04:03:35 INFO - 'HOME': '/home/cltbld', 04:03:35 INFO - 'LANG': 'en_US.UTF-8', 04:03:35 INFO - 'LANGUAGE': 'en_US:en', 04:03:35 INFO - 'LOGNAME': 'cltbld', 04:03:35 INFO - 'MAIL': '/var/mail/cltbld', 04:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:35 INFO - 'MOZ_NO_REMOTE': '1', 04:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:35 INFO - 'NO_EM_RESTART': '1', 04:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:35 INFO - 'PWD': '/builds/slave/test', 04:03:35 INFO - 'SHELL': '/bin/bash', 04:03:35 INFO - 'SHLVL': '1', 04:03:35 INFO - 'TERM': 'linux', 04:03:35 INFO - 'TMOUT': '86400', 04:03:35 INFO - 'USER': 'cltbld', 04:03:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:35 INFO - '_': '/tools/buildbot/bin/python'} 04:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:03:35 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:03:35 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:03:35 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:03:35 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:03:35 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:03:35 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:03:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:03:37 INFO - Installing collected packages: mozsystemmonitor 04:03:37 INFO - Running setup.py install for mozsystemmonitor 04:03:37 INFO - Successfully installed mozsystemmonitor 04:03:37 INFO - Cleaning up... 04:03:37 INFO - Return code: 0 04:03:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:03:37 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:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:37 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:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:37 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:37 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:03:37 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:03:37 INFO - Using env: {'DISPLAY': ':0', 04:03:37 INFO - 'HOME': '/home/cltbld', 04:03:37 INFO - 'LANG': 'en_US.UTF-8', 04:03:37 INFO - 'LANGUAGE': 'en_US:en', 04:03:37 INFO - 'LOGNAME': 'cltbld', 04:03:37 INFO - 'MAIL': '/var/mail/cltbld', 04:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:37 INFO - 'MOZ_NO_REMOTE': '1', 04:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:37 INFO - 'NO_EM_RESTART': '1', 04:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:37 INFO - 'PWD': '/builds/slave/test', 04:03:37 INFO - 'SHELL': '/bin/bash', 04:03:37 INFO - 'SHLVL': '1', 04:03:37 INFO - 'TERM': 'linux', 04:03:37 INFO - 'TMOUT': '86400', 04:03:37 INFO - 'USER': 'cltbld', 04:03:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:37 INFO - '_': '/tools/buildbot/bin/python'} 04:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:03:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:03:39 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:03:39 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:03:39 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:03:39 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:03:39 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:03:39 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:03:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:03:39 INFO - warning: no files found matching '*.txt' 04:03:39 INFO - no previously-included directories found matching 'build' 04:03:39 INFO - no previously-included directories found matching 'dist' 04:03:39 INFO - no previously-included directories found matching '.git*' 04:03:39 INFO - Installing collected packages: jsonschema, functools32 04:03:39 INFO - Running setup.py install for functools32 04:03:39 INFO - warning: no files found matching '*.txt' 04:03:39 INFO - no previously-included directories found matching 'build' 04:03:39 INFO - no previously-included directories found matching 'dist' 04:03:39 INFO - no previously-included directories found matching '.git*' 04:03:39 INFO - Successfully installed jsonschema functools32 04:03:39 INFO - Cleaning up... 04:03:39 INFO - Return code: 0 04:03:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:03: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:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:39 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:39 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:03:39 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:03:39 INFO - Using env: {'DISPLAY': ':0', 04:03:39 INFO - 'HOME': '/home/cltbld', 04:03:39 INFO - 'LANG': 'en_US.UTF-8', 04:03:39 INFO - 'LANGUAGE': 'en_US:en', 04:03:39 INFO - 'LOGNAME': 'cltbld', 04:03:39 INFO - 'MAIL': '/var/mail/cltbld', 04:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:39 INFO - 'MOZ_NO_REMOTE': '1', 04:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:39 INFO - 'NO_EM_RESTART': '1', 04:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:39 INFO - 'PWD': '/builds/slave/test', 04:03:39 INFO - 'SHELL': '/bin/bash', 04:03:39 INFO - 'SHLVL': '1', 04:03:39 INFO - 'TERM': 'linux', 04:03:39 INFO - 'TMOUT': '86400', 04:03:39 INFO - 'USER': 'cltbld', 04:03:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:39 INFO - '_': '/tools/buildbot/bin/python'} 04:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:40 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:03:40 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:03:40 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:03:40 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:03:40 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:03:40 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:03:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:42 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:03:42 INFO - Downloading docopt-0.6.1.tar.gz 04:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:42 INFO - Running setup.py install for blobuploader 04:03:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:03:42 INFO - Running setup.py install for requests 04:03:43 INFO - Running setup.py install for docopt 04:03:43 INFO - Successfully installed blobuploader requests docopt 04:03:43 INFO - Cleaning up... 04:03:43 INFO - Return code: 0 04:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:43 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:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:43 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:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:43 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:43 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:03:43 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:03:43 INFO - Using env: {'DISPLAY': ':0', 04:03:43 INFO - 'HOME': '/home/cltbld', 04:03:43 INFO - 'LANG': 'en_US.UTF-8', 04:03:43 INFO - 'LANGUAGE': 'en_US:en', 04:03:43 INFO - 'LOGNAME': 'cltbld', 04:03:43 INFO - 'MAIL': '/var/mail/cltbld', 04:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:43 INFO - 'MOZ_NO_REMOTE': '1', 04:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:43 INFO - 'NO_EM_RESTART': '1', 04:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:43 INFO - 'PWD': '/builds/slave/test', 04:03:43 INFO - 'SHELL': '/bin/bash', 04:03:43 INFO - 'SHLVL': '1', 04:03:43 INFO - 'TERM': 'linux', 04:03:43 INFO - 'TMOUT': '86400', 04:03:43 INFO - 'USER': 'cltbld', 04:03:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:43 INFO - '_': '/tools/buildbot/bin/python'} 04:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:43 INFO - Running setup.py (path:/tmp/pip-0DBbYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:43 INFO - Running setup.py (path:/tmp/pip-iYcjO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:43 INFO - Running setup.py (path:/tmp/pip-ysLgfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:43 INFO - Running setup.py (path:/tmp/pip-MNddfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:43 INFO - Running setup.py (path:/tmp/pip-auAhV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:43 INFO - Running setup.py (path:/tmp/pip-rKAnsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:44 INFO - Running setup.py (path:/tmp/pip-7YW3Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:44 INFO - Running setup.py (path:/tmp/pip-cp66Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:44 INFO - Running setup.py (path:/tmp/pip-XbY_29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:44 INFO - Running setup.py (path:/tmp/pip-EmlKub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:44 INFO - Running setup.py (path:/tmp/pip-MKBaRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:44 INFO - Running setup.py (path:/tmp/pip-d1XuUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:44 INFO - Running setup.py (path:/tmp/pip-N7o5X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:44 INFO - Running setup.py (path:/tmp/pip-sbFdPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:44 INFO - Running setup.py (path:/tmp/pip-sAOYBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:44 INFO - Running setup.py (path:/tmp/pip-AeCrTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:44 INFO - Running setup.py (path:/tmp/pip-JNGCPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:44 INFO - Running setup.py install for manifestparser 04:03:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:03:44 INFO - Running setup.py install for mozcrash 04:03:45 INFO - Running setup.py install for mozdebug 04:03:45 INFO - Running setup.py install for mozdevice 04:03:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for mozfile 04:03:45 INFO - Running setup.py install for mozhttpd 04:03:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for mozinfo 04:03:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for mozInstall 04:03:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for mozleak 04:03:45 INFO - Running setup.py install for mozlog 04:03:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for moznetwork 04:03:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:45 INFO - Running setup.py install for mozprocess 04:03:46 INFO - Running setup.py install for mozprofile 04:03:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:46 INFO - Running setup.py install for mozrunner 04:03:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:46 INFO - Running setup.py install for mozscreenshot 04:03:46 INFO - Running setup.py install for moztest 04:03:46 INFO - Running setup.py install for mozversion 04:03:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:46 INFO - Cleaning up... 04:03:46 INFO - Return code: 0 04:03:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:46 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:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:46 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:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:46 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:46 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:03:46 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:03:46 INFO - Using env: {'DISPLAY': ':0', 04:03:46 INFO - 'HOME': '/home/cltbld', 04:03:46 INFO - 'LANG': 'en_US.UTF-8', 04:03:46 INFO - 'LANGUAGE': 'en_US:en', 04:03:46 INFO - 'LOGNAME': 'cltbld', 04:03:46 INFO - 'MAIL': '/var/mail/cltbld', 04:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:46 INFO - 'MOZ_NO_REMOTE': '1', 04:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:46 INFO - 'NO_EM_RESTART': '1', 04:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:46 INFO - 'PWD': '/builds/slave/test', 04:03:46 INFO - 'SHELL': '/bin/bash', 04:03:46 INFO - 'SHLVL': '1', 04:03:46 INFO - 'TERM': 'linux', 04:03:46 INFO - 'TMOUT': '86400', 04:03:46 INFO - 'USER': 'cltbld', 04:03:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:46 INFO - '_': '/tools/buildbot/bin/python'} 04:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:46 INFO - Running setup.py (path:/tmp/pip-9UvRl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:46 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:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:46 INFO - Running setup.py (path:/tmp/pip-ch2R_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:46 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:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:46 INFO - Running setup.py (path:/tmp/pip-rTE_Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:47 INFO - Running setup.py (path:/tmp/pip-CkHXWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:47 INFO - Running setup.py (path:/tmp/pip-CUvb9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:47 INFO - Running setup.py (path:/tmp/pip-aSNXIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:47 INFO - Running setup.py (path:/tmp/pip-vczxb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:47 INFO - Running setup.py (path:/tmp/pip-WPthR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:47 INFO - Running setup.py (path:/tmp/pip-0zsCEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:47 INFO - Running setup.py (path:/tmp/pip-7Hkd_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:47 INFO - Running setup.py (path:/tmp/pip-WclLNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:47 INFO - Running setup.py (path:/tmp/pip-r3KKKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:47 INFO - Running setup.py (path:/tmp/pip-0W1Tls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:47 INFO - Running setup.py (path:/tmp/pip-46eH4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:47 INFO - Running setup.py (path:/tmp/pip-OMlaMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:47 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:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:47 INFO - Running setup.py (path:/tmp/pip-17q5cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:48 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:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:48 INFO - Running setup.py (path:/tmp/pip-0ajan2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:48 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:03:48 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:03:48 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:03:48 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:03:48 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:03:48 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:03:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:48 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:03:48 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:03:48 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:03:48 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:03:48 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:03:48 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:03:50 INFO - Downloading blessings-1.6.tar.gz 04:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:50 INFO - Installing collected packages: blessings 04:03:50 INFO - Running setup.py install for blessings 04:03:50 INFO - Successfully installed blessings 04:03:50 INFO - Cleaning up... 04:03:50 INFO - Return code: 0 04:03:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:50 INFO - Reading from file tmpfile_stdout 04:03:50 INFO - Current package versions: 04:03:50 INFO - argparse == 1.2.1 04:03:50 INFO - blessings == 1.6 04:03:50 INFO - blobuploader == 1.2.4 04:03:50 INFO - docopt == 0.6.1 04:03:50 INFO - functools32 == 3.2.3-2 04:03:50 INFO - jsonschema == 2.5.1 04:03:50 INFO - manifestparser == 1.1 04:03:50 INFO - mozInstall == 1.12 04:03:50 INFO - mozcrash == 0.17 04:03:50 INFO - mozdebug == 0.1 04:03:50 INFO - mozdevice == 0.48 04:03:50 INFO - mozfile == 1.2 04:03:50 INFO - mozhttpd == 0.7 04:03:50 INFO - mozinfo == 0.9 04:03:50 INFO - mozleak == 0.1 04:03:50 INFO - mozlog == 3.2 04:03:50 INFO - moznetwork == 0.27 04:03:50 INFO - mozprocess == 0.22 04:03:50 INFO - mozprofile == 0.28 04:03:50 INFO - mozrunner == 6.11 04:03:50 INFO - mozscreenshot == 0.1 04:03:50 INFO - mozsystemmonitor == 0.3 04:03:50 INFO - moztest == 0.7 04:03:50 INFO - mozversion == 1.4 04:03:50 INFO - psutil == 3.1.1 04:03:50 INFO - requests == 1.2.3 04:03:50 INFO - wsgiref == 0.1.2 04:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:50 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:50 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:03:50 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:03:50 INFO - Using env: {'DISPLAY': ':0', 04:03:50 INFO - 'HOME': '/home/cltbld', 04:03:50 INFO - 'LANG': 'en_US.UTF-8', 04:03:50 INFO - 'LANGUAGE': 'en_US:en', 04:03:50 INFO - 'LOGNAME': 'cltbld', 04:03:50 INFO - 'MAIL': '/var/mail/cltbld', 04:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:50 INFO - 'MOZ_NO_REMOTE': '1', 04:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:50 INFO - 'NO_EM_RESTART': '1', 04:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:50 INFO - 'PWD': '/builds/slave/test', 04:03:50 INFO - 'SHELL': '/bin/bash', 04:03:50 INFO - 'SHLVL': '1', 04:03:50 INFO - 'TERM': 'linux', 04:03:50 INFO - 'TMOUT': '86400', 04:03:50 INFO - 'USER': 'cltbld', 04:03:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:50 INFO - '_': '/tools/buildbot/bin/python'} 04:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 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:03:50 INFO - Cleaning up... 04:03:50 INFO - Return code: 0 04:03:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:50 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:50 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:03:50 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:03:50 INFO - Using env: {'DISPLAY': ':0', 04:03:50 INFO - 'HOME': '/home/cltbld', 04:03:50 INFO - 'LANG': 'en_US.UTF-8', 04:03:50 INFO - 'LANGUAGE': 'en_US:en', 04:03:50 INFO - 'LOGNAME': 'cltbld', 04:03:50 INFO - 'MAIL': '/var/mail/cltbld', 04:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:50 INFO - 'MOZ_NO_REMOTE': '1', 04:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:50 INFO - 'NO_EM_RESTART': '1', 04:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:50 INFO - 'PWD': '/builds/slave/test', 04:03:50 INFO - 'SHELL': '/bin/bash', 04:03:50 INFO - 'SHLVL': '1', 04:03:50 INFO - 'TERM': 'linux', 04:03:50 INFO - 'TMOUT': '86400', 04:03:50 INFO - 'USER': 'cltbld', 04:03:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:50 INFO - '_': '/tools/buildbot/bin/python'} 04:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:50 INFO - Cleaning up... 04:03:51 INFO - Return code: 0 04:03:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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')]} 04:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:51 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 0x7f1efebe5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', '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:03:51 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:03:51 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:03:51 INFO - Using env: {'DISPLAY': ':0', 04:03:51 INFO - 'HOME': '/home/cltbld', 04:03:51 INFO - 'LANG': 'en_US.UTF-8', 04:03:51 INFO - 'LANGUAGE': 'en_US:en', 04:03:51 INFO - 'LOGNAME': 'cltbld', 04:03:51 INFO - 'MAIL': '/var/mail/cltbld', 04:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:51 INFO - 'MOZ_NO_REMOTE': '1', 04:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:51 INFO - 'NO_EM_RESTART': '1', 04:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:51 INFO - 'PWD': '/builds/slave/test', 04:03:51 INFO - 'SHELL': '/bin/bash', 04:03:51 INFO - 'SHLVL': '1', 04:03:51 INFO - 'TERM': 'linux', 04:03:51 INFO - 'TMOUT': '86400', 04:03:51 INFO - 'USER': 'cltbld', 04:03:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:51 INFO - '_': '/tools/buildbot/bin/python'} 04:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:51 INFO - Downloading/unpacking flake8 04:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:51 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:03:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:03:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:03:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:03:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:53 INFO - no previously-included directories found matching 'docs/_build' 04:03:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:03:53 INFO - Running setup.py install for pep8 04:03:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:54 INFO - no previously-included directories found matching 'docs/_build' 04:03:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:03:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:03:54 INFO - Cleaning up... 04:03:54 INFO - Return code: 0 04:03:54 INFO - Running post-action listener: _resource_record_post_action 04:03:54 INFO - Running post-action listener: _start_resource_monitoring 04:03:54 INFO - Starting resource monitoring. 04:03:54 INFO - ##### 04:03:54 INFO - ##### Finished create-virtualenv step (success) 04:03:54 INFO - ##### 04:03:54 INFO - ##### 04:03:54 INFO - ##### Running install step. 04:03:54 INFO - ##### 04:03:54 INFO - Running pre-action listener: _resource_record_pre_action 04:03:54 INFO - Running main action method: install 04:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:54 INFO - Reading from file tmpfile_stdout 04:03:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:54 INFO - Reading from file tmpfile_stdout 04:03:54 INFO - Output received: 04:03:54 INFO - Usage: mozinstall [options] installer 04:03:54 INFO - Options: 04:03:54 INFO - -h, --help show this help message and exit 04:03:54 INFO - -d DEST, --destination=DEST 04:03:54 INFO - Directory to install application into. [default: 04:03:54 INFO - "/builds/slave/test"] 04:03:54 INFO - --app=APP Application being installed. [default: firefox] 04:03:54 INFO - mkdir: /builds/slave/test/build/application 04:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:04:11 INFO - Reading from file tmpfile_stdout 04:04:11 INFO - Output received: 04:04:11 INFO - /builds/slave/test/build/application/firefox/firefox 04:04:11 INFO - Running post-action listener: _resource_record_post_action 04:04:11 INFO - ##### 04:04:11 INFO - ##### Finished install step (success) 04:04:11 INFO - ##### 04:04:11 INFO - ##### 04:04:11 INFO - ##### Running run-tests step. 04:04:11 INFO - ##### 04:04:11 INFO - Running pre-action listener: _resource_record_pre_action 04:04:11 INFO - Running main action method: run_tests 04:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:04:11 INFO - Python 2.7.3 04:04:11 INFO - Return code: 0 04:04:11 INFO - grabbing minidump binary from tooltool 04:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:11 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 0x10fc1c0>, '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 0x10fd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:04:11 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:04:11 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:04:11 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:04:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:04:11 INFO - Return code: 0 04:04:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:04:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:04:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:04:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:04:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:04:12 INFO - Return code: 0 04:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:04:12 INFO - Using env: {'DISPLAY': ':0', 04:04:12 INFO - 'HOME': '/home/cltbld', 04:04:12 INFO - 'LANG': 'en_US.UTF-8', 04:04:12 INFO - 'LANGUAGE': 'en_US:en', 04:04:12 INFO - 'LOGNAME': 'cltbld', 04:04:12 INFO - 'MAIL': '/var/mail/cltbld', 04:04:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:12 INFO - 'MOZ_NO_REMOTE': '1', 04:04:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:12 INFO - 'NO_EM_RESTART': '1', 04:04:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:12 INFO - 'PWD': '/builds/slave/test', 04:04:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:12 INFO - 'SHELL': '/bin/bash', 04:04:12 INFO - 'SHLVL': '1', 04:04:12 INFO - 'TERM': 'linux', 04:04:12 INFO - 'TMOUT': '86400', 04:04:12 INFO - 'USER': 'cltbld', 04:04:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620', 04:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:12 INFO - '_': '/tools/buildbot/bin/python'} 04:04:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:04:12 INFO - mozversion application_buildid: 20160609013053 04:04:12 INFO - mozversion application_changeset: da40184c044a47a0a8d812dad4f8e1215ae3a025 04:04:12 INFO - mozversion application_display_name: Nightly 04:04:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:04:12 INFO - mozversion application_name: Firefox 04:04:12 INFO - mozversion application_remotingname: firefox 04:04:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:04:12 INFO - mozversion application_vendor: Mozilla 04:04:12 INFO - mozversion application_version: 50.0a1 04:04:12 INFO - mozversion platform_buildid: 20160609013053 04:04:12 INFO - mozversion platform_changeset: da40184c044a47a0a8d812dad4f8e1215ae3a025 04:04:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:04:12 INFO - mozversion platform_version: 50.0a1 04:04:12 INFO - using testdate: 1465470252 04:04:12 INFO - actual date: 1465470252 04:04:12 INFO - starting webserver on 'localhost:41346' 04:04:12 INFO - SUITE-START | Running 2 tests 04:04:12 INFO - TEST-START | dromaeo_css 04:04:12 INFO - operating with platform_type : linux_ 04:04:12 INFO - Initialising browser for dromaeo_css test... 04:04:12 INFO - TEST-INFO | started process 16626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6WBlF/profile http://localhost:41346/getInfo.html) 04:04:17 INFO - PROCESS | 16626 | __metrics Screen width/height:1600/1200 04:04:17 INFO - PROCESS | 16626 | colorDepth:24 04:04:17 INFO - PROCESS | 16626 | Browser inner width/height: 1024/697 04:04:17 INFO - PROCESS | 16626 | __metrics 04:04:18 ERROR - PROCESS | 16626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:04:19 INFO - TEST-INFO | 16626: exit 0 04:04:19 INFO - Browser initialized. 04:04:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:04:19 INFO - TEST-INFO | started process 16745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6WBlF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:31 INFO - PROCESS | 16745 | RSS: Main: 184532992 04:04:31 INFO - PROCESS | 16745 | 04:05:20 INFO - PROCESS | 16745 | 1465470320637 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:07:29 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41346/tests/dromaeo/cssquery-ext.html) 04:07:30 INFO - PROCESS | 16745 | RSS: Main: 187191296 04:07:30 INFO - PROCESS | 16745 | 04:10:32 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-ext.html (next: http://localhost:41346/tests/dromaeo/cssquery-jquery.html) 04:10:33 INFO - PROCESS | 16745 | RSS: Main: 186073088 04:10:33 INFO - PROCESS | 16745 | 04:13:34 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41346/tests/dromaeo/cssquery-mootools.html) 04:13:35 INFO - PROCESS | 16745 | RSS: Main: 187617280 04:13:35 INFO - PROCESS | 16745 | 04:16:37 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41346/tests/dromaeo/cssquery-prototype.html) 04:16:37 INFO - PROCESS | 16745 | RSS: Main: 185442304 04:16:37 INFO - PROCESS | 16745 | 04:19:40 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41346/tests/dromaeo/cssquery-yui.html) 04:19:40 INFO - PROCESS | 16745 | RSS: Main: 187686912 04:19:40 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:41346/tests/dromaeo/cssquery-yui.html (next: http://localhost:41346/tests/dromaeo/cssquery-dojo.html) 04:22:43 INFO - PROCESS | 16745 | RSS: Main: 188608512 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | __start_tp_report 04:22:43 INFO - PROCESS | 16745 | _x_x_mozilla_page_load 04:22:43 INFO - PROCESS | 16745 | _x_x_mozilla_page_load_details 04:22:43 INFO - PROCESS | 16745 | |i|pagename|runs| 04:22:43 INFO - PROCESS | 16745 | |0;dojo.html;3102.5346198070292;3173.30187358781;3191.2341038150844;3195.8082515049086;3206.519022146678;5486.396496385394;5517.531009864161;5534.142207957768;5612.270404847364;5623.775048998045;5349.5185433311;5523.447655234475;5536.723163841802;5574.777008919648;5605.327360716719;4943.9011219775675;4957.5786058185095;5018.096742586333;5114.923276150861;5125.890359318265;5012.273220383042;5051.974740126313;5077.695338279696;5099.974500127494;5101.183810590306;4984.3021976923255;5023.522765337306;5046.823361182341;5072.365954255718;5089.643724939256;5100.897982040376;5103.209002604565;5104.310918026056;5120.257562653394;5187.455317191716;5061;5070.949290507121;5085.923711144335;5097.031564002865;5101.82143624975;5497.367802702661;5501.037318469252;5534.280543529316;5544.7227638618315;5560.026995275811;5948.7323070461935;5951.196588460546;5954.166416701665;5967.940320596826;5979.342272350082;5850.970745146247;5942.465178133989;5987.580869339148;6002.609830361012;6023.337432882379;5480.616356855022;5561.054620714448;5562.888742225174;5571.832845014656;5579.776808927679;6004.759809607567;6106.389361063947;6144.938550614436;6147.877042459126;6159.1069294951985;5767.048437007847;5792.768289268382;5816.651000939957;5900.055991041413;5906;5953.136795164677;5954.987652099154;5958.940410595926;5966.254218222723;5993.0710739835395;5733.598648094593;5862.413758624189;5936.1392598073035;5938.703064846741;5946.464818166386;5945.583809133319;6004.6097003695495;6007.219061521974;6007.399260074045;6047.879042419127;4566.725996440225;4578.908421831611;4588.334691469785;4594.33382159585;4626.467956185014;3990.7206495545033;4031.879043628696;4071.91856162881;4072.714909956275;4089;5668.716564171775;5715.771369145271;5729.914051289234;5731.627444216113;5742.052561327418;6046.727897244635;6047.0627052806885;6047.758089676364;6048.364921683248;6052.636841789506;5565.415631358649;5654.604177707521;5696.572757043238;5722;5723.255976723;5008.398992120896;5012.448630650625;5018.322526458955;5019.447860735316;5094.592432605383;5983.910241346296;6147.66187859663;6154.353792851775;6154.753809847645;6177.351378105324;5845.18167456548;5913.142594323885;5942.64344139353;5981.700914954322;5982.7307771149535;6055.969720151371;6094.177286066324;6125.938740612537;6132.386761323832;6144.293406258337;5646.971765141148;5776.075827867521;5848.473637372657;5858.297004359504;5860.941390586039;5899.734511946886;5936;5952.910706339322;5954.4938680210935;6039.698015099139;5758;5775.047117225611;5782.10377391505;5783.479486846204;5828.358880523054;5590.2453168821685;5718.027935250934;5736.942630573641;5744.942550574441;5793.826185214451;5534.086875665631;5541.5289700375915;5592.916106258328;5678.829635110953;5749.166370876116;5775.6823374714795;5793.681347525927;5809.912851307149;5826.446487583673;5836.795712150224;5564.749586268546;5668.461496157858;5677.233573467529;5678.233438485751;5701.287339082614 04:22:43 INFO - PROCESS | 16745 | |1;ext.html;562.5471495446164;607.3956413368699;612.5956868466812;614.339584946183;627.3945642455031;42369.78815105928;43628.78185609072;43707.34438983418;44067.55932440675;46856.76571617137;45667.77166114173;46044;46122.308165377544;46481.07037859249;46504.534954650444;8701.695440659563;8813.206811386974;8814.647414103429;8829.55852207387;8835.337349698799;8933;9017.819643607158;9018.954905225464;9023.233025192834;9028.232600228988;9065.365424420293;9069.818603627924;9085.182333589975;9086.636534538644;9100.180983711465;8968.372213945026;8975.237104846095;8993.10068993102;9022.368434209608;9054.275657947348;8794.164554367326;8802.779930501725;8880;8906.955465222698;8962.238209752179;42517;42897.14205715868;42979.1404171918;43066.35400468996;43128.353074703904;3457.7752446091176;3543.3799085160254;3727.732570925871;4001.5398229203433;4080.224757296104;29129.56305655417;29140.708592914012;29298;30892;34141.31717365664;4001.6170166043894;4062.4921884764403;4119.553260858808;4134.111166099273;4238.364245363189;386562;386944;388116;389269;389415;60197.398026020055;60341;60582.39417605856;60745.69627151836;60832.695836520536;34684;35680.46479302813;35699.10752231215;61773;61984;17280.22238999248;17309.65380692379;17367.739483907753;17393.478195654152;17399.130043497775;12962.092653514164;12968.481260749653;13016.609501714964;13024.41390137446;13026.218426894417;18985.43043708691;19138;19207.51981200453;19285.4214373569;19317.80682193188;6809.319068093151;7052.647367631598;7154.678039488235;7220.891686624705;7302.517144171007;969.7575606098476;976.7753416714196;1022.9795404092025;1106.5960924262586;1118.5917140243753;31445.528317075263;32312;32312.19219519484;32416.675833241836;32647.510287345707;967.0474582536197;1065.4429369513075;1093.9343639381664;1162.3897453836635;1183.331417748969;15901.363945442054;16285.918570407071;16298.266578004019;16304;16461.83538164627;609647;611870;613706;615140;618834;56548.71725641345;57089.42910570924;57175.714121429955;57284;57850.710746446;1328.8604696506727;1376.5400103664256;1398.5245016694575;1401.0332870319446;1404.0592802822134;29255;30342.84828575843;30412.847935761063;30553.23616909595;30895.382092357577;48153.27770083521;48487.5151248483;48897.75551122222;48906.5109348902;49333.766655832456;504991;505426;506110;507329;508277;27420.862895685394;27618.723812761615;27718.168454946383;27762.167134985983;27885.442291154468;47095.764521177174;47410;47450.52549474461;47759;48650.270245947046;40684.59315406808;41011.384829228184;41072.79463602663;41142.58857411507;41786.791066044476;39580.60419395769;40013.59986400215;40632;40726.79636601917;40919.37300076693;40130.59869401269;40455.393169101895;41396.793016034724;41591.58408415877;44273.11453770971;33693.66306336905;36797.96061181581;37461.43807842939;37476.43785343168;37833.81083094677;28056.29859253535;28425.304969054814;28487.43025139527;28611.42777144404;28772.568411473425 04:22:43 INFO - PROCESS | 16745 | |2;jquery.html;386.9071422858513;396.44299758838804;396.90275882408815;399.67426547363897;407.92861249281384;14179.43282268708;17758.82241177588;18668.533286667807;19278.228870845185;19279.807201927975;15668.138252396142;15856.207189640501;16789.664206715857;18226.817731822677;18299.451016469528;5489.945100548984;5589.217509548666;5733.598648094635;5801.158831969362;5830.562707796911;5671.7164141792955;5688.9146662799885;5705.25831641886;5709.229254050691;5729.0833466645345;5536.280283563131;5609.831705048835;5665.405132461094;5705.743241554119;5791.131330300446;5764.9423505765035;5765.884682306372;5782.826515204551;5803.767849286023;5810.33181184165;4930.9013819723405;5116.718580478072;5167.48325167484;5167.560757335631;5185.55922746567;21139.788602113935;21808.563828723494;22260.77739222603;22473.775262247495;22556.774432255632;2250.6393861892648;2303.781140791622;2322.454223257533;2448.791852692523;2952.2766922104006;13594.32028398586;14200.076994995292;14456.638584035378;14465.85534144666;14538.636534086627;1957.696557033662;1977.9604407911904;1979.4853338132045;1990.3431867483696;2012.1347820437206;77623;79791.20208797896;80780.59609701972;80922.59538702328;81158.59420702858;10005.49972501372;10197.541110650038;10304.948475257575;10591.682249532527;10598.894011059945;12323.445444955;13209.40557674907;14463.638409039859;14474.203918784568;14483.565493035227;7156.35692440621;7325.377342925911;8008.199180081945;8040.959795201104;8309.25216730485;8104.0680321762575;8127.715529956423;8190.303824175012;8304.418690691715;8313.41806073569;6096.69516524172;6368.490520758328;6382.776602818879;6425.164728585254;6463.127477790532;1824;1889.537063419471;1905.7522522072043;1907.5898681783206;1919.9520011999532;854.3634991931051;942.6182396129578;1020.4999550220339;1070.4059247117925;1078.2883297023927;18439.72340414895;18522.536936576693;19009;19010;19010.146201166404;1031.0926384781344;1032.76762728387;1053.7471006958428;1081.8323159910226;1139.8347239650204;9443.90556094444;11076.5569377224;11082.168837337233;11095.50070246841;11134.721631959104;466914;475891;495333;495775;496206;79750;82741;83161;83328.58335708283;83471.58264208761;1021.9131373833308;1029.3000759483623;1044.1490185498794;1054.3568423261804;1062.675883855416;16593.35007714437;16707.582310442336;16762;17143.571410714332;17334.82665173332;30857.382852343275;36701.63298367089;37132;37906.81046594749;39800.60199398085;49909;50344;51103.744481277354;51193;52199;8043.959780201061;8080.757577272691;8319.916800831914;8364.749057528285;8593;12555.246685198552;13062.673433164247;13065.477380904656;13110.737785244433;13203.141795783244;8452.788680283042;8704.434211776213;10976.890231097586;11213.71965700864;11554.364509952033;11402;11426.94286528562;11655.88344116548;11787.646370608896;11890.940545297219;11129.443527823738;11661.008814250883;11701.122415819018;11764.764704706029;11837.940810295893;8028.197180281925;8111.391645626483;8182.977127859018;8239.917600823916;8316.251537361666;11688.415579220835;11787.941060294643;11856.466459009192;11965.880341196476;11984.58053968107 04:22:43 INFO - PROCESS | 16745 | |3;mootools.html;1490.426185918421;1491.1202390589553;1624.829392913744;1729.092226581044;1750.9562260943483;7756.612169391522;8444.535550544726;8446.915530844704;9090.818183636331;9117.316201284906;8519.701810436636;8722.258608018326;8821.779455513615;8821.867671984925;8841.95579022104;2318.48993221491;2352.8353015288935;2354.1407386304045;2359.870207138615;2364.3498038039593;2291.3355127013147;2297.1385730351117;2300.700908881843;2305.4697419593504;2335.7313908900524;2306.8500547464446;2312.919047833326;2314.2363020203375;2377.702787151606;2383.6067048936907;2255.4812393149505;2265.9773402266014;2267.1498188179435;2280.692106565609;2283.6917016202765;2231.308294428716;2232.7767223277706;2239.7536271010176;2245.674377215311;2267.1498188179435;8885.42244754089;8934.195922367018;8934.821303573957;8937.061608531076;9015.729528114167;5165.302684137631;5277.656952298088;5290.259363689087;5302.390225124122;5308.442613525563;3183.7930534515413;3252.804831710105;3344.749143814199;3389.762716609838;3438.398280300937;1172.9209127602626;1187.928724276546;1953.326102494637;2111.883846388448;2167.3606286145623;12265.693357666041;12345.93827030859;12404.13171078025;12414.62756117318;12460.252384856938;4344.45694288214;4355.7822108894425;4450.265706158512;4467.441569803775;4487.169873573399;9622.759431014141;9657.517124143766;9669.323147379757;9698.51507424626;9711.951440242754;5005.849824505271;5025.195968644999;5045.899082018339;5072.340595722606;5174.741262936838;4236.915261694749;4707.599854012379;4768.594669453136;4785.3300537924715;4852.951470485321;3591.1919818041256;3691.187938653492;3709.406494960793;3766.7174961877968;3828.712846536521;1085.782843431317;1116.849225354583;1119.054399032816;1122.2649164797072;1149.408054851752;845.6406027438314;854.7734850264685;938.216589148069;940.501534186882;977.4575110813566;5618.2415373924;5649.322081350182;5692.402297758758;5784.161296611967;5804.79683211094;473.7181377080631;476.10492274523676;487.36642364925456;1018.567108978696;1046.1630695443766;3930.4890364252465;3956.5252169739815;3976.906350753566;4019.2765302245293;4027.2952233359047;11016.559337626406;11133.443327833576;11254.831177532344;11318.886811131948;11319.603813866639;10997.450127493594;11130.443477826077;11135.944320278346;11145.108391328675;11248;8168.877466838002;8409.747707568782;8478.406511544255;8481.575921203916;8513.702020429255;5704.087346024616;5770.278715160605;5844.327902291121;5859.384764599656;5943.91084133747;10349.74125646865;10373.377597344184;10492.317999330018;10496.16030717556;10512.211584131068;10141.746456338651;10402.127617029008;10426.68719938403;10505.369677819355;10554.261201715806;6896.965515172593;7375.373093286916;7480.850382992418;7557.735479258199;7610.972518709903;8789.340799440195;8810.427322224292;8850.822983540422;8854.513001784964;8879.33404994615;7670.309672129535;7800.882986755317;7843.450958432855;7923.3661307096445;8144.959275203586;7811.960940195263;7812.140664527011;7879.960600196962;7980.042394912648;8032.156623554442;7164.176119746087;7182.533135346186;7274.236205198378;7289.271072892669;7297.452691048086;5111.207762796773;5123.769430375716;5158.406783219828;5165.7675404607635;5189.844304670866;4800.3759511263315;4908.680935739166;4959.801607935787;5148.330717006766;5226.764795584284 04:22:43 INFO - PROCESS | 16745 | |4;prototype.html;328.50688323073507;340.93863104641173;341.00426753878673;344.7362767482876;348.54514858110156;5602.543338731928;5645.57658175637;5653.575981801371;5673.914891276629;5674.177244299574;5574.414686457914;5592.636478628886;5594.300712410949;5596.356419011815;5600.355959064709;4178.6657067434535;4382.737035777864;4398.582134697199;4404.647628189737;4418.911621767571;4230.492340919079;4336.934945975813;4337.761423121727;4340.587644173798;4343.847965321214;4290.76400797956;4312.762798046107;4325.307950727884;4331.112122014979;4356.7821608919585;4208.389783481409;4366.471734892778;4368;4398.780060996937;4399.5820397062225;3805.543334799842;3827.445020472044;3837.194189220239;3839.865604703822;3847.365184744514;5393.946060539383;5412.431694672042;5430.3755068167275;5452.890942181134;5475.288212532385;4942.20924652054;5010.549050585429;5032.465098145064;5037.319961805146;5095.573239492911;5685.260916080883;5757.740901659436;5758.88482230353;5899.5870289079785;5927.762889484416;4274.700770946035;4286.6570674346285;4291.828326866922;4298.892527686801;4321.9135617287475;5971.910421343683;6078.544109191784;6096.1770161028135;6104.481119104837;6142.570020098595;4308.482982042112;4310.181065597527;4350.2810743285445;4352.673549483801;4353.760543170156;4398;4424.402705634762;4444.6666500012625;4446.466424029137;4446.510883802844;4864.318995340655;4937.9012419752125;5012.974935125301;5049.2173713074535;5063.493650634907;5848.678322692208;5881.382454842265;5894;5915.438033386821;5915.467607915309;1500.9774853377207;1503.4812989518598;1526.2750193658146;1527.6868242010362;1528.083150109925;933.206774241889;944.1644144931785;954.7565370830393;982.2044144243185;991.5339790298548;5062.025809934129;5569.331680198321;5783.652980821164;5806.04200306953;5821.27234095738;6130.570860039844;6171.6297022178815;6183.783567575113;6193.163922870445;6197.380261973766;5625.54995600351;5766.336871259775;5767.567432442584;5810.593258471867;5813.215215945877;3238.834019752887;3257.1857035741064;3262.9021129366156;3264.379767844102;3266.673332666762;6202.906081985868;6332.606826498163;6345.524085693592;6349.238091429058;6382.20222472191;6035.094735789667;6151.415615516519;6154.3845615438095;6245.687715614201;6281;6276.843078922972;6321.241451025906;6342.619442833445;6370.426661600478;6383.234011918599;5921.407859214217;6002.8294482575475;6015.368386319374;6078.72645730952;6079.665618391031;5964.314103877936;5979.730912108878;5984.670843103497;6017.909731354121;6036.939630603813;6024.5481588881885;6244.906326405198;6276.905846412216;6323.6838158090995;6324.841878953063;4207.263728847501;4239.5124560674685;4247.405363249086;4255.319148936155;4264.744115352964;6106.366711806468;6106.938930610637;6111.616469576958;6129.908051379144;6136.790755327989;5864.208331875142;5945.64326140433;5962.582619216787;5979.535013921617;5986.593150609516;5970.462658360769;5991;5996.2504686914135;6021.157038014769;6028.849278768066;5729.479029227126;5733.655980641175;5804.65172089676;5852.7658893643775;5909.143174239625;5844.707764611838;5858.736356863866;5890.941090589039;5999.430054145024;6018;5817.214676018683;5846.210761547307;5855.970720146372;5871.412858714094;5875.441833025856 04:22:43 INFO - PROCESS | 16745 | |5;yui.html;770.1259070954467;779.4777499075619;784.9686012559498;807.7617102954631;813.4996976859226;14192.716145677094;14680.559583212495;14742.557723268319;14794.482193123244;14861.702765944674;14647.414103435849;14687.192204428753;14713.852861471381;14777.408903643869;14846.851531484708;670.9698063587126;782.7143092771155;791.8297566023318;793.9166387529312;807.0355924670022;786.6538722961878;789.3487872505177;792.9484583502054;794.4319811334894;795;834.5910503853129;837.2757564706546;842.3892677808601;842.8482873082843;843.8438888805559;827.4538804389074;828.2338836576143;829.713748756681;835.1481488881337;835.7367429259764;605.5579427018301;609.4058293164173;612.8498517863108;613.0773186354553;613.1018058544254;13804.723905521934;13836.377363018688;13897;13983.510577129751;14115.364808583638;14537.200453975027;14739.92630036843;14800;14960.47638332664;15129.697406051928;11752.764944701144;11876.940615296868;11960;11970.760584788255;11998.880011199864;3701.704403458768;3739.4577786221116;3826.540815102178;3862.2275544891136;3876.4379165021196;73677.7896663101;73983.26016739817;74712.25287747107;75094;76095.23904760937;11332.490037948312;11444.370559619301;11607.187496875307;11878.881211187778;12005.339706316061;22156.446088847584;22229.221977231042;22293.777062229496;22302.88848555747;22330.441738956655;8402.957985210158;8509.276711479593;8637.481751094954;8813.206811387006;8898.199162075443;4676.392069031004;4734.597559207437;4777.522247775264;4778.522147785263;4782.545658162469;3747.8500859965843;3874.3994680824517;3875.6124387561017;3878.8448462061765;3893.8053097345587;627.5387590121258;642.081822993115;654.4044919123575;665.9400653941168;667.813012356541;654.6890227142164;717.7739012211136;738.9371903388164;750.1494321577982;764.6024067484876;9260.722178334661;9558.665446709332;9764.316497845224;9969.700908972742;10000.649977250761;647.6923461355818;742.7920182348951;751.6429695894516;755.437199286535;777.8133248020547;4640.32715256286;4649.837255696102;4651.232546629768;4656.254999200111;4681.227597446451;107889;113494;114058.72677002844;114638;115812;87932.12067879367;98618;99128;100230.49884750675;101795;85744;87438.56280718556;87650.56174719086;87737.12262877417;88307;8720.694775682821;8796.103406543281;9046.140616641671;9085.273178145864;9143.177114059767;50187.49812501828;52139.217911732114;52179.47820521746;52222.21666674927;53297;68787.65606171938;73463;75707.62146189234;75828;76525;12549.686257843627;12589.622311330675;12612.684682883002;12712.491500340253;12949.41727622278;12978.795488062528;13198.20810751358;13297.365915582262;13374.06381553282;13400.731985360044;12792.488300467878;12873.291968941798;13079.149855259378;13092.934535327262;13274.668133296746;12549.87450125487;12630.242185468902;12785.296808675612;12805.295708736108;13251.072424930162;12416.937915310365;13193.142445740996;13460.147619755598;13602.319884005958;13631.38658760378;10295.53670084833;10331.793364132525;10709.196810239107;10934.945325273322;11056.944715276371;9917.15704165154;10159.847602285823;10224.744381390525;10378.792424151627;10382.896171038194 04:22:43 INFO - PROCESS | 16745 | __end_tp_report 04:22:43 INFO - PROCESS | 16745 | __start_cc_report 04:22:43 INFO - PROCESS | 16745 | _x_x_mozilla_cycle_collect,360 04:22:43 INFO - PROCESS | 16745 | __end_cc_report 04:22:43 INFO - PROCESS | 16745 | __startTimestamp1465471363843__endTimestamp 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | ------- Summary: start ------- 04:22:43 INFO - PROCESS | 16745 | Number of tests: 6 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#0] dojo.html Cycles:165 Average:5515.74 Median:5722.00 stddev:629.11 (11.0%) stddev-sans-first:601.89 04:22:43 INFO - PROCESS | 16745 | Values: 3102.5 3173.3 3191.2 3195.8 3206.5 5486.4 5517.5 5534.1 5612.3 5623.8 5349.5 5523.4 5536.7 5574.8 5605.3 4943.9 4957.6 5018.1 5114.9 5125.9 5012.3 5052.0 5077.7 5100.0 5101.2 4984.3 5023.5 5046.8 5072.4 5089.6 5100.9 5103.2 5104.3 5120.3 5187.5 5061.0 5070.9 5085.9 5097.0 5101.8 5497.4 5501.0 5534.3 5544.7 5560.0 5948.7 5951.2 5954.2 5967.9 5979.3 5851.0 5942.5 5987.6 6002.6 6023.3 5480.6 5561.1 5562.9 5571.8 5579.8 6004.8 6106.4 6144.9 6147.9 6159.1 5767.0 5792.8 5816.7 5900.1 5906.0 5953.1 5955.0 5958.9 5966.3 5993.1 5733.6 5862.4 5936.1 5938.7 5946.5 5945.6 6004.6 6007.2 6007.4 6047.9 4566.7 4578.9 4588.3 4594.3 4626.5 3990.7 4031.9 4071.9 4072.7 4089.0 5668.7 5715.8 5729.9 5731.6 5742.1 6046.7 6047.1 6047.8 6048.4 6052.6 5565.4 5654.6 5696.6 5722.0 5723.3 5008.4 5012.4 5018.3 5019.4 5094.6 5983.9 6147.7 6154.4 6154.8 6177.4 5845.2 5913.1 5942.6 5981.7 5982.7 6056.0 6094.2 6125.9 6132.4 6144.3 5647.0 5776.1 5848.5 5858.3 5860.9 5899.7 5936.0 5952.9 5954.5 6039.7 5758.0 5775.0 5782.1 5783.5 5828.4 5590.2 5718.0 5736.9 5744.9 5793.8 5534.1 5541.5 5592.9 5678.8 5749.2 5775.7 5793.7 5809.9 5826.4 5836.8 5564.7 5668.5 5677.2 5678.2 5701.3 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#1] ext.html Cycles:180 Average:65006.36 Median:41494.19 stddev:136187.93 (328.2%) stddev-sans-first:136484.03 04:22:43 INFO - PROCESS | 16745 | Values: 562.5 607.4 612.6 614.3 627.4 42369.8 43628.8 43707.3 44067.6 46856.8 45667.8 46044.0 46122.3 46481.1 46504.5 8701.7 8813.2 8814.6 8829.6 8835.3 8933.0 9017.8 9019.0 9023.2 9028.2 9065.4 9069.8 9085.2 9086.6 9100.2 8968.4 8975.2 8993.1 9022.4 9054.3 8794.2 8802.8 8880.0 8907.0 8962.2 42517.0 42897.1 42979.1 43066.4 43128.4 3457.8 3543.4 3727.7 4001.5 4080.2 29129.6 29140.7 29298.0 30892.0 34141.3 4001.6 4062.5 4119.6 4134.1 4238.4 386562.0 386944.0 388116.0 389269.0 389415.0 60197.4 60341.0 60582.4 60745.7 60832.7 34684.0 35680.5 35699.1 61773.0 61984.0 17280.2 17309.7 17367.7 17393.5 17399.1 12962.1 12968.5 13016.6 13024.4 13026.2 18985.4 19138.0 19207.5 19285.4 19317.8 6809.3 7052.6 7154.7 7220.9 7302.5 969.8 976.8 1023.0 1106.6 1118.6 31445.5 32312.0 32312.2 32416.7 32647.5 967.0 1065.4 1093.9 1162.4 1183.3 15901.4 16285.9 16298.3 16304.0 16461.8 609647.0 611870.0 613706.0 615140.0 618834.0 56548.7 57089.4 57175.7 57284.0 57850.7 1328.9 1376.5 1398.5 1401.0 1404.1 29255.0 30342.8 30412.8 30553.2 30895.4 48153.3 48487.5 48897.8 48906.5 49333.8 504991.0 505426.0 506110.0 507329.0 508277.0 27420.9 27618.7 27718.2 27762.2 27885.4 47095.8 47410.0 47450.5 47759.0 48650.3 40684.6 41011.4 41072.8 41142.6 41786.8 39580.6 40013.6 40632.0 40726.8 40919.4 40130.6 40455.4 41396.8 41591.6 44273.1 33693.7 36798.0 37461.4 37476.4 37833.8 28056.3 28425.3 28487.4 28611.4 28772.6 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#2] jquery.html Cycles:180 Average:28126.40 Median:12430.28 stddev:79902.29 (642.8%) stddev-sans-first:80099.29 04:22:43 INFO - PROCESS | 16745 | Values: 386.9 396.4 396.9 399.7 407.9 14179.4 17758.8 18668.5 19278.2 19279.8 15668.1 15856.2 16789.7 18226.8 18299.5 5489.9 5589.2 5733.6 5801.2 5830.6 5671.7 5688.9 5705.3 5709.2 5729.1 5536.3 5609.8 5665.4 5705.7 5791.1 5764.9 5765.9 5782.8 5803.8 5810.3 4930.9 5116.7 5167.5 5167.6 5185.6 21139.8 21808.6 22260.8 22473.8 22556.8 2250.6 2303.8 2322.5 2448.8 2952.3 13594.3 14200.1 14456.6 14465.9 14538.6 1957.7 1978.0 1979.5 1990.3 2012.1 77623.0 79791.2 80780.6 80922.6 81158.6 10005.5 10197.5 10304.9 10591.7 10598.9 12323.4 13209.4 14463.6 14474.2 14483.6 7156.4 7325.4 8008.2 8041.0 8309.3 8104.1 8127.7 8190.3 8304.4 8313.4 6096.7 6368.5 6382.8 6425.2 6463.1 1824.0 1889.5 1905.8 1907.6 1920.0 854.4 942.6 1020.5 1070.4 1078.3 18439.7 18522.5 19009.0 19010.0 19010.1 1031.1 1032.8 1053.7 1081.8 1139.8 9443.9 11076.6 11082.2 11095.5 11134.7 466914.0 475891.0 495333.0 495775.0 496206.0 79750.0 82741.0 83161.0 83328.6 83471.6 1021.9 1029.3 1044.1 1054.4 1062.7 16593.4 16707.6 16762.0 17143.6 17334.8 30857.4 36701.6 37132.0 37906.8 39800.6 49909.0 50344.0 51103.7 51193.0 52199.0 8044.0 8080.8 8319.9 8364.7 8593.0 12555.2 13062.7 13065.5 13110.7 13203.1 8452.8 8704.4 10976.9 11213.7 11554.4 11402.0 11426.9 11655.9 11787.6 11890.9 11129.4 11661.0 11701.1 11764.8 11837.9 8028.2 8111.4 8183.0 8239.9 8316.3 11688.4 11787.9 11856.5 11965.9 11984.6 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#3] mootools.html Cycles:180 Average:5801.86 Median:2622.35 stddev:3347.49 (127.7%) stddev-sans-first:3341.21 04:22:43 INFO - PROCESS | 16745 | Values: 1490.4 1491.1 1624.8 1729.1 1751.0 7756.6 8444.5 8446.9 9090.8 9117.3 8519.7 8722.3 8821.8 8821.9 8842.0 2318.5 2352.8 2354.1 2359.9 2364.3 2291.3 2297.1 2300.7 2305.5 2335.7 2306.9 2312.9 2314.2 2377.7 2383.6 2255.5 2266.0 2267.1 2280.7 2283.7 2231.3 2232.8 2239.8 2245.7 2267.1 8885.4 8934.2 8934.8 8937.1 9015.7 5165.3 5277.7 5290.3 5302.4 5308.4 3183.8 3252.8 3344.7 3389.8 3438.4 1172.9 1187.9 1953.3 2111.9 2167.4 12265.7 12345.9 12404.1 12414.6 12460.3 4344.5 4355.8 4450.3 4467.4 4487.2 9622.8 9657.5 9669.3 9698.5 9712.0 5005.8 5025.2 5045.9 5072.3 5174.7 4236.9 4707.6 4768.6 4785.3 4853.0 3591.2 3691.2 3709.4 3766.7 3828.7 1085.8 1116.8 1119.1 1122.3 1149.4 845.6 854.8 938.2 940.5 977.5 5618.2 5649.3 5692.4 5784.2 5804.8 473.7 476.1 487.4 1018.6 1046.2 3930.5 3956.5 3976.9 4019.3 4027.3 11016.6 11133.4 11254.8 11318.9 11319.6 10997.5 11130.4 11135.9 11145.1 11248.0 8168.9 8409.7 8478.4 8481.6 8513.7 5704.1 5770.3 5844.3 5859.4 5943.9 10349.7 10373.4 10492.3 10496.2 10512.2 10141.7 10402.1 10426.7 10505.4 10554.3 6897.0 7375.4 7480.9 7557.7 7611.0 8789.3 8810.4 8850.8 8854.5 8879.3 7670.3 7800.9 7843.5 7923.4 8145.0 7812.0 7812.1 7880.0 7980.0 8032.2 7164.2 7182.5 7274.2 7289.3 7297.5 5111.2 5123.8 5158.4 5165.8 5189.8 4800.4 4908.7 4959.8 5148.3 5226.8 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#4] prototype.html Cycles:180 Average:4980.52 Median:5745.70 stddev:1476.66 (25.7%) stddev-sans-first:1438.93 04:22:43 INFO - PROCESS | 16745 | Values: 328.5 340.9 341.0 344.7 348.5 5602.5 5645.6 5653.6 5673.9 5674.2 5574.4 5592.6 5594.3 5596.4 5600.4 4178.7 4382.7 4398.6 4404.6 4418.9 4230.5 4336.9 4337.8 4340.6 4343.8 4290.8 4312.8 4325.3 4331.1 4356.8 4208.4 4366.5 4368.0 4398.8 4399.6 3805.5 3827.4 3837.2 3839.9 3847.4 5393.9 5412.4 5430.4 5452.9 5475.3 4942.2 5010.5 5032.5 5037.3 5095.6 5685.3 5757.7 5758.9 5899.6 5927.8 4274.7 4286.7 4291.8 4298.9 4321.9 5971.9 6078.5 6096.2 6104.5 6142.6 4308.5 4310.2 4350.3 4352.7 4353.8 4398.0 4424.4 4444.7 4446.5 4446.5 4864.3 4937.9 5013.0 5049.2 5063.5 5848.7 5881.4 5894.0 5915.4 5915.5 1501.0 1503.5 1526.3 1527.7 1528.1 933.2 944.2 954.8 982.2 991.5 5062.0 5569.3 5783.7 5806.0 5821.3 6130.6 6171.6 6183.8 6193.2 6197.4 5625.5 5766.3 5767.6 5810.6 5813.2 3238.8 3257.2 3262.9 3264.4 3266.7 6202.9 6332.6 6345.5 6349.2 6382.2 6035.1 6151.4 6154.4 6245.7 6281.0 6276.8 6321.2 6342.6 6370.4 6383.2 5921.4 6002.8 6015.4 6078.7 6079.7 5964.3 5979.7 5984.7 6017.9 6036.9 6024.5 6244.9 6276.9 6323.7 6324.8 4207.3 4239.5 4247.4 4255.3 4264.7 6106.4 6106.9 6111.6 6129.9 6136.8 5864.2 5945.6 5962.6 5979.5 5986.6 5970.5 5991.0 5996.3 6021.2 6028.8 5729.5 5733.7 5804.7 5852.8 5909.1 5844.7 5858.7 5890.9 5999.4 6018.0 5817.2 5846.2 5856.0 5871.4 5875.4 04:22:43 INFO - PROCESS | 16745 | 04:22:43 INFO - PROCESS | 16745 | [#5] yui.html Cycles:180 Average:20552.21 Median:4666.32 stddev:29699.52 (636.5%) stddev-sans-first:29745.69 04:22:43 INFO - PROCESS | 16745 | Values: 770.1 779.5 785.0 807.8 813.5 14192.7 14680.6 14742.6 14794.5 14861.7 14647.4 14687.2 14713.9 14777.4 14846.9 671.0 782.7 791.8 793.9 807.0 786.7 789.3 792.9 794.4 795.0 834.6 837.3 842.4 842.8 843.8 827.5 828.2 829.7 835.1 835.7 605.6 609.4 612.8 613.1 613.1 13804.7 13836.4 13897.0 13983.5 14115.4 14537.2 14739.9 14800.0 14960.5 15129.7 11752.8 11876.9 11960.0 11970.8 11998.9 3701.7 3739.5 3826.5 3862.2 3876.4 73677.8 73983.3 74712.3 75094.0 76095.2 11332.5 11444.4 11607.2 11878.9 12005.3 22156.4 22229.2 22293.8 22302.9 22330.4 8403.0 8509.3 8637.5 8813.2 8898.2 4676.4 4734.6 4777.5 4778.5 4782.5 3747.9 3874.4 3875.6 3878.8 3893.8 627.5 642.1 654.4 665.9 667.8 654.7 717.8 738.9 750.1 764.6 9260.7 9558.7 9764.3 9969.7 10000.6 647.7 742.8 751.6 755.4 777.8 4640.3 4649.8 4651.2 4656.3 4681.2 107889.0 113494.0 114058.7 114638.0 115812.0 87932.1 98618.0 99128.0 100230.5 101795.0 85744.0 87438.6 87650.6 87737.1 88307.0 8720.7 8796.1 9046.1 9085.3 9143.2 50187.5 52139.2 52179.5 52222.2 53297.0 68787.7 73463.0 75707.6 75828.0 76525.0 12549.7 12589.6 12612.7 12712.5 12949.4 12978.8 13198.2 13297.4 13374.1 13400.7 12792.5 12873.3 13079.1 13092.9 13274.7 12549.9 12630.2 12785.3 12805.3 13251.1 12416.9 13193.1 13460.1 13602.3 13631.4 10295.5 10331.8 10709.2 10934.9 11056.9 9917.2 10159.8 10224.7 10378.8 10382.9 04:22:43 INFO - PROCESS | 16745 | -------- Summary: end -------- 04:22:43 INFO - PROCESS | 16745 | 04:22:44 INFO - TEST-INFO | 16745: exit 0 04:22:44 INFO - TEST-OK | dromaeo_css | took 1112107ms 04:22:44 INFO - TEST-START | kraken 04:22:44 INFO - operating with platform_type : linux_ 04:22:44 INFO - Initialising browser for kraken test... 04:22:44 INFO - TEST-INFO | started process 16984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPmMNt2/profile http://localhost:41346/getInfo.html) 04:22:49 INFO - PROCESS | 16984 | __metrics Screen width/height:1600/1200 04:22:49 INFO - PROCESS | 16984 | colorDepth:24 04:22:49 INFO - PROCESS | 16984 | Browser inner width/height: 1024/697 04:22:49 INFO - PROCESS | 16984 | __metrics 04:22:50 ERROR - PROCESS | 16984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:22:51 INFO - TEST-INFO | 16984: exit 0 04:22:51 INFO - Browser initialized. 04:22:51 INFO - Running cycle 1/1 for kraken test... 04:22:51 INFO - TEST-INFO | started process 17103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPmMNt2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:03 INFO - PROCESS | 17103 | RSS: Main: 184504320 04:23:03 INFO - PROCESS | 17103 | 04:23:05 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41346/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:06 INFO - PROCESS | 17103 | RSS: Main: 189956096 04:23:06 INFO - PROCESS | 17103 | 04:23:09 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41346/tests/kraken/driver.html?testName=audio-dft) 04:23:09 INFO - PROCESS | 17103 | RSS: Main: 189014016 04:23:09 INFO - PROCESS | 17103 | 04:23:12 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41346/tests/kraken/driver.html?testName=audio-fft) 04:23:13 INFO - PROCESS | 17103 | RSS: Main: 184270848 04:23:13 INFO - PROCESS | 17103 | 04:23:15 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41346/tests/kraken/driver.html?testName=audio-oscillator) 04:23:16 INFO - PROCESS | 17103 | RSS: Main: 184328192 04:23:16 INFO - PROCESS | 17103 | 04:23:18 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:23:18 INFO - PROCESS | 17103 | RSS: Main: 184721408 04:23:18 INFO - PROCESS | 17103 | 04:23:21 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41346/tests/kraken/driver.html?testName=imaging-darkroom) 04:23:22 INFO - PROCESS | 17103 | RSS: Main: 185167872 04:23:22 INFO - PROCESS | 17103 | 04:23:26 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41346/tests/kraken/driver.html?testName=imaging-desaturate) 04:23:26 INFO - PROCESS | 17103 | RSS: Main: 183156736 04:23:26 INFO - PROCESS | 17103 | 04:23:29 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41346/tests/kraken/driver.html?testName=json-parse-financial) 04:23:30 INFO - PROCESS | 17103 | RSS: Main: 184651776 04:23:30 INFO - PROCESS | 17103 | 04:23:31 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:32 INFO - PROCESS | 17103 | RSS: Main: 185192448 04:23:32 INFO - PROCESS | 17103 | 04:23:34 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:34 INFO - PROCESS | 17103 | RSS: Main: 185393152 04:23:34 INFO - PROCESS | 17103 | 04:23:36 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:23:37 INFO - PROCESS | 17103 | RSS: Main: 185933824 04:23:37 INFO - PROCESS | 17103 | 04:23:40 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:40 INFO - PROCESS | 17103 | RSS: Main: 186114048 04:23:40 INFO - PROCESS | 17103 | 04:23:43 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:44 INFO - PROCESS | 17103 | RSS: Main: 186081280 04:23:44 INFO - PROCESS | 17103 | 04:23:45 INFO - PROCESS | 17103 | Cycle 1(1): loaded http://localhost:41346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41346/tests/kraken/driver.html?testName=ai-astar) 04:23:46 INFO - PROCESS | 17103 | RSS: Main: 186564608 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | __start_tp_report 04:23:46 INFO - PROCESS | 17103 | _x_x_mozilla_page_load 04:23:46 INFO - PROCESS | 17103 | _x_x_mozilla_page_load_details 04:23:46 INFO - PROCESS | 17103 | |i|pagename|runs| 04:23:46 INFO - PROCESS | 17103 | |0;ai-astar;110;106;111;111;111;112;112;113;109;109 04:23:46 INFO - PROCESS | 17103 | |1;audio-beat-detection;159;129;155;183;135;152;157;128;191;126 04:23:46 INFO - PROCESS | 17103 | |2;audio-dft;162;165;164;164;164;171;168;163;164;164 04:23:46 INFO - PROCESS | 17103 | |3;audio-fft;76;75;76;155;76;77;75;74;170;75 04:23:46 INFO - PROCESS | 17103 | |4;audio-oscillator;85;85;144;85;85;86;138;85;85;150 04:23:46 INFO - PROCESS | 17103 | |5;imaging-gaussian-blur;118;118;118;117;117;118;120;118;118;117 04:23:46 INFO - PROCESS | 17103 | |6;imaging-darkroom;147;148;149;147;149;148;149;147;148;146 04:23:46 INFO - PROCESS | 17103 | |7;imaging-desaturate;96;98;100;96;96;96;96;97;96;96 04:23:46 INFO - PROCESS | 17103 | |8;json-parse-financial;55;56;55;55;57;54;55;58;55;55 04:23:46 INFO - PROCESS | 17103 | |9;json-stringify-tinderbox;61;63;62;63;61;61;61;62;61;61 04:23:46 INFO - PROCESS | 17103 | |10;stanford-crypto-aes;81;79;85;78;81;81;81;81;106;86 04:23:46 INFO - PROCESS | 17103 | |11;stanford-crypto-ccm;142;133;125;129;127;123;134;135;135;124 04:23:46 INFO - PROCESS | 17103 | |12;stanford-crypto-pbkdf2;168;168;166;159;168;160;163;168;160;156 04:23:46 INFO - PROCESS | 17103 | |13;stanford-crypto-sha256-iterative;64;63;64;67;64;63;70;62;65;62 04:23:46 INFO - PROCESS | 17103 | __end_tp_report 04:23:46 INFO - PROCESS | 17103 | __start_cc_report 04:23:46 INFO - PROCESS | 17103 | _x_x_mozilla_cycle_collect,895 04:23:46 INFO - PROCESS | 17103 | __end_cc_report 04:23:46 INFO - PROCESS | 17103 | __startTimestamp1465471426049__endTimestamp 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | ------- Summary: start ------- 04:23:46 INFO - PROCESS | 17103 | Number of tests: 14 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 04:23:46 INFO - PROCESS | 17103 | Values: 110.0 106.0 111.0 111.0 111.0 112.0 112.0 113.0 109.0 109.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.00 stddev:22.69 (14.5%) stddev-sans-first:23.90 04:23:46 INFO - PROCESS | 17103 | Values: 159.0 129.0 155.0 183.0 135.0 152.0 157.0 128.0 191.0 126.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.64 (1.6%) stddev-sans-first:2.59 04:23:46 INFO - PROCESS | 17103 | Values: 162.0 165.0 164.0 164.0 164.0 171.0 168.0 163.0 164.0 164.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:36.86 (48.8%) stddev-sans-first:38.59 04:23:46 INFO - PROCESS | 17103 | Values: 76.0 75.0 76.0 155.0 76.0 77.0 75.0 74.0 170.0 75.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.00 stddev:28.57 (33.6%) stddev-sans-first:29.57 04:23:46 INFO - PROCESS | 17103 | Values: 85.0 85.0 144.0 85.0 85.0 86.0 138.0 85.0 85.0 150.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 04:23:46 INFO - PROCESS | 17103 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 120.0 118.0 118.0 117.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 04:23:46 INFO - PROCESS | 17103 | Values: 147.0 148.0 149.0 147.0 149.0 148.0 149.0 147.0 148.0 146.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:1.39 04:23:46 INFO - PROCESS | 17103 | Values: 96.0 98.0 100.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.18 (2.1%) stddev-sans-first:1.24 04:23:46 INFO - PROCESS | 17103 | Values: 55.0 56.0 55.0 55.0 57.0 54.0 55.0 58.0 55.0 55.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 04:23:46 INFO - PROCESS | 17103 | Values: 61.0 63.0 62.0 63.0 61.0 61.0 61.0 62.0 61.0 61.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:8.13 (10.0%) stddev-sans-first:8.56 04:23:46 INFO - PROCESS | 17103 | Values: 81.0 79.0 85.0 78.0 81.0 81.0 81.0 81.0 106.0 86.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:133.50 stddev:6.09 (4.6%) stddev-sans-first:4.90 04:23:46 INFO - PROCESS | 17103 | Values: 142.0 133.0 125.0 129.0 127.0 123.0 134.0 135.0 135.0 124.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:167.00 stddev:4.58 (2.7%) stddev-sans-first:4.57 04:23:46 INFO - PROCESS | 17103 | Values: 168.0 168.0 166.0 159.0 168.0 160.0 163.0 168.0 160.0 156.0 04:23:46 INFO - PROCESS | 17103 | 04:23:46 INFO - PROCESS | 17103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.46 (3.8%) stddev-sans-first:2.60 04:23:46 INFO - PROCESS | 17103 | Values: 64.0 63.0 64.0 67.0 64.0 63.0 70.0 62.0 65.0 62.0 04:23:46 INFO - PROCESS | 17103 | -------- Summary: end -------- 04:23:46 INFO - PROCESS | 17103 | 04:23:47 INFO - TEST-INFO | 17103: exit 0 04:23:47 INFO - TEST-OK | kraken | took 62456ms 04:23:47 INFO - SUITE-END | took 1174s 04:23:47 INFO - Completed test suite (00:19:34) 04:23:47 INFO - javascript benchmark 04:23:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7339.755714966252, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.5346198070292, 3173.30187358781, 3191.2341038150844, 3195.8082515049086, 3206.519022146678, 5486.396496385394, 5517.531009864161, 5534.142207957768, 5612.270404847364, 5623.775048998045, 5349.5185433311, 5523.447655234475, 5536.723163841802, 5574.777008919648, 5605.327360716719, 4943.9011219775675, 4957.5786058185095, 5018.096742586333, 5114.923276150861, 5125.890359318265, 5012.273220383042, 5051.974740126313, 5077.695338279696, 5099.974500127494, 5101.183810590306, 4984.3021976923255, 5023.522765337306, 5046.823361182341, 5072.365954255718, 5089.643724939256, 5100.897982040376, 5103.209002604565, 5104.310918026056, 5120.257562653394, 5187.455317191716, 5061.0, 5070.949290507121, 5085.923711144335, 5097.031564002865, 5101.82143624975, 5497.367802702661, 5501.037318469252, 5534.280543529316, 5544.7227638618315, 5560.026995275811, 5948.7323070461935, 5951.196588460546, 5954.166416701665, 5967.940320596826, 5979.342272350082, 5850.970745146247, 5942.465178133989, 5987.580869339148, 6002.609830361012, 6023.337432882379, 5480.616356855022, 5561.054620714448, 5562.888742225174, 5571.832845014656, 5579.776808927679, 6004.759809607567, 6106.389361063947, 6144.938550614436, 6147.877042459126, 6159.1069294951985, 5767.048437007847, 5792.768289268382, 5816.651000939957, 5900.055991041413, 5906.0, 5953.136795164677, 5954.987652099154, 5958.940410595926, 5966.254218222723, 5993.0710739835395, 5733.598648094593, 5862.413758624189, 5936.1392598073035, 5938.703064846741, 5946.464818166386, 5945.583809133319, 6004.6097003695495, 6007.219061521974, 6007.399260074045, 6047.879042419127, 4566.725996440225, 4578.908421831611, 4588.334691469785, 4594.33382159585, 4626.467956185014, 3990.7206495545033, 4031.879043628696, 4071.91856162881, 4072.714909956275, 4089.0, 5668.716564171775, 5715.771369145271, 5729.914051289234, 5731.627444216113, 5742.052561327418, 6046.727897244635, 6047.0627052806885, 6047.758089676364, 6048.364921683248, 6052.636841789506, 5565.415631358649, 5654.604177707521, 5696.572757043238, 5722.0, 5723.255976723, 5008.398992120896, 5012.448630650625, 5018.322526458955, 5019.447860735316, 5094.592432605383, 5983.910241346296, 6147.66187859663, 6154.353792851775, 6154.753809847645, 6177.351378105324, 5845.18167456548, 5913.142594323885, 5942.64344139353, 5981.700914954322, 5982.7307771149535, 6055.969720151371, 6094.177286066324, 6125.938740612537, 6132.386761323832, 6144.293406258337, 5646.971765141148, 5776.075827867521, 5848.473637372657, 5858.297004359504, 5860.941390586039, 5899.734511946886, 5936.0, 5952.910706339322, 5954.4938680210935, 6039.698015099139, 5758.0, 5775.047117225611, 5782.10377391505, 5783.479486846204, 5828.358880523054, 5590.2453168821685, 5718.027935250934, 5736.942630573641, 5744.942550574441, 5793.826185214451, 5534.086875665631, 5541.5289700375915, 5592.916106258328, 5678.829635110953, 5749.166370876116, 5775.6823374714795, 5793.681347525927, 5809.912851307149, 5826.446487583673, 5836.795712150224, 5564.749586268546, 5668.461496157858, 5677.233573467529, 5678.233438485751, 5701.287339082614], "value": 5472.799340992843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5471495446164, 607.3956413368699, 612.5956868466812, 614.339584946183, 627.3945642455031, 42369.78815105928, 43628.78185609072, 43707.34438983418, 44067.55932440675, 46856.76571617137, 45667.77166114173, 46044.0, 46122.308165377544, 46481.07037859249, 46504.534954650444, 8701.695440659563, 8813.206811386974, 8814.647414103429, 8829.55852207387, 8835.337349698799, 8933.0, 9017.819643607158, 9018.954905225464, 9023.233025192834, 9028.232600228988, 9065.365424420293, 9069.818603627924, 9085.182333589975, 9086.636534538644, 9100.180983711465, 8968.372213945026, 8975.237104846095, 8993.10068993102, 9022.368434209608, 9054.275657947348, 8794.164554367326, 8802.779930501725, 8880.0, 8906.955465222698, 8962.238209752179, 42517.0, 42897.14205715868, 42979.1404171918, 43066.35400468996, 43128.353074703904, 3457.7752446091176, 3543.3799085160254, 3727.732570925871, 4001.5398229203433, 4080.224757296104, 29129.56305655417, 29140.708592914012, 29298.0, 30892.0, 34141.31717365664, 4001.6170166043894, 4062.4921884764403, 4119.553260858808, 4134.111166099273, 4238.364245363189, 386562.0, 386944.0, 388116.0, 389269.0, 389415.0, 60197.398026020055, 60341.0, 60582.39417605856, 60745.69627151836, 60832.695836520536, 34684.0, 35680.46479302813, 35699.10752231215, 61773.0, 61984.0, 17280.22238999248, 17309.65380692379, 17367.739483907753, 17393.478195654152, 17399.130043497775, 12962.092653514164, 12968.481260749653, 13016.609501714964, 13024.41390137446, 13026.218426894417, 18985.43043708691, 19138.0, 19207.51981200453, 19285.4214373569, 19317.80682193188, 6809.319068093151, 7052.647367631598, 7154.678039488235, 7220.891686624705, 7302.517144171007, 969.7575606098476, 976.7753416714196, 1022.9795404092025, 1106.5960924262586, 1118.5917140243753, 31445.528317075263, 32312.0, 32312.19219519484, 32416.675833241836, 32647.510287345707, 967.0474582536197, 1065.4429369513075, 1093.9343639381664, 1162.3897453836635, 1183.331417748969, 15901.363945442054, 16285.918570407071, 16298.266578004019, 16304.0, 16461.83538164627, 609647.0, 611870.0, 613706.0, 615140.0, 618834.0, 56548.71725641345, 57089.42910570924, 57175.714121429955, 57284.0, 57850.710746446, 1328.8604696506727, 1376.5400103664256, 1398.5245016694575, 1401.0332870319446, 1404.0592802822134, 29255.0, 30342.84828575843, 30412.847935761063, 30553.23616909595, 30895.382092357577, 48153.27770083521, 48487.5151248483, 48897.75551122222, 48906.5109348902, 49333.766655832456, 504991.0, 505426.0, 506110.0, 507329.0, 508277.0, 27420.862895685394, 27618.723812761615, 27718.168454946383, 27762.167134985983, 27885.442291154468, 47095.764521177174, 47410.0, 47450.52549474461, 47759.0, 48650.270245947046, 40684.59315406808, 41011.384829228184, 41072.79463602663, 41142.58857411507, 41786.791066044476, 39580.60419395769, 40013.59986400215, 40632.0, 40726.79636601917, 40919.37300076693, 40130.59869401269, 40455.393169101895, 41396.793016034724, 41591.58408415877, 44273.11453770971, 33693.66306336905, 36797.96061181581, 37461.43807842939, 37476.43785343168, 37833.81083094677, 28056.29859253535, 28425.304969054814, 28487.43025139527, 28611.42777144404, 28772.568411473425], "value": 20199.737738386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.9071422858513, 396.44299758838804, 396.90275882408815, 399.67426547363897, 407.92861249281384, 14179.43282268708, 17758.82241177588, 18668.533286667807, 19278.228870845185, 19279.807201927975, 15668.138252396142, 15856.207189640501, 16789.664206715857, 18226.817731822677, 18299.451016469528, 5489.945100548984, 5589.217509548666, 5733.598648094635, 5801.158831969362, 5830.562707796911, 5671.7164141792955, 5688.9146662799885, 5705.25831641886, 5709.229254050691, 5729.0833466645345, 5536.280283563131, 5609.831705048835, 5665.405132461094, 5705.743241554119, 5791.131330300446, 5764.9423505765035, 5765.884682306372, 5782.826515204551, 5803.767849286023, 5810.33181184165, 4930.9013819723405, 5116.718580478072, 5167.48325167484, 5167.560757335631, 5185.55922746567, 21139.788602113935, 21808.563828723494, 22260.77739222603, 22473.775262247495, 22556.774432255632, 2250.6393861892648, 2303.781140791622, 2322.454223257533, 2448.791852692523, 2952.2766922104006, 13594.32028398586, 14200.076994995292, 14456.638584035378, 14465.85534144666, 14538.636534086627, 1957.696557033662, 1977.9604407911904, 1979.4853338132045, 1990.3431867483696, 2012.1347820437206, 77623.0, 79791.20208797896, 80780.59609701972, 80922.59538702328, 81158.59420702858, 10005.49972501372, 10197.541110650038, 10304.948475257575, 10591.682249532527, 10598.894011059945, 12323.445444955, 13209.40557674907, 14463.638409039859, 14474.203918784568, 14483.565493035227, 7156.35692440621, 7325.377342925911, 8008.199180081945, 8040.959795201104, 8309.25216730485, 8104.0680321762575, 8127.715529956423, 8190.303824175012, 8304.418690691715, 8313.41806073569, 6096.69516524172, 6368.490520758328, 6382.776602818879, 6425.164728585254, 6463.127477790532, 1824.0, 1889.537063419471, 1905.7522522072043, 1907.5898681783206, 1919.9520011999532, 854.3634991931051, 942.6182396129578, 1020.4999550220339, 1070.4059247117925, 1078.2883297023927, 18439.72340414895, 18522.536936576693, 19009.0, 19010.0, 19010.146201166404, 1031.0926384781344, 1032.76762728387, 1053.7471006958428, 1081.8323159910226, 1139.8347239650204, 9443.90556094444, 11076.5569377224, 11082.168837337233, 11095.50070246841, 11134.721631959104, 466914.0, 475891.0, 495333.0, 495775.0, 496206.0, 79750.0, 82741.0, 83161.0, 83328.58335708283, 83471.58264208761, 1021.9131373833308, 1029.3000759483623, 1044.1490185498794, 1054.3568423261804, 1062.675883855416, 16593.35007714437, 16707.582310442336, 16762.0, 17143.571410714332, 17334.82665173332, 30857.382852343275, 36701.63298367089, 37132.0, 37906.81046594749, 39800.60199398085, 49909.0, 50344.0, 51103.744481277354, 51193.0, 52199.0, 8043.959780201061, 8080.757577272691, 8319.916800831914, 8364.749057528285, 8593.0, 12555.246685198552, 13062.673433164247, 13065.477380904656, 13110.737785244433, 13203.141795783244, 8452.788680283042, 8704.434211776213, 10976.890231097586, 11213.71965700864, 11554.364509952033, 11402.0, 11426.94286528562, 11655.88344116548, 11787.646370608896, 11890.940545297219, 11129.443527823738, 11661.008814250883, 11701.122415819018, 11764.764704706029, 11837.940810295893, 8028.197180281925, 8111.391645626483, 8182.977127859018, 8239.917600823916, 8316.251537361666, 11688.415579220835, 11787.941060294643, 11856.466459009192, 11965.880341196476, 11984.58053968107], "value": 9114.674324685348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.426185918421, 1491.1202390589553, 1624.829392913744, 1729.092226581044, 1750.9562260943483, 7756.612169391522, 8444.535550544726, 8446.915530844704, 9090.818183636331, 9117.316201284906, 8519.701810436636, 8722.258608018326, 8821.779455513615, 8821.867671984925, 8841.95579022104, 2318.48993221491, 2352.8353015288935, 2354.1407386304045, 2359.870207138615, 2364.3498038039593, 2291.3355127013147, 2297.1385730351117, 2300.700908881843, 2305.4697419593504, 2335.7313908900524, 2306.8500547464446, 2312.919047833326, 2314.2363020203375, 2377.702787151606, 2383.6067048936907, 2255.4812393149505, 2265.9773402266014, 2267.1498188179435, 2280.692106565609, 2283.6917016202765, 2231.308294428716, 2232.7767223277706, 2239.7536271010176, 2245.674377215311, 2267.1498188179435, 8885.42244754089, 8934.195922367018, 8934.821303573957, 8937.061608531076, 9015.729528114167, 5165.302684137631, 5277.656952298088, 5290.259363689087, 5302.390225124122, 5308.442613525563, 3183.7930534515413, 3252.804831710105, 3344.749143814199, 3389.762716609838, 3438.398280300937, 1172.9209127602626, 1187.928724276546, 1953.326102494637, 2111.883846388448, 2167.3606286145623, 12265.693357666041, 12345.93827030859, 12404.13171078025, 12414.62756117318, 12460.252384856938, 4344.45694288214, 4355.7822108894425, 4450.265706158512, 4467.441569803775, 4487.169873573399, 9622.759431014141, 9657.517124143766, 9669.323147379757, 9698.51507424626, 9711.951440242754, 5005.849824505271, 5025.195968644999, 5045.899082018339, 5072.340595722606, 5174.741262936838, 4236.915261694749, 4707.599854012379, 4768.594669453136, 4785.3300537924715, 4852.951470485321, 3591.1919818041256, 3691.187938653492, 3709.406494960793, 3766.7174961877968, 3828.712846536521, 1085.782843431317, 1116.849225354583, 1119.054399032816, 1122.2649164797072, 1149.408054851752, 845.6406027438314, 854.7734850264685, 938.216589148069, 940.501534186882, 977.4575110813566, 5618.2415373924, 5649.322081350182, 5692.402297758758, 5784.161296611967, 5804.79683211094, 473.7181377080631, 476.10492274523676, 487.36642364925456, 1018.567108978696, 1046.1630695443766, 3930.4890364252465, 3956.5252169739815, 3976.906350753566, 4019.2765302245293, 4027.2952233359047, 11016.559337626406, 11133.443327833576, 11254.831177532344, 11318.886811131948, 11319.603813866639, 10997.450127493594, 11130.443477826077, 11135.944320278346, 11145.108391328675, 11248.0, 8168.877466838002, 8409.747707568782, 8478.406511544255, 8481.575921203916, 8513.702020429255, 5704.087346024616, 5770.278715160605, 5844.327902291121, 5859.384764599656, 5943.91084133747, 10349.74125646865, 10373.377597344184, 10492.317999330018, 10496.16030717556, 10512.211584131068, 10141.746456338651, 10402.127617029008, 10426.68719938403, 10505.369677819355, 10554.261201715806, 6896.965515172593, 7375.373093286916, 7480.850382992418, 7557.735479258199, 7610.972518709903, 8789.340799440195, 8810.427322224292, 8850.822983540422, 8854.513001784964, 8879.33404994615, 7670.309672129535, 7800.882986755317, 7843.450958432855, 7923.3661307096445, 8144.959275203586, 7811.960940195263, 7812.140664527011, 7879.960600196962, 7980.042394912648, 8032.156623554442, 7164.176119746087, 7182.533135346186, 7274.236205198378, 7289.271072892669, 7297.452691048086, 5111.207762796773, 5123.769430375716, 5158.406783219828, 5165.7675404607635, 5189.844304670866, 4800.3759511263315, 4908.680935739166, 4959.801607935787, 5148.330717006766, 5226.764795584284], "value": 4613.587674742317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.50688323073507, 340.93863104641173, 341.00426753878673, 344.7362767482876, 348.54514858110156, 5602.543338731928, 5645.57658175637, 5653.575981801371, 5673.914891276629, 5674.177244299574, 5574.414686457914, 5592.636478628886, 5594.300712410949, 5596.356419011815, 5600.355959064709, 4178.6657067434535, 4382.737035777864, 4398.582134697199, 4404.647628189737, 4418.911621767571, 4230.492340919079, 4336.934945975813, 4337.761423121727, 4340.587644173798, 4343.847965321214, 4290.76400797956, 4312.762798046107, 4325.307950727884, 4331.112122014979, 4356.7821608919585, 4208.389783481409, 4366.471734892778, 4368.0, 4398.780060996937, 4399.5820397062225, 3805.543334799842, 3827.445020472044, 3837.194189220239, 3839.865604703822, 3847.365184744514, 5393.946060539383, 5412.431694672042, 5430.3755068167275, 5452.890942181134, 5475.288212532385, 4942.20924652054, 5010.549050585429, 5032.465098145064, 5037.319961805146, 5095.573239492911, 5685.260916080883, 5757.740901659436, 5758.88482230353, 5899.5870289079785, 5927.762889484416, 4274.700770946035, 4286.6570674346285, 4291.828326866922, 4298.892527686801, 4321.9135617287475, 5971.910421343683, 6078.544109191784, 6096.1770161028135, 6104.481119104837, 6142.570020098595, 4308.482982042112, 4310.181065597527, 4350.2810743285445, 4352.673549483801, 4353.760543170156, 4398.0, 4424.402705634762, 4444.6666500012625, 4446.466424029137, 4446.510883802844, 4864.318995340655, 4937.9012419752125, 5012.974935125301, 5049.2173713074535, 5063.493650634907, 5848.678322692208, 5881.382454842265, 5894.0, 5915.438033386821, 5915.467607915309, 1500.9774853377207, 1503.4812989518598, 1526.2750193658146, 1527.6868242010362, 1528.083150109925, 933.206774241889, 944.1644144931785, 954.7565370830393, 982.2044144243185, 991.5339790298548, 5062.025809934129, 5569.331680198321, 5783.652980821164, 5806.04200306953, 5821.27234095738, 6130.570860039844, 6171.6297022178815, 6183.783567575113, 6193.163922870445, 6197.380261973766, 5625.54995600351, 5766.336871259775, 5767.567432442584, 5810.593258471867, 5813.215215945877, 3238.834019752887, 3257.1857035741064, 3262.9021129366156, 3264.379767844102, 3266.673332666762, 6202.906081985868, 6332.606826498163, 6345.524085693592, 6349.238091429058, 6382.20222472191, 6035.094735789667, 6151.415615516519, 6154.3845615438095, 6245.687715614201, 6281.0, 6276.843078922972, 6321.241451025906, 6342.619442833445, 6370.426661600478, 6383.234011918599, 5921.407859214217, 6002.8294482575475, 6015.368386319374, 6078.72645730952, 6079.665618391031, 5964.314103877936, 5979.730912108878, 5984.670843103497, 6017.909731354121, 6036.939630603813, 6024.5481588881885, 6244.906326405198, 6276.905846412216, 6323.6838158090995, 6324.841878953063, 4207.263728847501, 4239.5124560674685, 4247.405363249086, 4255.319148936155, 4264.744115352964, 6106.366711806468, 6106.938930610637, 6111.616469576958, 6129.908051379144, 6136.790755327989, 5864.208331875142, 5945.64326140433, 5962.582619216787, 5979.535013921617, 5986.593150609516, 5970.462658360769, 5991.0, 5996.2504686914135, 6021.157038014769, 6028.849278768066, 5729.479029227126, 5733.655980641175, 5804.65172089676, 5852.7658893643775, 5909.143174239625, 5844.707764611838, 5858.736356863866, 5890.941090589039, 5999.430054145024, 6018.0, 5817.214676018683, 5846.210761547307, 5855.970720146372, 5871.412858714094, 5875.441833025856], "value": 4503.157613082244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.1259070954467, 779.4777499075619, 784.9686012559498, 807.7617102954631, 813.4996976859226, 14192.716145677094, 14680.559583212495, 14742.557723268319, 14794.482193123244, 14861.702765944674, 14647.414103435849, 14687.192204428753, 14713.852861471381, 14777.408903643869, 14846.851531484708, 670.9698063587126, 782.7143092771155, 791.8297566023318, 793.9166387529312, 807.0355924670022, 786.6538722961878, 789.3487872505177, 792.9484583502054, 794.4319811334894, 795.0, 834.5910503853129, 837.2757564706546, 842.3892677808601, 842.8482873082843, 843.8438888805559, 827.4538804389074, 828.2338836576143, 829.713748756681, 835.1481488881337, 835.7367429259764, 605.5579427018301, 609.4058293164173, 612.8498517863108, 613.0773186354553, 613.1018058544254, 13804.723905521934, 13836.377363018688, 13897.0, 13983.510577129751, 14115.364808583638, 14537.200453975027, 14739.92630036843, 14800.0, 14960.47638332664, 15129.697406051928, 11752.764944701144, 11876.940615296868, 11960.0, 11970.760584788255, 11998.880011199864, 3701.704403458768, 3739.4577786221116, 3826.540815102178, 3862.2275544891136, 3876.4379165021196, 73677.7896663101, 73983.26016739817, 74712.25287747107, 75094.0, 76095.23904760937, 11332.490037948312, 11444.370559619301, 11607.187496875307, 11878.881211187778, 12005.339706316061, 22156.446088847584, 22229.221977231042, 22293.777062229496, 22302.88848555747, 22330.441738956655, 8402.957985210158, 8509.276711479593, 8637.481751094954, 8813.206811387006, 8898.199162075443, 4676.392069031004, 4734.597559207437, 4777.522247775264, 4778.522147785263, 4782.545658162469, 3747.8500859965843, 3874.3994680824517, 3875.6124387561017, 3878.8448462061765, 3893.8053097345587, 627.5387590121258, 642.081822993115, 654.4044919123575, 665.9400653941168, 667.813012356541, 654.6890227142164, 717.7739012211136, 738.9371903388164, 750.1494321577982, 764.6024067484876, 9260.722178334661, 9558.665446709332, 9764.316497845224, 9969.700908972742, 10000.649977250761, 647.6923461355818, 742.7920182348951, 751.6429695894516, 755.437199286535, 777.8133248020547, 4640.32715256286, 4649.837255696102, 4651.232546629768, 4656.254999200111, 4681.227597446451, 107889.0, 113494.0, 114058.72677002844, 114638.0, 115812.0, 87932.12067879367, 98618.0, 99128.0, 100230.49884750675, 101795.0, 85744.0, 87438.56280718556, 87650.56174719086, 87737.12262877417, 88307.0, 8720.694775682821, 8796.103406543281, 9046.140616641671, 9085.273178145864, 9143.177114059767, 50187.49812501828, 52139.217911732114, 52179.47820521746, 52222.21666674927, 53297.0, 68787.65606171938, 73463.0, 75707.62146189234, 75828.0, 76525.0, 12549.686257843627, 12589.622311330675, 12612.684682883002, 12712.491500340253, 12949.41727622278, 12978.795488062528, 13198.20810751358, 13297.365915582262, 13374.06381553282, 13400.731985360044, 12792.488300467878, 12873.291968941798, 13079.149855259378, 13092.934535327262, 13274.668133296746, 12549.87450125487, 12630.242185468902, 12785.296808675612, 12805.295708736108, 13251.072424930162, 12416.937915310365, 13193.142445740996, 13460.147619755598, 13602.319884005958, 13631.38658760378, 10295.53670084833, 10331.793364132525, 10709.196810239107, 10934.945325273322, 11056.944715276371, 9917.15704165154, 10159.847602285823, 10224.744381390525, 10378.792424151627, 10382.896171038194], "value": 7467.841553569056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 111.0, 111.0, 112.0, 112.0, 113.0, 109.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 155.0, 183.0, 135.0, 152.0, 157.0, 128.0, 191.0, 126.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 164.0, 164.0, 171.0, 168.0, 163.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 155.0, 76.0, 77.0, 75.0, 74.0, 170.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 144.0, 85.0, 85.0, 86.0, 138.0, 85.0, 85.0, 150.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 149.0, 148.0, 149.0, 147.0, 148.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 100.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 57.0, 54.0, 55.0, 58.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 85.0, 78.0, 81.0, 81.0, 81.0, 81.0, 106.0, 86.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 125.0, 129.0, 127.0, 123.0, 134.0, 135.0, 135.0, 124.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 159.0, 168.0, 160.0, 163.0, 168.0, 160.0, 156.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 67.0, 64.0, 63.0, 70.0, 62.0, 65.0, 62.0], "value": 64.4, "unit": "score"}]}]} 04:23:47 INFO - Return code: 0 04:23:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:47 ERROR - # TBPL SUCCESS # 04:23:47 INFO - Running post-action listener: _resource_record_post_action 04:23:47 INFO - ##### 04:23:47 INFO - ##### Finished run-tests step (success) 04:23:47 INFO - ##### 04:23:47 INFO - Running post-run listener: _resource_record_post_run 04:23:47 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 541962240; Read time: 368; Write time: 453004 04:23:47 INFO - TinderboxPrint: CPU usage
13.4% 04:23:47 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 368 04:23:47 INFO - TinderboxPrint: I/O write bytes / time
541,962,240 / 453,004 04:23:47 INFO - TinderboxPrint: CPU idle
8,235.5 (86.5%) 04:23:47 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 04:23:47 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 248365056; Read time: 136; Write time: 257128 04:23:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 293597184; Read time: 232; Write time: 195876 04:23:47 INFO - Running post-run listener: _upload_blobber_files 04:23:47 INFO - Blob upload gear active. 04:23:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:47 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:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:23:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:49 INFO - (blobuploader) - INFO - Done attempting. 04:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:53 INFO - (blobuploader) - INFO - Done attempting. 04:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:53 INFO - (blobuploader) - INFO - Done attempting. 04:23:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:53 INFO - Return code: 0 04:23:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b8ecbeb6c277b890c883cada00b87739689f44930f384128e6f07948a040ee6b1cb33c0c8ead6811f290a309a2646b13ac085ea9b44bce164c5640654e5d53da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8b62f4a61f95ff43dc1c3fbfd0bd8351119f2b02b5e5654c7c45f2f0100fa1b708c3385721d07c6ab4496a3ec1e8f7f475d0f1d21cf4b4c7f4dc863f80fb89f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4823e468380b60da03f8a083fb6760c0f5cabebfcd3452ada17ad2eaf18dfbf3d38899a1c112c98b4ee176d18656a864ef0b0b830a7f97b7e4159255d11d612"} 04:23:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:53 INFO - Contents: 04:23:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b8ecbeb6c277b890c883cada00b87739689f44930f384128e6f07948a040ee6b1cb33c0c8ead6811f290a309a2646b13ac085ea9b44bce164c5640654e5d53da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8b62f4a61f95ff43dc1c3fbfd0bd8351119f2b02b5e5654c7c45f2f0100fa1b708c3385721d07c6ab4496a3ec1e8f7f475d0f1d21cf4b4c7f4dc863f80fb89f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4823e468380b60da03f8a083fb6760c0f5cabebfcd3452ada17ad2eaf18dfbf3d38899a1c112c98b4ee176d18656a864ef0b0b830a7f97b7e4159255d11d612"} 04:23:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:53 INFO - Copying logs to upload dir... 04:23:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.580205 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 04:23:53.808233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:23:53.812002) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 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-Inbound/sha512/b8ecbeb6c277b890c883cada00b87739689f44930f384128e6f07948a040ee6b1cb33c0c8ead6811f290a309a2646b13ac085ea9b44bce164c5640654e5d53da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8b62f4a61f95ff43dc1c3fbfd0bd8351119f2b02b5e5654c7c45f2f0100fa1b708c3385721d07c6ab4496a3ec1e8f7f475d0f1d21cf4b4c7f4dc863f80fb89f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4823e468380b60da03f8a083fb6760c0f5cabebfcd3452ada17ad2eaf18dfbf3d38899a1c112c98b4ee176d18656a864ef0b0b830a7f97b7e4159255d11d612"} build_url:https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/KUHXwP2RTjKhNInCbEciXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b8ecbeb6c277b890c883cada00b87739689f44930f384128e6f07948a040ee6b1cb33c0c8ead6811f290a309a2646b13ac085ea9b44bce164c5640654e5d53da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8b62f4a61f95ff43dc1c3fbfd0bd8351119f2b02b5e5654c7c45f2f0100fa1b708c3385721d07c6ab4496a3ec1e8f7f475d0f1d21cf4b4c7f4dc863f80fb89f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4823e468380b60da03f8a083fb6760c0f5cabebfcd3452ada17ad2eaf18dfbf3d38899a1c112c98b4ee176d18656a864ef0b0b830a7f97b7e4159255d11d612"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:23:53.837932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:23:53.838314) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465469348.220495-1553298620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:23:53.920538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:23:53.920902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:23:53.921211) ========= ========= Total master_lag: 0.16 =========