builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466982220.03 results: success (0) buildid: 20160626133106 builduid: 447d8c3ac4104c7f9d14ff0f3be2ee8d revision: 4e6dd91cd5823834a7da0394367609a1640dfb11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.032909) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.033733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.034067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.497524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.497807) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 16:03:40-- 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% 55.5M=0s 2016-06-26 16:03:41 (55.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.645759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.646217) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.696914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:40.697293) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4e6dd91cd5823834a7da0394367609a1640dfb11 --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 4e6dd91cd5823834a7da0394367609a1640dfb11 --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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 16:03:41,125 truncating revision to first 12 chars 2016-06-26 16:03:41,125 Setting DEBUG logging. 2016-06-26 16:03:41,125 attempt 1/10 2016-06-26 16:03:41,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4e6dd91cd582?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 16:03:41,482 unpacking tar archive at: mozilla-inbound-4e6dd91cd582/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:41.407792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:41.408182) ========= script_repo_revision: 4e6dd91cd5823834a7da0394367609a1640dfb11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:41.408638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:41.408972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 16:03:41.419152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-26 16:03:41.419506) ========= /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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:03:41 INFO - MultiFileLogger online at 20160626 16:03:41 in /builds/slave/test 16:03:41 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 16:03:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:03:41 INFO - {'append_to_log': False, 16:03:41 INFO - 'base_work_dir': '/builds/slave/test', 16:03:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:03:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:03:41 INFO - 'branch': 'Mozilla-Inbound', 16:03:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:41 INFO - 'config_files': ('talos/linux_config.py',), 16:03:41 INFO - 'default_actions': ('clobber', 16:03:41 INFO - 'read-buildbot-config', 16:03:41 INFO - 'download-and-extract', 16:03:41 INFO - 'populate-webroot', 16:03:41 INFO - 'create-virtualenv', 16:03:41 INFO - 'install', 16:03:41 INFO - 'run-tests'), 16:03:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:41 INFO - 'download_minidump_stackwalk': True, 16:03:41 INFO - 'download_symbols': 'ondemand', 16:03:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:41 INFO - 'installer_path': 'installer.exe', 16:03:41 INFO - 'log_level': 'info', 16:03:41 INFO - 'log_name': 'talos', 16:03:41 INFO - 'log_to_console': True, 16:03:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:03:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:03:41 INFO - 'opt_config_files': (), 16:03:41 INFO - 'pip_index': False, 16:03:41 INFO - 'sps_profile': False, 16:03:41 INFO - 'sps_profile_interval': 0, 16:03:41 INFO - 'suite': 'dromaeojs-e10s', 16:03:41 INFO - 'system_bits': '32', 16:03:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:41 INFO - 'title': 'talos-linux64-ix-001', 16:03:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:41 INFO - 'use_talos_json': True, 16:03:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:03:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:41 INFO - 'work_dir': 'build'} 16:03:41 INFO - ##### 16:03:41 INFO - ##### Running clobber step. 16:03:41 INFO - ##### 16:03:41 INFO - Running pre-action listener: _resource_record_pre_action 16:03:41 INFO - Running main action method: clobber 16:03:41 INFO - rmtree: /builds/slave/test/build 16:03:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:03:42 INFO - Running post-action listener: _resource_record_post_action 16:03:42 INFO - ##### 16:03:42 INFO - ##### Finished clobber step (success) 16:03:42 INFO - ##### 16:03:42 INFO - ##### 16:03:42 INFO - ##### Running read-buildbot-config step. 16:03:42 INFO - ##### 16:03:42 INFO - Running pre-action listener: _resource_record_pre_action 16:03:42 INFO - Running main action method: read_buildbot_config 16:03:42 INFO - Using buildbot properties: 16:03:42 INFO - { 16:03:42 INFO - "project": "", 16:03:42 INFO - "product": "firefox", 16:03:42 INFO - "script_repo_revision": "production", 16:03:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:03:42 INFO - "repository": "", 16:03:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:03:42 INFO - "buildid": "20160626133106", 16:03:42 INFO - "pgo_build": "True", 16:03:42 INFO - "basedir": "/builds/slave/test", 16:03:42 INFO - "buildnumber": 1221, 16:03:42 INFO - "slavename": "talos-linux64-ix-001", 16:03:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:03:42 INFO - "platform": "ubuntu64_hw", 16:03:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:03:42 INFO - "branch": "mozilla-inbound", 16:03:42 INFO - "repo_path": "integration/mozilla-inbound", 16:03:42 INFO - "revision": "4e6dd91cd5823834a7da0394367609a1640dfb11", 16:03:42 INFO - "stage_platform": "linux64-pgo", 16:03:42 INFO - "builduid": "447d8c3ac4104c7f9d14ff0f3be2ee8d", 16:03:42 INFO - "slavebuilddir": "test" 16:03:42 INFO - } 16:03:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:03:42 INFO - Running post-action listener: _resource_record_post_action 16:03:42 INFO - ##### 16:03:42 INFO - ##### Finished read-buildbot-config step (success) 16:03:42 INFO - ##### 16:03:42 INFO - ##### 16:03:42 INFO - ##### Running download-and-extract step. 16:03:42 INFO - ##### 16:03:42 INFO - Running pre-action listener: _resource_record_pre_action 16:03:42 INFO - Running main action method: download_and_extract 16:03:42 INFO - mkdir: /builds/slave/test/build/tests 16:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:42 INFO - https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:49 INFO - Downloaded 1361 bytes. 16:03:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:03:49 INFO - Using the following test package requirements: 16:03:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:03:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:03:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:03:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'jsshell-linux-x86_64.zip'], 16:03:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:03:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:03:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:03:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:03:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:03:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:03:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:03:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:03:49 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')]} 16:03:49 INFO - https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:03:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:03:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:03:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:57 INFO - Downloaded 24279836 bytes. 16:03:57 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'] 16:03:57 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 16:03:58 INFO - Return code: 0 16:03:58 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 16:03:58 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')]} 16:03:58 INFO - https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:03:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:03:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:03:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:03:59 INFO - Downloaded 24279836 bytes. 16:03:59 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'] 16:03:59 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 16:04:00 INFO - Return code: 0 16:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:00 INFO - https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:04:01 INFO - Downloaded 14405240 bytes. 16:04:01 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'] 16:04:01 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 16:04:02 INFO - Return code: 0 16:04:02 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')]} 16:04:02 INFO - https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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 16:04:08 INFO - Downloaded 60175128 bytes. 16:04:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:08 INFO - mkdir: /builds/slave/test/properties 16:04:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:04:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:04:08 INFO - Contents: 16:04:08 INFO - build_url:https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:09 INFO - Running post-action listener: _resource_record_post_action 16:04:09 INFO - Running post-action listener: set_extra_try_arguments 16:04:09 INFO - ##### 16:04:09 INFO - ##### Finished download-and-extract step (success) 16:04:09 INFO - ##### 16:04:09 INFO - ##### 16:04:09 INFO - ##### Running populate-webroot step. 16:04:09 INFO - ##### 16:04:09 INFO - Running pre-action listener: _resource_record_pre_action 16:04:09 INFO - Running main action method: populate_webroot 16:04:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:09 INFO - '--tppagecycles', 16:04:09 INFO - '7'], 16:04:09 INFO - 'tests': ['tsvgm']}}, 16:04:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:04:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:04:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:04:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['damp', 'tps']}, 16:04:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'tests': ['damp', 'tps']}, 16:04:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['dromaeo_dom']}, 16:04:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['basic_compositor_video']}, 16:04:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:04:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['a11yr', 16:04:09 INFO - 'ts_paint', 16:04:09 INFO - 'tpaint', 16:04:09 INFO - 'sessionrestore', 16:04:09 INFO - 'sessionrestore_no_auto_restore', 16:04:09 INFO - 'tabpaint']}, 16:04:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['tsvgx', 16:04:09 INFO - 'tsvgr_opacity', 16:04:09 INFO - 'tart', 16:04:09 INFO - 'tscrollx', 16:04:09 INFO - 'cart']}, 16:04:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:04:09 INFO - 'tsvgr_opacity', 16:04:09 INFO - 'tart', 16:04:09 INFO - 'tscrollx', 16:04:09 INFO - 'cart']}, 16:04:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'talos_options': ['--disable-e10s'], 16:04:09 INFO - 'tests': ['tp5o']}, 16:04:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'tests': ['tp5o']}, 16:04:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'talos_options': ['--disable-e10s', 16:04:09 INFO - '--xperf_path', 16:04:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:09 INFO - 'tests': ['tp5n']}, 16:04:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:09 INFO - 'talos_options': ['--xperf_path', 16:04:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:09 INFO - 'tests': ['tp5n']}}, 16:04:09 INFO - 'talos.zip': {'path': '', 16:04:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:09 INFO - Running post-action listener: _resource_record_post_action 16:04:09 INFO - ##### 16:04:09 INFO - ##### Finished populate-webroot step (success) 16:04:09 INFO - ##### 16:04:09 INFO - ##### 16:04:09 INFO - ##### Running create-virtualenv step. 16:04:09 INFO - ##### 16:04:09 INFO - Running pre-action listener: _resource_record_pre_action 16:04:09 INFO - Running main action method: create_virtualenv 16:04:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:04:09 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 16:04:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:04:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:09 INFO - Using real prefix '/usr' 16:04:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:04:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:12 INFO - Installing pip.................done. 16:04:12 INFO - Return code: 0 16:04:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:12 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 16:04:12 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 16:04:12 INFO - Using env: {'DISPLAY': ':0', 16:04:12 INFO - 'HOME': '/home/cltbld', 16:04:12 INFO - 'LANG': 'en_US.UTF-8', 16:04:12 INFO - 'LANGUAGE': 'en_US:en', 16:04:12 INFO - 'LOGNAME': 'cltbld', 16:04:12 INFO - 'MAIL': '/var/mail/cltbld', 16:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:12 INFO - 'MOZ_NO_REMOTE': '1', 16:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:12 INFO - 'NO_EM_RESTART': '1', 16:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:12 INFO - 'PWD': '/builds/slave/test', 16:04:12 INFO - 'SHELL': '/bin/bash', 16:04:12 INFO - 'SHLVL': '1', 16:04:12 INFO - 'TERM': 'linux', 16:04:12 INFO - 'TMOUT': '86400', 16:04:12 INFO - 'USER': 'cltbld', 16:04:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:12 INFO - '_': '/tools/buildbot/bin/python'} 16:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:12 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 16:04:12 INFO - Cleaning up... 16:04:12 INFO - Return code: 0 16:04:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:12 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 16:04:12 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 16:04:12 INFO - Using env: {'DISPLAY': ':0', 16:04:12 INFO - 'HOME': '/home/cltbld', 16:04:12 INFO - 'LANG': 'en_US.UTF-8', 16:04:12 INFO - 'LANGUAGE': 'en_US:en', 16:04:12 INFO - 'LOGNAME': 'cltbld', 16:04:12 INFO - 'MAIL': '/var/mail/cltbld', 16:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:12 INFO - 'MOZ_NO_REMOTE': '1', 16:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:12 INFO - 'NO_EM_RESTART': '1', 16:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:12 INFO - 'PWD': '/builds/slave/test', 16:04:12 INFO - 'SHELL': '/bin/bash', 16:04:12 INFO - 'SHLVL': '1', 16:04:12 INFO - 'TERM': 'linux', 16:04:12 INFO - 'TMOUT': '86400', 16:04:12 INFO - 'USER': 'cltbld', 16:04:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:12 INFO - '_': '/tools/buildbot/bin/python'} 16:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:12 INFO - Downloading/unpacking psutil>=3.1.1 16:04:12 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 16:04:12 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 16:04:12 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 16:04:12 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 16:04:12 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 16:04:12 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 16:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:14 INFO - Installing collected packages: psutil 16:04:14 INFO - Running setup.py install for psutil 16:04:14 INFO - building 'psutil._psutil_linux' extension 16:04:14 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 16:04:14 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 16:04:14 INFO - building 'psutil._psutil_posix' extension 16:04:14 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 16:04:14 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 16:04:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:15 INFO - Successfully installed psutil 16:04:15 INFO - Cleaning up... 16:04:15 INFO - Return code: 0 16:04:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:15 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 16:04:15 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 16:04:15 INFO - Using env: {'DISPLAY': ':0', 16:04:15 INFO - 'HOME': '/home/cltbld', 16:04:15 INFO - 'LANG': 'en_US.UTF-8', 16:04:15 INFO - 'LANGUAGE': 'en_US:en', 16:04:15 INFO - 'LOGNAME': 'cltbld', 16:04:15 INFO - 'MAIL': '/var/mail/cltbld', 16:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:15 INFO - 'MOZ_NO_REMOTE': '1', 16:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:15 INFO - 'NO_EM_RESTART': '1', 16:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:15 INFO - 'PWD': '/builds/slave/test', 16:04:15 INFO - 'SHELL': '/bin/bash', 16:04:15 INFO - 'SHLVL': '1', 16:04:15 INFO - 'TERM': 'linux', 16:04:15 INFO - 'TMOUT': '86400', 16:04:15 INFO - 'USER': 'cltbld', 16:04:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:15 INFO - '_': '/tools/buildbot/bin/python'} 16:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:15 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 16:04:15 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 16:04:15 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 16:04:15 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 16:04:15 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 16:04:15 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 16:04:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:17 INFO - Installing collected packages: mozsystemmonitor 16:04:17 INFO - Running setup.py install for mozsystemmonitor 16:04:17 INFO - Successfully installed mozsystemmonitor 16:04:17 INFO - Cleaning up... 16:04:17 INFO - Return code: 0 16:04:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:17 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:17 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 16:04:17 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 16:04:17 INFO - Using env: {'DISPLAY': ':0', 16:04:17 INFO - 'HOME': '/home/cltbld', 16:04:17 INFO - 'LANG': 'en_US.UTF-8', 16:04:17 INFO - 'LANGUAGE': 'en_US:en', 16:04:17 INFO - 'LOGNAME': 'cltbld', 16:04:17 INFO - 'MAIL': '/var/mail/cltbld', 16:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:17 INFO - 'MOZ_NO_REMOTE': '1', 16:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:17 INFO - 'NO_EM_RESTART': '1', 16:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:17 INFO - 'PWD': '/builds/slave/test', 16:04:17 INFO - 'SHELL': '/bin/bash', 16:04:17 INFO - 'SHLVL': '1', 16:04:17 INFO - 'TERM': 'linux', 16:04:17 INFO - 'TMOUT': '86400', 16:04:17 INFO - 'USER': 'cltbld', 16:04:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:17 INFO - '_': '/tools/buildbot/bin/python'} 16:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:19 INFO - warning: no files found matching '*.txt' 16:04:19 INFO - no previously-included directories found matching 'build' 16:04:19 INFO - no previously-included directories found matching 'dist' 16:04:19 INFO - no previously-included directories found matching '.git*' 16:04:19 INFO - Installing collected packages: jsonschema, functools32 16:04:19 INFO - Running setup.py install for functools32 16:04:19 INFO - warning: no files found matching '*.txt' 16:04:19 INFO - no previously-included directories found matching 'build' 16:04:19 INFO - no previously-included directories found matching 'dist' 16:04:19 INFO - no previously-included directories found matching '.git*' 16:04:19 INFO - Successfully installed jsonschema functools32 16:04:19 INFO - Cleaning up... 16:04:19 INFO - Return code: 0 16:04:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:20 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:20 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 16:04:20 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 16:04:20 INFO - Using env: {'DISPLAY': ':0', 16:04:20 INFO - 'HOME': '/home/cltbld', 16:04:20 INFO - 'LANG': 'en_US.UTF-8', 16:04:20 INFO - 'LANGUAGE': 'en_US:en', 16:04:20 INFO - 'LOGNAME': 'cltbld', 16:04:20 INFO - 'MAIL': '/var/mail/cltbld', 16:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:20 INFO - 'MOZ_NO_REMOTE': '1', 16:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:20 INFO - 'NO_EM_RESTART': '1', 16:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:20 INFO - 'PWD': '/builds/slave/test', 16:04:20 INFO - 'SHELL': '/bin/bash', 16:04:20 INFO - 'SHLVL': '1', 16:04:20 INFO - 'TERM': 'linux', 16:04:20 INFO - 'TMOUT': '86400', 16:04:20 INFO - 'USER': 'cltbld', 16:04:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:20 INFO - '_': '/tools/buildbot/bin/python'} 16:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:04:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:04:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:22 INFO - Downloading docopt-0.6.1.tar.gz 16:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:04:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:04:22 INFO - Running setup.py install for blobuploader 16:04:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:04:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:04:23 INFO - Running setup.py install for requests 16:04:23 INFO - Running setup.py install for docopt 16:04:23 INFO - Successfully installed blobuploader requests docopt 16:04:23 INFO - Cleaning up... 16:04:23 INFO - Return code: 0 16:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:23 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')]} 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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')]} 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:23 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:23 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 16:04:23 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 16:04:23 INFO - Using env: {'DISPLAY': ':0', 16:04:23 INFO - 'HOME': '/home/cltbld', 16:04:23 INFO - 'LANG': 'en_US.UTF-8', 16:04:23 INFO - 'LANGUAGE': 'en_US:en', 16:04:23 INFO - 'LOGNAME': 'cltbld', 16:04:23 INFO - 'MAIL': '/var/mail/cltbld', 16:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:23 INFO - 'MOZ_NO_REMOTE': '1', 16:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:23 INFO - 'NO_EM_RESTART': '1', 16:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:23 INFO - 'PWD': '/builds/slave/test', 16:04:23 INFO - 'SHELL': '/bin/bash', 16:04:23 INFO - 'SHLVL': '1', 16:04:23 INFO - 'TERM': 'linux', 16:04:23 INFO - 'TMOUT': '86400', 16:04:23 INFO - 'USER': 'cltbld', 16:04:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:23 INFO - '_': '/tools/buildbot/bin/python'} 16:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:23 INFO - Running setup.py (path:/tmp/pip-vQZRLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:23 INFO - Running setup.py (path:/tmp/pip-IpEa2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:23 INFO - Running setup.py (path:/tmp/pip-NA7NeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:24 INFO - Running setup.py (path:/tmp/pip-rvMYDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:24 INFO - Running setup.py (path:/tmp/pip-GCxLdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:24 INFO - Running setup.py (path:/tmp/pip-4xNhJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:24 INFO - Running setup.py (path:/tmp/pip-uneCqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:24 INFO - Running setup.py (path:/tmp/pip-kiRPm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:24 INFO - Running setup.py (path:/tmp/pip-YhN40e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:24 INFO - Running setup.py (path:/tmp/pip-p7dMNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:24 INFO - Running setup.py (path:/tmp/pip-mDdJHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:24 INFO - Running setup.py (path:/tmp/pip-wHiJoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:24 INFO - Running setup.py (path:/tmp/pip-YvoEKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:24 INFO - Running setup.py (path:/tmp/pip-eCT1uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:24 INFO - Running setup.py (path:/tmp/pip-4kMfmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:24 INFO - Running setup.py (path:/tmp/pip-HdcjDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:24 INFO - Running setup.py (path:/tmp/pip-0MWFGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:04:25 INFO - Running setup.py install for manifestparser 16:04:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Running setup.py install for mozcrash 16:04:25 INFO - Running setup.py install for mozdebug 16:04:25 INFO - Running setup.py install for mozdevice 16:04:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Running setup.py install for mozfile 16:04:25 INFO - Running setup.py install for mozhttpd 16:04:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Running setup.py install for mozinfo 16:04:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Running setup.py install for mozInstall 16:04:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:04:25 INFO - Running setup.py install for mozleak 16:04:25 INFO - Running setup.py install for mozlog 16:04:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Running setup.py install for moznetwork 16:04:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Running setup.py install for mozprocess 16:04:26 INFO - Running setup.py install for mozprofile 16:04:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Running setup.py install for mozrunner 16:04:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Running setup.py install for mozscreenshot 16:04:26 INFO - Running setup.py install for moztest 16:04:26 INFO - Running setup.py install for mozversion 16:04:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:04:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:04:26 INFO - Cleaning up... 16:04:26 INFO - Return code: 0 16:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:26 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:26 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 16:04:26 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 16:04:26 INFO - Using env: {'DISPLAY': ':0', 16:04:26 INFO - 'HOME': '/home/cltbld', 16:04:26 INFO - 'LANG': 'en_US.UTF-8', 16:04:26 INFO - 'LANGUAGE': 'en_US:en', 16:04:26 INFO - 'LOGNAME': 'cltbld', 16:04:26 INFO - 'MAIL': '/var/mail/cltbld', 16:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:26 INFO - 'MOZ_NO_REMOTE': '1', 16:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:26 INFO - 'NO_EM_RESTART': '1', 16:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:26 INFO - 'PWD': '/builds/slave/test', 16:04:26 INFO - 'SHELL': '/bin/bash', 16:04:26 INFO - 'SHLVL': '1', 16:04:26 INFO - 'TERM': 'linux', 16:04:26 INFO - 'TMOUT': '86400', 16:04:26 INFO - 'USER': 'cltbld', 16:04:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:26 INFO - '_': '/tools/buildbot/bin/python'} 16:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:27 INFO - Running setup.py (path:/tmp/pip-siBGRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:27 INFO - Running setup.py (path:/tmp/pip-N6i0Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:27 INFO - Running setup.py (path:/tmp/pip-9cHysk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:27 INFO - Running setup.py (path:/tmp/pip-ka6meQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:27 INFO - Running setup.py (path:/tmp/pip-8u7EDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:27 INFO - Running setup.py (path:/tmp/pip-Ce8RQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:27 INFO - Running setup.py (path:/tmp/pip-596bnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:27 INFO - Running setup.py (path:/tmp/pip-VnHmiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:27 INFO - Running setup.py (path:/tmp/pip-okFiCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:27 INFO - Running setup.py (path:/tmp/pip-rF407k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:27 INFO - Running setup.py (path:/tmp/pip-asgZif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:27 INFO - Running setup.py (path:/tmp/pip-rzyXXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:27 INFO - Running setup.py (path:/tmp/pip-GcyaLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:27 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)) 16:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:27 INFO - Running setup.py (path:/tmp/pip-eSECe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:28 INFO - Running setup.py (path:/tmp/pip-dNzAE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:28 INFO - Running setup.py (path:/tmp/pip-0Y_xDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:28 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)) 16:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:28 INFO - Running setup.py (path:/tmp/pip-OOh_x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 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)) 16:04:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:28 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 16:04:30 INFO - Downloading blessings-1.6.tar.gz 16:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:30 INFO - Installing collected packages: blessings 16:04:30 INFO - Running setup.py install for blessings 16:04:30 INFO - Successfully installed blessings 16:04:30 INFO - Cleaning up... 16:04:30 INFO - Return code: 0 16:04:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:30 INFO - Reading from file tmpfile_stdout 16:04:30 INFO - Current package versions: 16:04:30 INFO - argparse == 1.2.1 16:04:30 INFO - blessings == 1.6 16:04:30 INFO - blobuploader == 1.2.4 16:04:30 INFO - docopt == 0.6.1 16:04:30 INFO - functools32 == 3.2.3-2 16:04:30 INFO - jsonschema == 2.5.1 16:04:30 INFO - manifestparser == 1.1 16:04:30 INFO - mozInstall == 1.12 16:04:30 INFO - mozcrash == 0.17 16:04:30 INFO - mozdebug == 0.1 16:04:30 INFO - mozdevice == 0.48 16:04:30 INFO - mozfile == 1.2 16:04:30 INFO - mozhttpd == 0.7 16:04:30 INFO - mozinfo == 0.9 16:04:30 INFO - mozleak == 0.1 16:04:30 INFO - mozlog == 3.2 16:04:30 INFO - moznetwork == 0.27 16:04:30 INFO - mozprocess == 0.22 16:04:30 INFO - mozprofile == 0.28 16:04:30 INFO - mozrunner == 6.11 16:04:30 INFO - mozscreenshot == 0.1 16:04:30 INFO - mozsystemmonitor == 0.3 16:04:30 INFO - moztest == 0.7 16:04:30 INFO - mozversion == 1.4 16:04:30 INFO - psutil == 3.1.1 16:04:30 INFO - requests == 1.2.3 16:04:30 INFO - wsgiref == 0.1.2 16:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:30 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 16:04:30 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 16:04:30 INFO - Using env: {'DISPLAY': ':0', 16:04:30 INFO - 'HOME': '/home/cltbld', 16:04:30 INFO - 'LANG': 'en_US.UTF-8', 16:04:30 INFO - 'LANGUAGE': 'en_US:en', 16:04:30 INFO - 'LOGNAME': 'cltbld', 16:04:30 INFO - 'MAIL': '/var/mail/cltbld', 16:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:30 INFO - 'MOZ_NO_REMOTE': '1', 16:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:30 INFO - 'NO_EM_RESTART': '1', 16:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:30 INFO - 'PWD': '/builds/slave/test', 16:04:30 INFO - 'SHELL': '/bin/bash', 16:04:30 INFO - 'SHLVL': '1', 16:04:30 INFO - 'TERM': 'linux', 16:04:30 INFO - 'TMOUT': '86400', 16:04:30 INFO - 'USER': 'cltbld', 16:04:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:30 INFO - '_': '/tools/buildbot/bin/python'} 16:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 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)) 16:04:30 INFO - Cleaning up... 16:04:30 INFO - Return code: 0 16:04:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:30 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 16:04:30 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 16:04:30 INFO - Using env: {'DISPLAY': ':0', 16:04:30 INFO - 'HOME': '/home/cltbld', 16:04:30 INFO - 'LANG': 'en_US.UTF-8', 16:04:30 INFO - 'LANGUAGE': 'en_US:en', 16:04:30 INFO - 'LOGNAME': 'cltbld', 16:04:30 INFO - 'MAIL': '/var/mail/cltbld', 16:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:30 INFO - 'MOZ_NO_REMOTE': '1', 16:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:30 INFO - 'NO_EM_RESTART': '1', 16:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:30 INFO - 'PWD': '/builds/slave/test', 16:04:30 INFO - 'SHELL': '/bin/bash', 16:04:30 INFO - 'SHLVL': '1', 16:04:30 INFO - 'TERM': 'linux', 16:04:30 INFO - 'TMOUT': '86400', 16:04:30 INFO - 'USER': 'cltbld', 16:04:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:30 INFO - '_': '/tools/buildbot/bin/python'} 16:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:04:31 INFO - Cleaning up... 16:04:31 INFO - Return code: 0 16:04:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:04:31 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')]} 16:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:31 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')]} 16:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:31 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 0x7f5ecb9abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', '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 16:04:31 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 16:04:31 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 16:04:31 INFO - Using env: {'DISPLAY': ':0', 16:04:31 INFO - 'HOME': '/home/cltbld', 16:04:31 INFO - 'LANG': 'en_US.UTF-8', 16:04:31 INFO - 'LANGUAGE': 'en_US:en', 16:04:31 INFO - 'LOGNAME': 'cltbld', 16:04:31 INFO - 'MAIL': '/var/mail/cltbld', 16:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:31 INFO - 'MOZ_NO_REMOTE': '1', 16:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:31 INFO - 'NO_EM_RESTART': '1', 16:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:31 INFO - 'PWD': '/builds/slave/test', 16:04:31 INFO - 'SHELL': '/bin/bash', 16:04:31 INFO - 'SHLVL': '1', 16:04:31 INFO - 'TERM': 'linux', 16:04:31 INFO - 'TMOUT': '86400', 16:04:31 INFO - 'USER': 'cltbld', 16:04:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:31 INFO - '_': '/tools/buildbot/bin/python'} 16:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:31 INFO - Downloading/unpacking flake8 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:31 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 16:04:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:04:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:04:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 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 16:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:33 INFO - no previously-included directories found matching 'docs/_build' 16:04:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:04:33 INFO - Running setup.py install for pep8 16:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:04:34 INFO - no previously-included directories found matching 'docs/_build' 16:04:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:04:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:04:34 INFO - Cleaning up... 16:04:34 INFO - Return code: 0 16:04:34 INFO - Running post-action listener: _resource_record_post_action 16:04:34 INFO - Running post-action listener: _start_resource_monitoring 16:04:34 INFO - Starting resource monitoring. 16:04:34 INFO - ##### 16:04:34 INFO - ##### Finished create-virtualenv step (success) 16:04:34 INFO - ##### 16:04:34 INFO - ##### 16:04:34 INFO - ##### Running install step. 16:04:34 INFO - ##### 16:04:34 INFO - Running pre-action listener: _resource_record_pre_action 16:04:34 INFO - Running main action method: install 16:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:34 INFO - Reading from file tmpfile_stdout 16:04:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:04:34 INFO - Reading from file tmpfile_stdout 16:04:34 INFO - Output received: 16:04:34 INFO - Usage: mozinstall [options] installer 16:04:34 INFO - Options: 16:04:34 INFO - -h, --help show this help message and exit 16:04:34 INFO - -d DEST, --destination=DEST 16:04:34 INFO - Directory to install application into. [default: 16:04:34 INFO - "/builds/slave/test"] 16:04:34 INFO - --app=APP Application being installed. [default: firefox] 16:04:34 INFO - mkdir: /builds/slave/test/build/application 16:04:34 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'] 16:04:34 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 16:04:51 INFO - Reading from file tmpfile_stdout 16:04:51 INFO - Output received: 16:04:51 INFO - /builds/slave/test/build/application/firefox/firefox 16:04:51 INFO - Running post-action listener: _resource_record_post_action 16:04:51 INFO - ##### 16:04:51 INFO - ##### Finished install step (success) 16:04:51 INFO - ##### 16:04:51 INFO - ##### 16:04:51 INFO - ##### Running run-tests step. 16:04:51 INFO - ##### 16:04:51 INFO - Running pre-action listener: _resource_record_pre_action 16:04:51 INFO - Running main action method: run_tests 16:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:04:51 INFO - Python 2.7.3 16:04:51 INFO - Return code: 0 16:04:51 INFO - grabbing minidump binary from tooltool 16:04: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')]} 16:04:51 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 0x11796f0>, '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 0x117a5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117aaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:04:51 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 16:04:51 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 16:04:51 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 16:04:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:51 INFO - Return code: 0 16:04:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:04:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:04:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:04:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:04:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:04:52 INFO - Return code: 0 16:04:52 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/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 16:04:52 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/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 16:04:52 INFO - Using env: {'DISPLAY': ':0', 16:04:52 INFO - 'HOME': '/home/cltbld', 16:04:52 INFO - 'LANG': 'en_US.UTF-8', 16:04:52 INFO - 'LANGUAGE': 'en_US:en', 16:04:52 INFO - 'LOGNAME': 'cltbld', 16:04:52 INFO - 'MAIL': '/var/mail/cltbld', 16:04:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:04:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:52 INFO - 'MOZ_NO_REMOTE': '1', 16:04:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:52 INFO - 'NO_EM_RESTART': '1', 16:04:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:52 INFO - 'PWD': '/builds/slave/test', 16:04:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:04:52 INFO - 'SHELL': '/bin/bash', 16:04:52 INFO - 'SHLVL': '1', 16:04:52 INFO - 'TERM': 'linux', 16:04:52 INFO - 'TMOUT': '86400', 16:04:52 INFO - 'USER': 'cltbld', 16:04:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144', 16:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:52 INFO - '_': '/tools/buildbot/bin/python'} 16:04:52 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/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 16:04:52 INFO - mozversion application_buildid: 20160626133106 16:04:52 INFO - mozversion application_changeset: 4e6dd91cd5823834a7da0394367609a1640dfb11 16:04:52 INFO - mozversion application_display_name: Nightly 16:04:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:52 INFO - mozversion application_name: Firefox 16:04:52 INFO - mozversion application_remotingname: firefox 16:04:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:04:52 INFO - mozversion application_vendor: Mozilla 16:04:52 INFO - mozversion application_version: 50.0a1 16:04:52 INFO - mozversion platform_buildid: 20160626133106 16:04:52 INFO - mozversion platform_changeset: 4e6dd91cd5823834a7da0394367609a1640dfb11 16:04:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:04:52 INFO - mozversion platform_version: 50.0a1 16:04:52 INFO - using testdate: 1466982292 16:04:52 INFO - actual date: 1466982292 16:04:52 INFO - starting webserver on 'localhost:41144' 16:04:52 INFO - SUITE-START | Running 2 tests 16:04:52 INFO - TEST-START | dromaeo_css 16:04:52 INFO - operating with platform_type : linux_ 16:04:52 INFO - Initialising browser for dromaeo_css test... 16:04:52 INFO - TEST-INFO | started process 3147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaa6vBt/profile http://localhost:41144/getInfo.html) 16:04:57 INFO - PROCESS | 3147 | __metrics Screen width/height:1600/1200 16:04:57 INFO - PROCESS | 3147 | colorDepth:24 16:04:57 INFO - PROCESS | 3147 | Browser inner width/height: 1024/697 16:04:57 INFO - PROCESS | 3147 | __metrics 16:04:58 ERROR - PROCESS | 3147 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:04:59 INFO - TEST-INFO | 3147: exit 0 16:04:59 INFO - Browser initialized. 16:04:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:59 INFO - TEST-INFO | started process 3268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaa6vBt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:11 INFO - PROCESS | 3268 | RSS: Main: 185540608 16:05:11 INFO - PROCESS | 3268 | 16:06:00 INFO - PROCESS | 3268 | 1466982360952 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] 16:08:09 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41144/tests/dromaeo/cssquery-ext.html) 16:08:10 INFO - PROCESS | 3268 | RSS: Main: 188600320 16:08:10 INFO - PROCESS | 3268 | 16:11:12 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-ext.html (next: http://localhost:41144/tests/dromaeo/cssquery-jquery.html) 16:11:13 INFO - PROCESS | 3268 | RSS: Main: 187641856 16:11:13 INFO - PROCESS | 3268 | 16:14:14 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41144/tests/dromaeo/cssquery-mootools.html) 16:14:15 INFO - PROCESS | 3268 | RSS: Main: 189140992 16:14:15 INFO - PROCESS | 3268 | 16:17:17 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41144/tests/dromaeo/cssquery-prototype.html) 16:17:17 INFO - PROCESS | 3268 | RSS: Main: 186945536 16:17:17 INFO - PROCESS | 3268 | 16:20:20 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41144/tests/dromaeo/cssquery-yui.html) 16:20:21 INFO - PROCESS | 3268 | RSS: Main: 188710912 16:20:21 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | Cycle 1(1): loaded http://localhost:41144/tests/dromaeo/cssquery-yui.html (next: http://localhost:41144/tests/dromaeo/cssquery-dojo.html) 16:23:23 INFO - PROCESS | 3268 | RSS: Main: 189620224 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | __start_tp_report 16:23:23 INFO - PROCESS | 3268 | _x_x_mozilla_page_load 16:23:23 INFO - PROCESS | 3268 | _x_x_mozilla_page_load_details 16:23:23 INFO - PROCESS | 3268 | |i|pagename|runs| 16:23:23 INFO - PROCESS | 3268 | |0;dojo.html;3139.905802825915;3186.2512309607255;3188.011716367926;3204.9198770030753;3208.6470488246273;5559.027170245211;5562.833115006551;5605.215269862218;5620.606557540974;5625.099984002561;5463.590230732691;5563.833085007446;5575.442455754423;5592.86017849554;5643.6049476536655;5000.624953128521;5039.244113383003;5137.152369858969;5181.6113791465605;5241.082810508165;768.2024480814193;4960.727160006199;5046.21783623539;5120.743962801864;5134.589232861362;5071.061853557104;5075.061113693979;5089.312942752718;5100.183970564729;5106.387233531981;5121.8463446096675;5125.923111153335;5138.768755406016;5148.510891465305;5158.690478571298;4935.950640493585;4960.107180707471;4984.401871775374;4997.275395067732;4999.225120106389;5507.008738427082;5510.980468613279;5520.592248976485;5523.171524271352;5524.419935906712;5829.737661805187;5890.587658863881;5953;5953.523718102541;5996.400359964013;5912.408759124096;5940.168376427304;5952.880942381128;6014.96992515039;6017.308009578911;5588.413216612278;5589;5590.91613625796;5593.52455041322;5619.578531610146;5913.793017244376;6044.607100538451;6149.84625384369;6156.569040167145;6160.568760186834;5846.4153584642045;5913.526917846562;5915.556333275022;5934.732937017845;5959.106134079836;5973.074173503114;5989.341172471025;6002.819915402545;6004.159417681528;6020.668863212565;5790.189373487715;5837.0368889132815;5843.328017277982;5906.202662640489;5971.581989260797;5880.941190588125;5909.054551271776;5922.141289512996;5938.257717785277;5962.1056841473255;4491.326301054803;4495.730256184574;4508.256137737302;4521.502634710179;4556.612687921497;3966.186931678999;3996.140829721624;4029.91940161201;4034.6973976951845;4076.3274059780397;5497.725113744297;5577.44225577439;5617.101263797773;5619.129034999582;5675.886482270332;5939.346671866091;5944.227250457413;6010.429009244115;6033.849153771191;6049.78825741097;5577.498025177753;5653.462921022497;5736.627119237236;5738.856528586819;5750.281214848144;5119.129747942859;5174.534291913746;5186.92219616706;5199.142141546678;5234.2933703949475;6223.471004964538;6248.094026366151;6250.156228909039;6274.6548939808745;6276.968615156987;5771;5993.190919225849;6040.516758659209;6047.425494578096;6068.544859135494;6299.30707622152;6311.147995020613;6319.842003949938;6322.589031713108;6332.778352757631;5933.554983376178;5939.524838013035;5955.642661440327;5964.105384192406;6011.008183649649;5838.211841401357;5916;5940.46535811779;5982.341942386421;6100.786472473442;5843.415658434123;5878.735456904364;5879.412058794086;5884.176215329943;5921.023031199804;5841.474267315792;5859.707014649336;5879.73541190656;5882.1470886722045;5883.911741323969;5537.861553461195;5653.830385088454;5754.51086657622;5758.452946970031;5831.854203644773;5931.169636250842;5943.64338139713;5953.374895636069;5955.166276721176;5964.970175149097;5634.774609015757;5794.246747922743;5840.561957853093;5853.560982926212;5855.2973643163095 16:23:23 INFO - PROCESS | 3268 | |1;ext.html;575.709266820256;614.9815505534834;627.3600927054405;635.6630985577642;645.1935081148564;39950.60049399505;43970;44258.557414425886;44342.33486497705;44485.77757111214;43601.563984360146;44357.556424435745;44452.555474445246;44461.7776911115;44507;8799.560021998906;8957.149070838292;8990.68532601359;8996.145366190201;8998;8833.823323533525;8917.108289171096;8939.687110951118;8942.150495702897;8949.686760963368;8865.157810008039;8874.20132188103;8912.777180570472;8919.821603567925;8992.05583413742;8833.73498795034;8915.108489151065;8930.642774289021;8954.820903581893;8954.910450895473;8873.201411872898;8938.86591701125;8955.55222238892;8992.46045237288;8992.55037248135;36054.63945360539;36255.81872090622;36377.09057273563;36396.818015910016;36468.817655911815;3050.572919791231;3351.413502637053;3358.3619112368574;3535.1515636247373;3657.652523010336;30177.547336789965;30333.848330758206;33325.83337083299;34167.48748768771;35360.29279414397;4033.979830100831;4203.956489547256;4293.205756934945;4445.8221671133115;4537.954620453786;356978;360424.7915041685;361238;363103;363238.1838090819;63170;63389;63606.363936360045;63772.36227637664;63868.36131638717;35858.10354741153;36826.8158659205;36989.07527311785;66009.33990660128;66363;17636.559086022953;17774.46676599704;17788.55528611769;17840.55398615019;17884;12820;12899.097063205672;12902.225866448043;12907.677308067186;12961.185434039242;19620.3132890351;19926.800731992495;19947.501312467306;20106.497337566387;20142;7420.332170104609;7455.291747284108;7496.6251687415415;7630.656620452093;7706.262462705583;895.5298468304062;990.7919336939324;1123.2979387882574;1158;1160.988390116105;32271.51592726111;32659;32808;33014.3397132056;33338.3332333352;1105.784372047459;1112.3937454087543;1120.7086157599083;1123.2530367305812;1155.9479823407967;17151;17249.56876078108;17340.30638774435;17342.935534976295;17676.11619419024;540990;545725;551843;551940;552610;60786;61281.69359153176;61333;61486.38513614806;61496.38503614996;1307.8822905938512;1363.7136201397818;1373.979390309146;1378.8621137886332;1389.1387339849357;31045.223869403446;31918.68081319157;32200.838995804872;32379.19052023624;32984.83507582447;52891;52986.73506632442;53435.46564534305;53598.73200634128;53679.73160134331;445474;449137;449787;450160;450387;28675.856620716764;29194.270143246587;29418.558721618763;29620.851895740383;29776.10671679853;49464.752676236385;49957.50042499674;50077.24884126668;50126.74936625294;50647.49352506428;42753.144937100464;43278.56721432746;43430.34854477122;44415.77792111019;44452.11095778131;42428.787856060524;42955.78522107495;42959;43151;43819;41194;41930.580694192664;42129.157416852104;42615.14769704651;42687.14625707531;36460.635393646786;38409.807950961185;38676.80661596674;38722.2255554893;38819;27873.303167420978;28355.43289134247;28868.855655721585;30184.09447716572;30303.242418939702 16:23:23 INFO - PROCESS | 3268 | |2;jquery.html;384.1510262320273;394.5935686243171;398.8105649816337;402.82074476857775;416.33386581469654;14029.719405611882;18268.451946441593;18977.051147442642;19814.207431702733;19852.50368740782;18446.35437759679;18560;19079.14143863526;19123.42629721107;19135.33026344078;5690.99999999999;5775.942240577603;5868.09044598088;5882.058870580687;5883.8529036774;5758.99217636914;5777.45114214149;5800.042992906166;6512.185976752906;6894.276101009397;6876.071730316393;6892.207396149432;6954.165500139965;6960.060391847086;7074;6929.861402771941;6986.510944233905;7028.086348774677;7084;7096.503244772894;7081.822954426129;7132.5007249492555;7154.534955227893;7183.784486465414;7195.424366050704;23944.521109577887;24710.876445617658;25718.357041074123;25747.97008119673;25846.612300815505;2966.59950906627;3201.135693362779;3260.7228385587255;3262.934741305184;3372.15696075981;15129.546113616609;15400.46098386551;15482.219544752385;15796.526104216891;16045.91977040119;2055.290924631;2060.5157787919825;2079.6984437256515;2102.138123369411;2125.7767934366825;92740;94838;97045.5147724264;97985.51007244918;98152;17112.74330885038;17341.7398739019;17418.65162696739;17688.142745011588;17896.373626922996;31229.219269518442;31487.685123148476;31756.682433175836;31840;31874;9792.314537982273;10130.898691013143;10267.589296428208;10387.94806025965;10434.530446129942;8711.956440217758;8768.123187681309;8853.114688531225;8860.911390886009;9122.726318210463;8949.865752013726;8952.910470895207;9047.547622618842;9061.68284110066;9359.672411465566;3551.485034669958;3581.585273816828;3599.2441587266967;3603.1172362770762;3661.8901432957055;891.3092353426017;936.7704912296531;997.875265591801;1044.806710758512;1085.1264731890747;17734.733978990327;18097.638047238983;18760.437186884414;19039.143238554298;19272.903635481733;978.7161723100363;997.3367710472454;1012.964546240878;1055.904968552834;1068.9465526723632;9846.803063938682;10900.781984360268;10914;10938.343699378063;10995.505202265756;473059;474814;475504;497132;500189;59709.402905971256;84053.15946840453;95405;97577;98407;1022.5500779656927;1035.1925498111484;1044.1072882685346;1044.5143008501084;1049.1292227451197;16764.32942682279;17167.141642918054;17411.47765567035;17425.651486970444;17494.9125254378;40118.39822402608;40339.798301008304;43554;43702.56297437112;44571.55428445674;54022.18966715581;54174.18738718844;56685;60219;60531.394686052576;8671.826563468821;8732.78168045804;8754.47473151613;8881.600327985385;8906.777330566787;9770.658026969022;13243.470261189444;13547.932260338635;13744.244066576433;13915.791263131263;12067.396630168281;12068.75862482763;12314.199577027464;12357.691057723629;12380.133390662568;11213.102951764002;11322.60370887048;12277.815832762695;12289.955353795027;12705.491780328683;11586.188966772244;12354.196977196454;12502;12533.122681412578;12644.557440489538;8177;8236.752897413087;8401.53791541471;8450.915490845013;8829.293656507592;8648.264897483532;11312.773744524899;12049.939750301193;12114.818277726017;12391.442385092512 16:23:23 INFO - PROCESS | 3268 | |3;mootools.html;1449.9855001449985;1463.9898470055662;1581.312129223787;1695.398133662549;1708.9230984605692;8227.17728227177;8902.065283145266;9053.637854485813;9522.571484283206;9530.380525265862;8943.910560894388;9118.08819118088;9270.907290927105;9302.395344302615;9311.72064838056;2287.5653625811124;2306.984926632285;2322.7328857181387;2325.3140323604575;2335.1009861203474;2296.8851557422145;2321.3848330192427;2346.4016675747744;2348.659444380564;2355.9646605300936;2253.445122865226;2277.2257432472957;2289.244549298736;2329.452578644017;2341.94145146371;2239.6640503924377;2273.81809455244;2293.8967746451367;2294.1855641247284;2300.804431623314;2248.8425810193294;2254.458929856839;2264.79616834484;2272.602294598455;2280.2019293247395;9249.768755781159;9313.720588382359;9317.835270591177;9324.813503729954;9337.953310233474;5385.7576409061685;5459.508644222039;5465.426130256305;5497.945020549823;5531.474509921551;3297.422950983568;3517.3317069756663;3564.946525802115;3643.453481977698;3659.1583935694675;1103.167108832826;1111.8999290063932;2192.6601376786625;2236.798688118061;2278.8290878184202;12634.936825315815;12639.49442022318;12778.616641500677;12794;12804.167729097579;4582.770861456914;4598.195315819718;4681.391419115561;4709.340692303081;4710.458297295855;9910.306278560576;9911.207103431709;9918.900810991941;9927.453990030617;9941.155001824782;5337.146056630921;5354.41101478837;5368.194770784414;5381.704006279614;5386.084365657847;4327.978360108179;4934.1118598651865;4972.676776009548;5045.84862454127;5063.569596584258;3692.51997240357;3769.4345848123003;3816.2749077675153;3851.1527463957887;3866.4393662919283;1115.8214685650257;1150.0339714639742;1154.492023509653;1157.0916830288184;1166.1487114406532;1012.2256473797551;1025.9640912568025;1033.5452400943561;1056.9048785609332;1063.3088492479794;6328.588641738273;6476.417122459001;6537.411632952962;6557.573757705829;6589.53873228879;423.9067405170857;428.37029566537143;430.66193038464655;430.79106633282834;442.23714093188994;4289.6139347458875;4300.634446072057;4307.418498502725;4330;4347.413099231627;11356.829647555292;11562.364069976064;11642.88357116418;11644;11689.357085360387;11589.362585057734;11622.709432264091;11629.24409913353;11635.825462618068;11641.767164656829;8008;8328.250457458858;8337.458065225741;8522.232999030117;8682.739517814349;6270.4670103039925;6488.8362770014965;6509.8698026040165;6560.540762146604;6567.080608714879;10820.18848586375;10881.727956801144;10963.506642201279;10993.725156871142;11077;10832.18758593093;11052.613158539412;11140.220184587;11167.720806979565;11170.553177872795;7408;7909.209079092045;8162.265396114378;8280.875786863322;8456.577171141542;9145;9249.768755781159;9267.351285409957;9350.158485736316;9358.81282374335;7995.880061799194;8191.754247372588;8245.79385515343;8313.376496762889;8344.916550834656;7906.367490600623;7925.0886148093705;7990.560519171268;8026.799330016796;8048.315893148913;7163.31948464895;7385.667644956097;7409.777706668809;7436.553806771611;7565.735199268;5588.832335029955;5615.915761263666;5629.549636029026;5739.311282646109;5739.971300143473;5525.4474552544425;5532.557395408438;5660.943390566042;5687.146927960839;5734.197212390352 16:23:23 INFO - PROCESS | 3268 | |4;prototype.html;322.83858070964516;331.65839185638794;332.966703329667;335.5386343777306;336.12942478979437;5650.74571644276;5717.971410142954;5736.45503677151;5759.942400575993;5763.991301522233;5570.220169176318;5606.187102870082;5609.158626206071;5613.186088017235;5662.546996240301;4156.563560826107;4283.329501494404;4367.956320436787;4376;4404.933925991097;4364.148990946766;4366.781660916958;4377.4528183977;4380.102079073782;4403.427554417921;4342.348647702854;4343.4580723843055;4369.1480161368545;4379.189849877767;4394.956050439487;4278.4010238566625;4319.33050377192;4363.759993200404;4371.606555410029;4371.693981421302;3776.754510956779;3798;3816.599257078022;3824.598417166213;3833.8658146965;5481.972590137024;5488.271194573696;5515.503604675559;5524.558035357162;5561.944380556223;4762.523747625244;4941.431735350445;4970.602351811846;4971.328870602459;5072.594192464631;5779.410662067923;5812.9709351452975;5962.105684147369;6001.879962400728;6006.279246490449;4193.916121677549;4205.915881682349;4241.766702831343;4244.893877653052;4249.830006799724;6087.54343424245;6136.140940268366;6153.753849846001;6173.2900716417735;6190.5452218729015;4314.50383205929;4315.964168599514;4325.329573916048;4348.673849461303;4354.608085272341;4416.470023597189;4427.6236519896165;4432.958254810182;4438.467383913951;4440;4941.802327906916;5026.4973502649445;5037.219231019198;5043.52086551777;5050.520200580939;5834.504067154339;5886.646801191942;5947.375525569752;6002.4897883679505;6040.305364883095;1474.7198032374029;1496.453794365049;1518.187769543311;1527.4119464006214;1529.785829983803;974.8099120671543;986.1519093579516;1000.4547521600745;1015.8120747661707;1025.2105878473683;5721.199032135504;5740.311162660508;5752.654840709487;5787.855303617359;5790.699301398163;6026.608270462406;6027.517798576104;6070;6079.574429789961;6080.695965201722;5636.97181514098;5657.4059723728415;5680.375158732536;5739.8565035874435;5803.564732645069;3206.727428168585;3235.854386552611;3247.2531317796565;3262.2986057997646;3265.5428240046413;6149.66176860268;6266.561340706106;6279.654618995999;6297.685115744194;6301.180846489927;6216.471599913967;6236.875262494725;6242.344553821783;6254.8123556293385;6269.7178626961895;5975.19334889793;6277.811665649946;6288.019273928698;6331.240251169889;6333.651649159248;6027.914975304488;6048.788292409745;6091.878162436815;6122.785702500391;6166.630002199882;6078.817635470943;6133.3866613338305;6139.723712432862;6147.72335244924;6150.630962142286;6108.839320529085;6368.172137622265;6414.967925160345;6426.164598602152;6426.871462570816;4348.478182618106;4351.325544540601;4360.454943132108;4372.1692878353015;4389.736615803062;6005.939940600538;6093.847653808691;6245.7189426476825;6256.280527739368;6295.370462953668;5956.880862382642;5982.222311099529;5997.5501837363245;6012.278526576839;6064.181335519825;5990.311114221746;6017.729202185825;6017.939820601738;6057.666828324484;6061.939380606137;5565.276514053147;5760.94239057604;5872.442117998783;5911.320198177093;5949;5949.434803693643;5990.191324171181;6007.729652165751;6034.366391528826;6049.727762250797;5677.659340439587;5890.617109887844;5899.970500147643;5919.934411805744;5949.464548190684 16:23:23 INFO - PROCESS | 3268 | |5;yui.html;714.2107970692384;721.982223546353;741.907261592301;832.5920299053463;858.7767180533061;12875;14513.20177390243;14946.327415266313;14984.850151498482;15051.849481505182;13075.084744067895;13720.176789392643;13760.93119534401;13769.105008174487;13808.378622961965;801.2588355770903;807.6244546285976;807.9577345224653;810.1452967119686;811.8011087283594;796.2555011064644;802.8153524689325;804.3685706720225;804.8752443371258;805.8871757953891;827.896512935883;833.6123702478346;833.9207775261341;836.1137194573771;839.0560619303284;809.1059379385812;831.7546323834453;831.9251267385933;837.1795640272567;837.9790505237387;599.4544964082708;599.6522017230039;603.2971588099858;604.2205554834259;605.1739375752111;15956.122413267265;15993.360265589363;16029.038257704575;16073.758893616605;16100;14930.925345373204;15080.849191508054;15110.773338399822;15190.316435760416;15482.690346193012;12713.17364371313;12733.74532509354;13031.609051728463;13089.345532723326;13637;3729.515163028816;3822.8853134406013;4025.9798701006603;4098.6516146127615;4105.322621767405;57565.42434575642;80035;80162.59918700428;80499;80778;11399.886001140048;11764.352960587079;12027.939860300643;12128.939355303168;12358.62924112278;21233.36299911005;21358.893205533874;21500.247491337726;21595.67606485904;21618.45953851135;8880.822383552293;8925.464472131564;8954.552272386354;9163.58763855628;9220;4768.451628062748;4870.464248932614;4919.704817710949;4961.355023846877;4972.627052971042;3543.875964341236;3660.7254455915913;3660.9450858237146;3662.1760103976394;3756.3050835595504;685;690.5304393012799;703.409136325489;704.8590281943632;710.9146902371748;685.5646664368062;705.4004096518021;728.7886512911302;736.1791602363327;773.9496932699469;9972.301938864355;10221;10312.535935882903;10414.375137491776;10416.375017498975;605.3492495567283;633.8003528888386;670.7015378156674;703.7466512055656;718.741253148866;5008;5173.5602473789395;5235.110031294613;5242.18746094356;5252.921206181911;114003.42998284956;128292;128464;130128;131595;85801.57099214589;108949.45525272323;111274;111698;112055;79615.20384796194;81263.18736812557;88029.55985220161;88327.55836220778;90046.39814407482;9893.851592225978;10054.849177262493;10126;10159.695209143738;10269.383836969806;43038.56961430346;48595.525266554905;49546.25680614721;50430.49569504405;51824.48175518347;76670.6166469164;77533.2246677526;79224.60387698255;79889.60055199687;80457;13376;13476.663083422993;13544.458221671417;13661.18032918028;13781.448742050607;14932.178730169511;14974.176420296988;15775.369104783935;16096.712263019164;16671.916640417207;14431.85568144347;14469.710605788036;14538.781918271447;14685.632859178606;15514.9224253878;14260.786088208477;14456.638584035483;14853.183074930983;14934.626634334229;15331.463398780988;14291.356888939814;14477.565673029825;14741.11553306805;15450.84549154539;15488.767668485207;11544.422778861192;11736.354500502553;11994.76010479803;12263.264204147423;12858.485660573846;11622.825657614974;12016.879831201577;12252.693682658004;12446.502139914302;12684.492620295085 16:23:23 INFO - PROCESS | 3268 | __end_tp_report 16:23:23 INFO - PROCESS | 3268 | __start_cc_report 16:23:23 INFO - PROCESS | 3268 | _x_x_mozilla_cycle_collect,356 16:23:23 INFO - PROCESS | 3268 | __end_cc_report 16:23:23 INFO - PROCESS | 3268 | __startTimestamp1466983403878__endTimestamp 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | ------- Summary: start ------- 16:23:23 INFO - PROCESS | 3268 | Number of tests: 6 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#0] dojo.html Cycles:165 Average:5525.74 Median:5829.74 stddev:747.57 (12.8%) stddev-sans-first:726.05 16:23:23 INFO - PROCESS | 3268 | Values: 3139.9 3186.3 3188.0 3204.9 3208.6 5559.0 5562.8 5605.2 5620.6 5625.1 5463.6 5563.8 5575.4 5592.9 5643.6 5000.6 5039.2 5137.2 5181.6 5241.1 768.2 4960.7 5046.2 5120.7 5134.6 5071.1 5075.1 5089.3 5100.2 5106.4 5121.8 5125.9 5138.8 5148.5 5158.7 4936.0 4960.1 4984.4 4997.3 4999.2 5507.0 5511.0 5520.6 5523.2 5524.4 5829.7 5890.6 5953.0 5953.5 5996.4 5912.4 5940.2 5952.9 6015.0 6017.3 5588.4 5589.0 5590.9 5593.5 5619.6 5913.8 6044.6 6149.8 6156.6 6160.6 5846.4 5913.5 5915.6 5934.7 5959.1 5973.1 5989.3 6002.8 6004.2 6020.7 5790.2 5837.0 5843.3 5906.2 5971.6 5880.9 5909.1 5922.1 5938.3 5962.1 4491.3 4495.7 4508.3 4521.5 4556.6 3966.2 3996.1 4029.9 4034.7 4076.3 5497.7 5577.4 5617.1 5619.1 5675.9 5939.3 5944.2 6010.4 6033.8 6049.8 5577.5 5653.5 5736.6 5738.9 5750.3 5119.1 5174.5 5186.9 5199.1 5234.3 6223.5 6248.1 6250.2 6274.7 6277.0 5771.0 5993.2 6040.5 6047.4 6068.5 6299.3 6311.1 6319.8 6322.6 6332.8 5933.6 5939.5 5955.6 5964.1 6011.0 5838.2 5916.0 5940.5 5982.3 6100.8 5843.4 5878.7 5879.4 5884.2 5921.0 5841.5 5859.7 5879.7 5882.1 5883.9 5537.9 5653.8 5754.5 5758.5 5831.9 5931.2 5943.6 5953.4 5955.2 5965.0 5634.8 5794.2 5840.6 5853.6 5855.3 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#1] ext.html Cycles:180 Average:61510.02 Median:23523.18 stddev:121804.54 (517.8%) stddev-sans-first:122060.31 16:23:23 INFO - PROCESS | 3268 | Values: 575.7 615.0 627.4 635.7 645.2 39950.6 43970.0 44258.6 44342.3 44485.8 43601.6 44357.6 44452.6 44461.8 44507.0 8799.6 8957.1 8990.7 8996.1 8998.0 8833.8 8917.1 8939.7 8942.2 8949.7 8865.2 8874.2 8912.8 8919.8 8992.1 8833.7 8915.1 8930.6 8954.8 8954.9 8873.2 8938.9 8955.6 8992.5 8992.6 36054.6 36255.8 36377.1 36396.8 36468.8 3050.6 3351.4 3358.4 3535.2 3657.7 30177.5 30333.8 33325.8 34167.5 35360.3 4034.0 4204.0 4293.2 4445.8 4538.0 356978.0 360424.8 361238.0 363103.0 363238.2 63170.0 63389.0 63606.4 63772.4 63868.4 35858.1 36826.8 36989.1 66009.3 66363.0 17636.6 17774.5 17788.6 17840.6 17884.0 12820.0 12899.1 12902.2 12907.7 12961.2 19620.3 19926.8 19947.5 20106.5 20142.0 7420.3 7455.3 7496.6 7630.7 7706.3 895.5 990.8 1123.3 1158.0 1161.0 32271.5 32659.0 32808.0 33014.3 33338.3 1105.8 1112.4 1120.7 1123.3 1155.9 17151.0 17249.6 17340.3 17342.9 17676.1 540990.0 545725.0 551843.0 551940.0 552610.0 60786.0 61281.7 61333.0 61486.4 61496.4 1307.9 1363.7 1374.0 1378.9 1389.1 31045.2 31918.7 32200.8 32379.2 32984.8 52891.0 52986.7 53435.5 53598.7 53679.7 445474.0 449137.0 449787.0 450160.0 450387.0 28675.9 29194.3 29418.6 29620.9 29776.1 49464.8 49957.5 50077.2 50126.7 50647.5 42753.1 43278.6 43430.3 44415.8 44452.1 42428.8 42955.8 42959.0 43151.0 43819.0 41194.0 41930.6 42129.2 42615.1 42687.1 36460.6 38409.8 38676.8 38722.2 38819.0 27873.3 28355.4 28868.9 30184.1 30303.2 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#2] jquery.html Cycles:180 Average:30329.82 Median:3461.82 stddev:79904.53 (2308.2%) stddev-sans-first:80097.05 16:23:23 INFO - PROCESS | 3268 | Values: 384.2 394.6 398.8 402.8 416.3 14029.7 18268.5 18977.1 19814.2 19852.5 18446.4 18560.0 19079.1 19123.4 19135.3 5691.0 5775.9 5868.1 5882.1 5883.9 5759.0 5777.5 5800.0 6512.2 6894.3 6876.1 6892.2 6954.2 6960.1 7074.0 6929.9 6986.5 7028.1 7084.0 7096.5 7081.8 7132.5 7154.5 7183.8 7195.4 23944.5 24710.9 25718.4 25748.0 25846.6 2966.6 3201.1 3260.7 3262.9 3372.2 15129.5 15400.5 15482.2 15796.5 16045.9 2055.3 2060.5 2079.7 2102.1 2125.8 92740.0 94838.0 97045.5 97985.5 98152.0 17112.7 17341.7 17418.7 17688.1 17896.4 31229.2 31487.7 31756.7 31840.0 31874.0 9792.3 10130.9 10267.6 10387.9 10434.5 8712.0 8768.1 8853.1 8860.9 9122.7 8949.9 8952.9 9047.5 9061.7 9359.7 3551.5 3581.6 3599.2 3603.1 3661.9 891.3 936.8 997.9 1044.8 1085.1 17734.7 18097.6 18760.4 19039.1 19272.9 978.7 997.3 1013.0 1055.9 1068.9 9846.8 10900.8 10914.0 10938.3 10995.5 473059.0 474814.0 475504.0 497132.0 500189.0 59709.4 84053.2 95405.0 97577.0 98407.0 1022.6 1035.2 1044.1 1044.5 1049.1 16764.3 17167.1 17411.5 17425.7 17494.9 40118.4 40339.8 43554.0 43702.6 44571.6 54022.2 54174.2 56685.0 60219.0 60531.4 8671.8 8732.8 8754.5 8881.6 8906.8 9770.7 13243.5 13547.9 13744.2 13915.8 12067.4 12068.8 12314.2 12357.7 12380.1 11213.1 11322.6 12277.8 12290.0 12705.5 11586.2 12354.2 12502.0 12533.1 12644.6 8177.0 8236.8 8401.5 8450.9 8829.3 8648.3 11312.8 12049.9 12114.8 12391.4 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#3] mootools.html Cycles:180 Average:6068.23 Median:2512.50 stddev:3503.39 (139.4%) stddev-sans-first:3496.03 16:23:23 INFO - PROCESS | 3268 | Values: 1450.0 1464.0 1581.3 1695.4 1708.9 8227.2 8902.1 9053.6 9522.6 9530.4 8943.9 9118.1 9270.9 9302.4 9311.7 2287.6 2307.0 2322.7 2325.3 2335.1 2296.9 2321.4 2346.4 2348.7 2356.0 2253.4 2277.2 2289.2 2329.5 2341.9 2239.7 2273.8 2293.9 2294.2 2300.8 2248.8 2254.5 2264.8 2272.6 2280.2 9249.8 9313.7 9317.8 9324.8 9338.0 5385.8 5459.5 5465.4 5497.9 5531.5 3297.4 3517.3 3564.9 3643.5 3659.2 1103.2 1111.9 2192.7 2236.8 2278.8 12634.9 12639.5 12778.6 12794.0 12804.2 4582.8 4598.2 4681.4 4709.3 4710.5 9910.3 9911.2 9918.9 9927.5 9941.2 5337.1 5354.4 5368.2 5381.7 5386.1 4328.0 4934.1 4972.7 5045.8 5063.6 3692.5 3769.4 3816.3 3851.2 3866.4 1115.8 1150.0 1154.5 1157.1 1166.1 1012.2 1026.0 1033.5 1056.9 1063.3 6328.6 6476.4 6537.4 6557.6 6589.5 423.9 428.4 430.7 430.8 442.2 4289.6 4300.6 4307.4 4330.0 4347.4 11356.8 11562.4 11642.9 11644.0 11689.4 11589.4 11622.7 11629.2 11635.8 11641.8 8008.0 8328.3 8337.5 8522.2 8682.7 6270.5 6488.8 6509.9 6560.5 6567.1 10820.2 10881.7 10963.5 10993.7 11077.0 10832.2 11052.6 11140.2 11167.7 11170.6 7408.0 7909.2 8162.3 8280.9 8456.6 9145.0 9249.8 9267.4 9350.2 9358.8 7995.9 8191.8 8245.8 8313.4 8344.9 7906.4 7925.1 7990.6 8026.8 8048.3 7163.3 7385.7 7409.8 7436.6 7565.7 5588.8 5615.9 5629.5 5739.3 5740.0 5525.4 5532.6 5660.9 5687.1 5734.2 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#4] prototype.html Cycles:180 Average:5005.63 Median:5728.83 stddev:1488.35 (26.0%) stddev-sans-first:1450.43 16:23:23 INFO - PROCESS | 3268 | Values: 322.8 331.7 333.0 335.5 336.1 5650.7 5718.0 5736.5 5759.9 5764.0 5570.2 5606.2 5609.2 5613.2 5662.5 4156.6 4283.3 4368.0 4376.0 4404.9 4364.1 4366.8 4377.5 4380.1 4403.4 4342.3 4343.5 4369.1 4379.2 4395.0 4278.4 4319.3 4363.8 4371.6 4371.7 3776.8 3798.0 3816.6 3824.6 3833.9 5482.0 5488.3 5515.5 5524.6 5561.9 4762.5 4941.4 4970.6 4971.3 5072.6 5779.4 5813.0 5962.1 6001.9 6006.3 4193.9 4205.9 4241.8 4244.9 4249.8 6087.5 6136.1 6153.8 6173.3 6190.5 4314.5 4316.0 4325.3 4348.7 4354.6 4416.5 4427.6 4433.0 4438.5 4440.0 4941.8 5026.5 5037.2 5043.5 5050.5 5834.5 5886.6 5947.4 6002.5 6040.3 1474.7 1496.5 1518.2 1527.4 1529.8 974.8 986.2 1000.5 1015.8 1025.2 5721.2 5740.3 5752.7 5787.9 5790.7 6026.6 6027.5 6070.0 6079.6 6080.7 5637.0 5657.4 5680.4 5739.9 5803.6 3206.7 3235.9 3247.3 3262.3 3265.5 6149.7 6266.6 6279.7 6297.7 6301.2 6216.5 6236.9 6242.3 6254.8 6269.7 5975.2 6277.8 6288.0 6331.2 6333.7 6027.9 6048.8 6091.9 6122.8 6166.6 6078.8 6133.4 6139.7 6147.7 6150.6 6108.8 6368.2 6415.0 6426.2 6426.9 4348.5 4351.3 4360.5 4372.2 4389.7 6005.9 6093.8 6245.7 6256.3 6295.4 5956.9 5982.2 5997.6 6012.3 6064.2 5990.3 6017.7 6017.9 6057.7 6061.9 5565.3 5760.9 5872.4 5911.3 5949.0 5949.4 5990.2 6007.7 6034.4 6049.7 5677.7 5890.6 5900.0 5919.9 5949.5 16:23:23 INFO - PROCESS | 3268 | 16:23:23 INFO - PROCESS | 3268 | [#5] yui.html Cycles:180 Average:21629.11 Median:3695.85 stddev:31568.59 (854.2%) stddev-sans-first:31618.09 16:23:23 INFO - PROCESS | 3268 | Values: 714.2 722.0 741.9 832.6 858.8 12875.0 14513.2 14946.3 14984.9 15051.8 13075.1 13720.2 13760.9 13769.1 13808.4 801.3 807.6 808.0 810.1 811.8 796.3 802.8 804.4 804.9 805.9 827.9 833.6 833.9 836.1 839.1 809.1 831.8 831.9 837.2 838.0 599.5 599.7 603.3 604.2 605.2 15956.1 15993.4 16029.0 16073.8 16100.0 14930.9 15080.8 15110.8 15190.3 15482.7 12713.2 12733.7 13031.6 13089.3 13637.0 3729.5 3822.9 4026.0 4098.7 4105.3 57565.4 80035.0 80162.6 80499.0 80778.0 11399.9 11764.4 12027.9 12128.9 12358.6 21233.4 21358.9 21500.2 21595.7 21618.5 8880.8 8925.5 8954.6 9163.6 9220.0 4768.5 4870.5 4919.7 4961.4 4972.6 3543.9 3660.7 3660.9 3662.2 3756.3 685.0 690.5 703.4 704.9 710.9 685.6 705.4 728.8 736.2 773.9 9972.3 10221.0 10312.5 10414.4 10416.4 605.3 633.8 670.7 703.7 718.7 5008.0 5173.6 5235.1 5242.2 5252.9 114003.4 128292.0 128464.0 130128.0 131595.0 85801.6 108949.5 111274.0 111698.0 112055.0 79615.2 81263.2 88029.6 88327.6 90046.4 9893.9 10054.8 10126.0 10159.7 10269.4 43038.6 48595.5 49546.3 50430.5 51824.5 76670.6 77533.2 79224.6 79889.6 80457.0 13376.0 13476.7 13544.5 13661.2 13781.4 14932.2 14974.2 15775.4 16096.7 16671.9 14431.9 14469.7 14538.8 14685.6 15514.9 14260.8 14456.6 14853.2 14934.6 15331.5 14291.4 14477.6 14741.1 15450.8 15488.8 11544.4 11736.4 11994.8 12263.3 12858.5 11622.8 12016.9 12252.7 12446.5 12684.5 16:23:23 INFO - PROCESS | 3268 | -------- Summary: end -------- 16:23:23 INFO - PROCESS | 3268 | 16:23:24 INFO - TEST-INFO | 3268: exit 0 16:23:24 INFO - TEST-OK | dromaeo_css | took 1111973ms 16:23:24 INFO - TEST-START | kraken 16:23:24 INFO - operating with platform_type : linux_ 16:23:24 INFO - Initialising browser for kraken test... 16:23:24 INFO - TEST-INFO | started process 3511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Qbf4j/profile http://localhost:41144/getInfo.html) 16:23:29 INFO - PROCESS | 3511 | __metrics Screen width/height:1600/1200 16:23:29 INFO - PROCESS | 3511 | colorDepth:24 16:23:29 INFO - PROCESS | 3511 | Browser inner width/height: 1024/697 16:23:29 INFO - PROCESS | 3511 | __metrics 16:23:30 ERROR - PROCESS | 3511 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:23:30 INFO - TEST-INFO | 3511: exit 0 16:23:30 INFO - Browser initialized. 16:23:30 INFO - Running cycle 1/1 for kraken test... 16:23:30 INFO - TEST-INFO | started process 3634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Qbf4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:43 INFO - PROCESS | 3634 | RSS: Main: 184979456 16:23:43 INFO - PROCESS | 3634 | 16:23:45 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41144/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:46 INFO - PROCESS | 3634 | RSS: Main: 190275584 16:23:46 INFO - PROCESS | 3634 | 16:23:49 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41144/tests/kraken/driver.html?testName=audio-dft) 16:23:49 INFO - PROCESS | 3634 | RSS: Main: 189546496 16:23:49 INFO - PROCESS | 3634 | 16:23:52 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41144/tests/kraken/driver.html?testName=audio-fft) 16:23:53 INFO - PROCESS | 3634 | RSS: Main: 184303616 16:23:53 INFO - PROCESS | 3634 | 16:23:55 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41144/tests/kraken/driver.html?testName=audio-oscillator) 16:23:55 INFO - PROCESS | 3634 | RSS: Main: 185294848 16:23:55 INFO - PROCESS | 3634 | 16:23:58 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:58 INFO - PROCESS | 3634 | RSS: Main: 185405440 16:23:58 INFO - PROCESS | 3634 | 16:24:01 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41144/tests/kraken/driver.html?testName=imaging-darkroom) 16:24:02 INFO - PROCESS | 3634 | RSS: Main: 185982976 16:24:02 INFO - PROCESS | 3634 | 16:24:05 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41144/tests/kraken/driver.html?testName=imaging-desaturate) 16:24:06 INFO - PROCESS | 3634 | RSS: Main: 184193024 16:24:06 INFO - PROCESS | 3634 | 16:24:09 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41144/tests/kraken/driver.html?testName=json-parse-financial) 16:24:10 INFO - PROCESS | 3634 | RSS: Main: 185139200 16:24:10 INFO - PROCESS | 3634 | 16:24:11 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:12 INFO - PROCESS | 3634 | RSS: Main: 185454592 16:24:12 INFO - PROCESS | 3634 | 16:24:13 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:24:14 INFO - PROCESS | 3634 | RSS: Main: 185618432 16:24:14 INFO - PROCESS | 3634 | 16:24:16 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:24:17 INFO - PROCESS | 3634 | RSS: Main: 185917440 16:24:17 INFO - PROCESS | 3634 | 16:24:20 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:20 INFO - PROCESS | 3634 | RSS: Main: 186085376 16:24:20 INFO - PROCESS | 3634 | 16:24:23 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:24 INFO - PROCESS | 3634 | RSS: Main: 186150912 16:24:24 INFO - PROCESS | 3634 | 16:24:25 INFO - PROCESS | 3634 | Cycle 1(1): loaded http://localhost:41144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41144/tests/kraken/driver.html?testName=ai-astar) 16:24:25 INFO - PROCESS | 3634 | RSS: Main: 186667008 16:24:25 INFO - PROCESS | 3634 | 16:24:25 INFO - PROCESS | 3634 | __start_tp_report 16:24:25 INFO - PROCESS | 3634 | _x_x_mozilla_page_load 16:24:25 INFO - PROCESS | 3634 | _x_x_mozilla_page_load_details 16:24:25 INFO - PROCESS | 3634 | |i|pagename|runs| 16:24:25 INFO - PROCESS | 3634 | |0;ai-astar;100;109;106;110;112;111;111;110;110;110 16:24:25 INFO - PROCESS | 3634 | |1;audio-beat-detection;150;127;152;172;126;162;151;135;181;127 16:24:25 INFO - PROCESS | 3634 | |2;audio-dft;161;161;163;162;167;167;162;163;163;165 16:24:25 INFO - PROCESS | 3634 | |3;audio-fft;76;84;76;153;77;74;76;75;178;75 16:24:25 INFO - PROCESS | 3634 | |4;audio-oscillator;84;85;147;87;85;86;161;85;85;141 16:24:25 INFO - PROCESS | 3634 | |5;imaging-gaussian-blur;117;118;118;117;118;117;117;119;118;117 16:24:25 INFO - PROCESS | 3634 | |6;imaging-darkroom;149;148;148;149;150;148;147;148;148;148 16:24:25 INFO - PROCESS | 3634 | |7;imaging-desaturate;95;95;95;96;96;95;96;96;96;96 16:24:25 INFO - PROCESS | 3634 | |8;json-parse-financial;53;54;54;55;57;58;54;55;54;54 16:24:25 INFO - PROCESS | 3634 | |9;json-stringify-tinderbox;64;62;62;61;61;61;60;62;62;62 16:24:25 INFO - PROCESS | 3634 | |10;stanford-crypto-aes;82;84;80;79;80;79;84;80;136;79 16:24:25 INFO - PROCESS | 3634 | |11;stanford-crypto-ccm;126;132;125;131;134;132;131;141;124;137 16:24:25 INFO - PROCESS | 3634 | |12;stanford-crypto-pbkdf2;167;160;162;160;166;162;160;160;163;163 16:24:25 INFO - PROCESS | 3634 | |13;stanford-crypto-sha256-iterative;64;65;63;62;64;64;62;66;62;64 16:24:25 INFO - PROCESS | 3634 | __end_tp_report 16:24:25 INFO - PROCESS | 3634 | __start_cc_report 16:24:25 INFO - PROCESS | 3634 | _x_x_mozilla_cycle_collect,874 16:24:25 INFO - PROCESS | 3634 | __end_cc_report 16:24:25 INFO - PROCESS | 3634 | __startTimestamp1466983465989__endTimestamp 16:24:25 INFO - PROCESS | 3634 | 16:24:25 INFO - PROCESS | 3634 | ------- Summary: start ------- 16:24:25 INFO - PROCESS | 3634 | Number of tests: 14 16:24:25 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.51 (3.2%) stddev-sans-first:1.69 16:24:26 INFO - PROCESS | 3634 | Values: 100.0 109.0 106.0 110.0 112.0 111.0 111.0 110.0 110.0 110.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:151.50 stddev:19.51 (12.9%) stddev-sans-first:20.68 16:24:26 INFO - PROCESS | 3634 | Values: 150.0 127.0 152.0 172.0 126.0 162.0 151.0 135.0 181.0 127.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.18 16:24:26 INFO - PROCESS | 3634 | Values: 161.0 161.0 163.0 162.0 167.0 167.0 162.0 163.0 163.0 165.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.03 (50.0%) stddev-sans-first:39.75 16:24:26 INFO - PROCESS | 3634 | Values: 76.0 84.0 76.0 153.0 77.0 74.0 76.0 75.0 178.0 75.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.00 stddev:31.48 (37.0%) stddev-sans-first:32.50 16:24:26 INFO - PROCESS | 3634 | Values: 84.0 85.0 147.0 87.0 85.0 86.0 161.0 85.0 85.0 141.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:24:26 INFO - PROCESS | 3634 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 117.0 119.0 118.0 117.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 16:24:26 INFO - PROCESS | 3634 | Values: 149.0 148.0 148.0 149.0 150.0 148.0 147.0 148.0 148.0 148.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:24:26 INFO - PROCESS | 3634 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.50 16:24:26 INFO - PROCESS | 3634 | Values: 53.0 54.0 54.0 55.0 57.0 58.0 54.0 55.0 54.0 54.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:1.06 (1.7%) stddev-sans-first:0.73 16:24:26 INFO - PROCESS | 3634 | Values: 64.0 62.0 62.0 61.0 61.0 61.0 60.0 62.0 62.0 62.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:80.00 stddev:17.57 (22.0%) stddev-sans-first:18.57 16:24:26 INFO - PROCESS | 3634 | Values: 82.0 84.0 80.0 79.0 80.0 79.0 84.0 80.0 136.0 79.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:132.00 stddev:5.33 (4.0%) stddev-sans-first:5.30 16:24:26 INFO - PROCESS | 3634 | Values: 126.0 132.0 125.0 131.0 134.0 132.0 131.0 141.0 124.0 137.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:2.54 (1.6%) stddev-sans-first:2.05 16:24:26 INFO - PROCESS | 3634 | Values: 167.0 160.0 162.0 160.0 166.0 162.0 160.0 160.0 163.0 163.0 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - PROCESS | 3634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 16:24:26 INFO - PROCESS | 3634 | Values: 64.0 65.0 63.0 62.0 64.0 64.0 62.0 66.0 62.0 64.0 16:24:26 INFO - PROCESS | 3634 | -------- Summary: end -------- 16:24:26 INFO - PROCESS | 3634 | 16:24:26 INFO - TEST-INFO | 3634: exit 0 16:24:26 INFO - TEST-OK | kraken | took 62326ms 16:24:26 INFO - SUITE-END | took 1174s 16:24:27 INFO - Completed test suite (00:19:34) 16:24:27 INFO - javascript benchmark 16:24:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7621.955239290574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.905802825915, 3186.2512309607255, 3188.011716367926, 3204.9198770030753, 3208.6470488246273, 5559.027170245211, 5562.833115006551, 5605.215269862218, 5620.606557540974, 5625.099984002561, 5463.590230732691, 5563.833085007446, 5575.442455754423, 5592.86017849554, 5643.6049476536655, 5000.624953128521, 5039.244113383003, 5137.152369858969, 5181.6113791465605, 5241.082810508165, 768.2024480814193, 4960.727160006199, 5046.21783623539, 5120.743962801864, 5134.589232861362, 5071.061853557104, 5075.061113693979, 5089.312942752718, 5100.183970564729, 5106.387233531981, 5121.8463446096675, 5125.923111153335, 5138.768755406016, 5148.510891465305, 5158.690478571298, 4935.950640493585, 4960.107180707471, 4984.401871775374, 4997.275395067732, 4999.225120106389, 5507.008738427082, 5510.980468613279, 5520.592248976485, 5523.171524271352, 5524.419935906712, 5829.737661805187, 5890.587658863881, 5953.0, 5953.523718102541, 5996.400359964013, 5912.408759124096, 5940.168376427304, 5952.880942381128, 6014.96992515039, 6017.308009578911, 5588.413216612278, 5589.0, 5590.91613625796, 5593.52455041322, 5619.578531610146, 5913.793017244376, 6044.607100538451, 6149.84625384369, 6156.569040167145, 6160.568760186834, 5846.4153584642045, 5913.526917846562, 5915.556333275022, 5934.732937017845, 5959.106134079836, 5973.074173503114, 5989.341172471025, 6002.819915402545, 6004.159417681528, 6020.668863212565, 5790.189373487715, 5837.0368889132815, 5843.328017277982, 5906.202662640489, 5971.581989260797, 5880.941190588125, 5909.054551271776, 5922.141289512996, 5938.257717785277, 5962.1056841473255, 4491.326301054803, 4495.730256184574, 4508.256137737302, 4521.502634710179, 4556.612687921497, 3966.186931678999, 3996.140829721624, 4029.91940161201, 4034.6973976951845, 4076.3274059780397, 5497.725113744297, 5577.44225577439, 5617.101263797773, 5619.129034999582, 5675.886482270332, 5939.346671866091, 5944.227250457413, 6010.429009244115, 6033.849153771191, 6049.78825741097, 5577.498025177753, 5653.462921022497, 5736.627119237236, 5738.856528586819, 5750.281214848144, 5119.129747942859, 5174.534291913746, 5186.92219616706, 5199.142141546678, 5234.2933703949475, 6223.471004964538, 6248.094026366151, 6250.156228909039, 6274.6548939808745, 6276.968615156987, 5771.0, 5993.190919225849, 6040.516758659209, 6047.425494578096, 6068.544859135494, 6299.30707622152, 6311.147995020613, 6319.842003949938, 6322.589031713108, 6332.778352757631, 5933.554983376178, 5939.524838013035, 5955.642661440327, 5964.105384192406, 6011.008183649649, 5838.211841401357, 5916.0, 5940.46535811779, 5982.341942386421, 6100.786472473442, 5843.415658434123, 5878.735456904364, 5879.412058794086, 5884.176215329943, 5921.023031199804, 5841.474267315792, 5859.707014649336, 5879.73541190656, 5882.1470886722045, 5883.911741323969, 5537.861553461195, 5653.830385088454, 5754.51086657622, 5758.452946970031, 5831.854203644773, 5931.169636250842, 5943.64338139713, 5953.374895636069, 5955.166276721176, 5964.970175149097, 5634.774609015757, 5794.246747922743, 5840.561957853093, 5853.560982926212, 5855.2973643163095], "value": 5475.503320678201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.709266820256, 614.9815505534834, 627.3600927054405, 635.6630985577642, 645.1935081148564, 39950.60049399505, 43970.0, 44258.557414425886, 44342.33486497705, 44485.77757111214, 43601.563984360146, 44357.556424435745, 44452.555474445246, 44461.7776911115, 44507.0, 8799.560021998906, 8957.149070838292, 8990.68532601359, 8996.145366190201, 8998.0, 8833.823323533525, 8917.108289171096, 8939.687110951118, 8942.150495702897, 8949.686760963368, 8865.157810008039, 8874.20132188103, 8912.777180570472, 8919.821603567925, 8992.05583413742, 8833.73498795034, 8915.108489151065, 8930.642774289021, 8954.820903581893, 8954.910450895473, 8873.201411872898, 8938.86591701125, 8955.55222238892, 8992.46045237288, 8992.55037248135, 36054.63945360539, 36255.81872090622, 36377.09057273563, 36396.818015910016, 36468.817655911815, 3050.572919791231, 3351.413502637053, 3358.3619112368574, 3535.1515636247373, 3657.652523010336, 30177.547336789965, 30333.848330758206, 33325.83337083299, 34167.48748768771, 35360.29279414397, 4033.979830100831, 4203.956489547256, 4293.205756934945, 4445.8221671133115, 4537.954620453786, 356978.0, 360424.7915041685, 361238.0, 363103.0, 363238.1838090819, 63170.0, 63389.0, 63606.363936360045, 63772.36227637664, 63868.36131638717, 35858.10354741153, 36826.8158659205, 36989.07527311785, 66009.33990660128, 66363.0, 17636.559086022953, 17774.46676599704, 17788.55528611769, 17840.55398615019, 17884.0, 12820.0, 12899.097063205672, 12902.225866448043, 12907.677308067186, 12961.185434039242, 19620.3132890351, 19926.800731992495, 19947.501312467306, 20106.497337566387, 20142.0, 7420.332170104609, 7455.291747284108, 7496.6251687415415, 7630.656620452093, 7706.262462705583, 895.5298468304062, 990.7919336939324, 1123.2979387882574, 1158.0, 1160.988390116105, 32271.51592726111, 32659.0, 32808.0, 33014.3397132056, 33338.3332333352, 1105.784372047459, 1112.3937454087543, 1120.7086157599083, 1123.2530367305812, 1155.9479823407967, 17151.0, 17249.56876078108, 17340.30638774435, 17342.935534976295, 17676.11619419024, 540990.0, 545725.0, 551843.0, 551940.0, 552610.0, 60786.0, 61281.69359153176, 61333.0, 61486.38513614806, 61496.38503614996, 1307.8822905938512, 1363.7136201397818, 1373.979390309146, 1378.8621137886332, 1389.1387339849357, 31045.223869403446, 31918.68081319157, 32200.838995804872, 32379.19052023624, 32984.83507582447, 52891.0, 52986.73506632442, 53435.46564534305, 53598.73200634128, 53679.73160134331, 445474.0, 449137.0, 449787.0, 450160.0, 450387.0, 28675.856620716764, 29194.270143246587, 29418.558721618763, 29620.851895740383, 29776.10671679853, 49464.752676236385, 49957.50042499674, 50077.24884126668, 50126.74936625294, 50647.49352506428, 42753.144937100464, 43278.56721432746, 43430.34854477122, 44415.77792111019, 44452.11095778131, 42428.787856060524, 42955.78522107495, 42959.0, 43151.0, 43819.0, 41194.0, 41930.580694192664, 42129.157416852104, 42615.14769704651, 42687.14625707531, 36460.635393646786, 38409.807950961185, 38676.80661596674, 38722.2255554893, 38819.0, 27873.303167420978, 28355.43289134247, 28868.855655721585, 30184.09447716572, 30303.242418939702], "value": 20399.11464837758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1510262320273, 394.5935686243171, 398.8105649816337, 402.82074476857775, 416.33386581469654, 14029.719405611882, 18268.451946441593, 18977.051147442642, 19814.207431702733, 19852.50368740782, 18446.35437759679, 18560.0, 19079.14143863526, 19123.42629721107, 19135.33026344078, 5690.99999999999, 5775.942240577603, 5868.09044598088, 5882.058870580687, 5883.8529036774, 5758.99217636914, 5777.45114214149, 5800.042992906166, 6512.185976752906, 6894.276101009397, 6876.071730316393, 6892.207396149432, 6954.165500139965, 6960.060391847086, 7074.0, 6929.861402771941, 6986.510944233905, 7028.086348774677, 7084.0, 7096.503244772894, 7081.822954426129, 7132.5007249492555, 7154.534955227893, 7183.784486465414, 7195.424366050704, 23944.521109577887, 24710.876445617658, 25718.357041074123, 25747.97008119673, 25846.612300815505, 2966.59950906627, 3201.135693362779, 3260.7228385587255, 3262.934741305184, 3372.15696075981, 15129.546113616609, 15400.46098386551, 15482.219544752385, 15796.526104216891, 16045.91977040119, 2055.290924631, 2060.5157787919825, 2079.6984437256515, 2102.138123369411, 2125.7767934366825, 92740.0, 94838.0, 97045.5147724264, 97985.51007244918, 98152.0, 17112.74330885038, 17341.7398739019, 17418.65162696739, 17688.142745011588, 17896.373626922996, 31229.219269518442, 31487.685123148476, 31756.682433175836, 31840.0, 31874.0, 9792.314537982273, 10130.898691013143, 10267.589296428208, 10387.94806025965, 10434.530446129942, 8711.956440217758, 8768.123187681309, 8853.114688531225, 8860.911390886009, 9122.726318210463, 8949.865752013726, 8952.910470895207, 9047.547622618842, 9061.68284110066, 9359.672411465566, 3551.485034669958, 3581.585273816828, 3599.2441587266967, 3603.1172362770762, 3661.8901432957055, 891.3092353426017, 936.7704912296531, 997.875265591801, 1044.806710758512, 1085.1264731890747, 17734.733978990327, 18097.638047238983, 18760.437186884414, 19039.143238554298, 19272.903635481733, 978.7161723100363, 997.3367710472454, 1012.964546240878, 1055.904968552834, 1068.9465526723632, 9846.803063938682, 10900.781984360268, 10914.0, 10938.343699378063, 10995.505202265756, 473059.0, 474814.0, 475504.0, 497132.0, 500189.0, 59709.402905971256, 84053.15946840453, 95405.0, 97577.0, 98407.0, 1022.5500779656927, 1035.1925498111484, 1044.1072882685346, 1044.5143008501084, 1049.1292227451197, 16764.32942682279, 17167.141642918054, 17411.47765567035, 17425.651486970444, 17494.9125254378, 40118.39822402608, 40339.798301008304, 43554.0, 43702.56297437112, 44571.55428445674, 54022.18966715581, 54174.18738718844, 56685.0, 60219.0, 60531.394686052576, 8671.826563468821, 8732.78168045804, 8754.47473151613, 8881.600327985385, 8906.777330566787, 9770.658026969022, 13243.470261189444, 13547.932260338635, 13744.244066576433, 13915.791263131263, 12067.396630168281, 12068.75862482763, 12314.199577027464, 12357.691057723629, 12380.133390662568, 11213.102951764002, 11322.60370887048, 12277.815832762695, 12289.955353795027, 12705.491780328683, 11586.188966772244, 12354.196977196454, 12502.0, 12533.122681412578, 12644.557440489538, 8177.0, 8236.752897413087, 8401.53791541471, 8450.915490845013, 8829.293656507592, 8648.264897483532, 11312.773744524899, 12049.939750301193, 12114.818277726017, 12391.442385092512], "value": 10462.782607609835, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.9855001449985, 1463.9898470055662, 1581.312129223787, 1695.398133662549, 1708.9230984605692, 8227.17728227177, 8902.065283145266, 9053.637854485813, 9522.571484283206, 9530.380525265862, 8943.910560894388, 9118.08819118088, 9270.907290927105, 9302.395344302615, 9311.72064838056, 2287.5653625811124, 2306.984926632285, 2322.7328857181387, 2325.3140323604575, 2335.1009861203474, 2296.8851557422145, 2321.3848330192427, 2346.4016675747744, 2348.659444380564, 2355.9646605300936, 2253.445122865226, 2277.2257432472957, 2289.244549298736, 2329.452578644017, 2341.94145146371, 2239.6640503924377, 2273.81809455244, 2293.8967746451367, 2294.1855641247284, 2300.804431623314, 2248.8425810193294, 2254.458929856839, 2264.79616834484, 2272.602294598455, 2280.2019293247395, 9249.768755781159, 9313.720588382359, 9317.835270591177, 9324.813503729954, 9337.953310233474, 5385.7576409061685, 5459.508644222039, 5465.426130256305, 5497.945020549823, 5531.474509921551, 3297.422950983568, 3517.3317069756663, 3564.946525802115, 3643.453481977698, 3659.1583935694675, 1103.167108832826, 1111.8999290063932, 2192.6601376786625, 2236.798688118061, 2278.8290878184202, 12634.936825315815, 12639.49442022318, 12778.616641500677, 12794.0, 12804.167729097579, 4582.770861456914, 4598.195315819718, 4681.391419115561, 4709.340692303081, 4710.458297295855, 9910.306278560576, 9911.207103431709, 9918.900810991941, 9927.453990030617, 9941.155001824782, 5337.146056630921, 5354.41101478837, 5368.194770784414, 5381.704006279614, 5386.084365657847, 4327.978360108179, 4934.1118598651865, 4972.676776009548, 5045.84862454127, 5063.569596584258, 3692.51997240357, 3769.4345848123003, 3816.2749077675153, 3851.1527463957887, 3866.4393662919283, 1115.8214685650257, 1150.0339714639742, 1154.492023509653, 1157.0916830288184, 1166.1487114406532, 1012.2256473797551, 1025.9640912568025, 1033.5452400943561, 1056.9048785609332, 1063.3088492479794, 6328.588641738273, 6476.417122459001, 6537.411632952962, 6557.573757705829, 6589.53873228879, 423.9067405170857, 428.37029566537143, 430.66193038464655, 430.79106633282834, 442.23714093188994, 4289.6139347458875, 4300.634446072057, 4307.418498502725, 4330.0, 4347.413099231627, 11356.829647555292, 11562.364069976064, 11642.88357116418, 11644.0, 11689.357085360387, 11589.362585057734, 11622.709432264091, 11629.24409913353, 11635.825462618068, 11641.767164656829, 8008.0, 8328.250457458858, 8337.458065225741, 8522.232999030117, 8682.739517814349, 6270.4670103039925, 6488.8362770014965, 6509.8698026040165, 6560.540762146604, 6567.080608714879, 10820.18848586375, 10881.727956801144, 10963.506642201279, 10993.725156871142, 11077.0, 10832.18758593093, 11052.613158539412, 11140.220184587, 11167.720806979565, 11170.553177872795, 7408.0, 7909.209079092045, 8162.265396114378, 8280.875786863322, 8456.577171141542, 9145.0, 9249.768755781159, 9267.351285409957, 9350.158485736316, 9358.81282374335, 7995.880061799194, 8191.754247372588, 8245.79385515343, 8313.376496762889, 8344.916550834656, 7906.367490600623, 7925.0886148093705, 7990.560519171268, 8026.799330016796, 8048.315893148913, 7163.31948464895, 7385.667644956097, 7409.777706668809, 7436.553806771611, 7565.735199268, 5588.832335029955, 5615.915761263666, 5629.549636029026, 5739.311282646109, 5739.971300143473, 5525.4474552544425, 5532.557395408438, 5660.943390566042, 5687.146927960839, 5734.197212390352], "value": 4752.122556150621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.83858070964516, 331.65839185638794, 332.966703329667, 335.5386343777306, 336.12942478979437, 5650.74571644276, 5717.971410142954, 5736.45503677151, 5759.942400575993, 5763.991301522233, 5570.220169176318, 5606.187102870082, 5609.158626206071, 5613.186088017235, 5662.546996240301, 4156.563560826107, 4283.329501494404, 4367.956320436787, 4376.0, 4404.933925991097, 4364.148990946766, 4366.781660916958, 4377.4528183977, 4380.102079073782, 4403.427554417921, 4342.348647702854, 4343.4580723843055, 4369.1480161368545, 4379.189849877767, 4394.956050439487, 4278.4010238566625, 4319.33050377192, 4363.759993200404, 4371.606555410029, 4371.693981421302, 3776.754510956779, 3798.0, 3816.599257078022, 3824.598417166213, 3833.8658146965, 5481.972590137024, 5488.271194573696, 5515.503604675559, 5524.558035357162, 5561.944380556223, 4762.523747625244, 4941.431735350445, 4970.602351811846, 4971.328870602459, 5072.594192464631, 5779.410662067923, 5812.9709351452975, 5962.105684147369, 6001.879962400728, 6006.279246490449, 4193.916121677549, 4205.915881682349, 4241.766702831343, 4244.893877653052, 4249.830006799724, 6087.54343424245, 6136.140940268366, 6153.753849846001, 6173.2900716417735, 6190.5452218729015, 4314.50383205929, 4315.964168599514, 4325.329573916048, 4348.673849461303, 4354.608085272341, 4416.470023597189, 4427.6236519896165, 4432.958254810182, 4438.467383913951, 4440.0, 4941.802327906916, 5026.4973502649445, 5037.219231019198, 5043.52086551777, 5050.520200580939, 5834.504067154339, 5886.646801191942, 5947.375525569752, 6002.4897883679505, 6040.305364883095, 1474.7198032374029, 1496.453794365049, 1518.187769543311, 1527.4119464006214, 1529.785829983803, 974.8099120671543, 986.1519093579516, 1000.4547521600745, 1015.8120747661707, 1025.2105878473683, 5721.199032135504, 5740.311162660508, 5752.654840709487, 5787.855303617359, 5790.699301398163, 6026.608270462406, 6027.517798576104, 6070.0, 6079.574429789961, 6080.695965201722, 5636.97181514098, 5657.4059723728415, 5680.375158732536, 5739.8565035874435, 5803.564732645069, 3206.727428168585, 3235.854386552611, 3247.2531317796565, 3262.2986057997646, 3265.5428240046413, 6149.66176860268, 6266.561340706106, 6279.654618995999, 6297.685115744194, 6301.180846489927, 6216.471599913967, 6236.875262494725, 6242.344553821783, 6254.8123556293385, 6269.7178626961895, 5975.19334889793, 6277.811665649946, 6288.019273928698, 6331.240251169889, 6333.651649159248, 6027.914975304488, 6048.788292409745, 6091.878162436815, 6122.785702500391, 6166.630002199882, 6078.817635470943, 6133.3866613338305, 6139.723712432862, 6147.72335244924, 6150.630962142286, 6108.839320529085, 6368.172137622265, 6414.967925160345, 6426.164598602152, 6426.871462570816, 4348.478182618106, 4351.325544540601, 4360.454943132108, 4372.1692878353015, 4389.736615803062, 6005.939940600538, 6093.847653808691, 6245.7189426476825, 6256.280527739368, 6295.370462953668, 5956.880862382642, 5982.222311099529, 5997.5501837363245, 6012.278526576839, 6064.181335519825, 5990.311114221746, 6017.729202185825, 6017.939820601738, 6057.666828324484, 6061.939380606137, 5565.276514053147, 5760.94239057604, 5872.442117998783, 5911.320198177093, 5949.0, 5949.434803693643, 5990.191324171181, 6007.729652165751, 6034.366391528826, 6049.727762250797, 5677.659340439587, 5890.617109887844, 5899.970500147643, 5919.934411805744, 5949.464548190684], "value": 4523.192264801363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2107970692384, 721.982223546353, 741.907261592301, 832.5920299053463, 858.7767180533061, 12875.0, 14513.20177390243, 14946.327415266313, 14984.850151498482, 15051.849481505182, 13075.084744067895, 13720.176789392643, 13760.93119534401, 13769.105008174487, 13808.378622961965, 801.2588355770903, 807.6244546285976, 807.9577345224653, 810.1452967119686, 811.8011087283594, 796.2555011064644, 802.8153524689325, 804.3685706720225, 804.8752443371258, 805.8871757953891, 827.896512935883, 833.6123702478346, 833.9207775261341, 836.1137194573771, 839.0560619303284, 809.1059379385812, 831.7546323834453, 831.9251267385933, 837.1795640272567, 837.9790505237387, 599.4544964082708, 599.6522017230039, 603.2971588099858, 604.2205554834259, 605.1739375752111, 15956.122413267265, 15993.360265589363, 16029.038257704575, 16073.758893616605, 16100.0, 14930.925345373204, 15080.849191508054, 15110.773338399822, 15190.316435760416, 15482.690346193012, 12713.17364371313, 12733.74532509354, 13031.609051728463, 13089.345532723326, 13637.0, 3729.515163028816, 3822.8853134406013, 4025.9798701006603, 4098.6516146127615, 4105.322621767405, 57565.42434575642, 80035.0, 80162.59918700428, 80499.0, 80778.0, 11399.886001140048, 11764.352960587079, 12027.939860300643, 12128.939355303168, 12358.62924112278, 21233.36299911005, 21358.893205533874, 21500.247491337726, 21595.67606485904, 21618.45953851135, 8880.822383552293, 8925.464472131564, 8954.552272386354, 9163.58763855628, 9220.0, 4768.451628062748, 4870.464248932614, 4919.704817710949, 4961.355023846877, 4972.627052971042, 3543.875964341236, 3660.7254455915913, 3660.9450858237146, 3662.1760103976394, 3756.3050835595504, 685.0, 690.5304393012799, 703.409136325489, 704.8590281943632, 710.9146902371748, 685.5646664368062, 705.4004096518021, 728.7886512911302, 736.1791602363327, 773.9496932699469, 9972.301938864355, 10221.0, 10312.535935882903, 10414.375137491776, 10416.375017498975, 605.3492495567283, 633.8003528888386, 670.7015378156674, 703.7466512055656, 718.741253148866, 5008.0, 5173.5602473789395, 5235.110031294613, 5242.18746094356, 5252.921206181911, 114003.42998284956, 128292.0, 128464.0, 130128.0, 131595.0, 85801.57099214589, 108949.45525272323, 111274.0, 111698.0, 112055.0, 79615.20384796194, 81263.18736812557, 88029.55985220161, 88327.55836220778, 90046.39814407482, 9893.851592225978, 10054.849177262493, 10126.0, 10159.695209143738, 10269.383836969806, 43038.56961430346, 48595.525266554905, 49546.25680614721, 50430.49569504405, 51824.48175518347, 76670.6166469164, 77533.2246677526, 79224.60387698255, 79889.60055199687, 80457.0, 13376.0, 13476.663083422993, 13544.458221671417, 13661.18032918028, 13781.448742050607, 14932.178730169511, 14974.176420296988, 15775.369104783935, 16096.712263019164, 16671.916640417207, 14431.85568144347, 14469.710605788036, 14538.781918271447, 14685.632859178606, 15514.9224253878, 14260.786088208477, 14456.638584035483, 14853.183074930983, 14934.626634334229, 15331.463398780988, 14291.356888939814, 14477.565673029825, 14741.11553306805, 15450.84549154539, 15488.767668485207, 11544.422778861192, 11736.354500502553, 11994.76010479803, 12263.264204147423, 12858.485660573846, 11622.825657614974, 12016.879831201577, 12252.693682658004, 12446.502139914302, 12684.492620295085], "value": 7804.405694582325, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 106.0, 110.0, 112.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 152.0, 172.0, 126.0, 162.0, 151.0, 135.0, 181.0, 127.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 167.0, 167.0, 162.0, 163.0, 163.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 76.0, 153.0, 77.0, 74.0, 76.0, 75.0, 178.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 147.0, 87.0, 85.0, 86.0, 161.0, 85.0, 85.0, 141.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 150.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 57.0, 58.0, 54.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 80.0, 79.0, 80.0, 79.0, 84.0, 80.0, 136.0, 79.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 125.0, 131.0, 134.0, 132.0, 131.0, 141.0, 124.0, 137.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 162.0, 160.0, 166.0, 162.0, 160.0, 160.0, 163.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 62.0, 64.0, 64.0, 62.0, 66.0, 62.0, 64.0], "value": 63.6, "unit": "score"}]}]} 16:24:27 INFO - Return code: 0 16:24:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:24:27 ERROR - # TBPL SUCCESS # 16:24:27 INFO - Running post-action listener: _resource_record_post_action 16:24:27 INFO - ##### 16:24:27 INFO - ##### Finished run-tests step (success) 16:24:27 INFO - ##### 16:24:27 INFO - Running post-run listener: _resource_record_post_run 16:24:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 413937664; Read time: 12; Write time: 260644 16:24:27 INFO - TinderboxPrint: CPU usage
13.4% 16:24:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:24:27 INFO - TinderboxPrint: I/O write bytes / time
413,937,664 / 260,644 16:24:27 INFO - TinderboxPrint: CPU idle
8,237.4 (86.6%) 16:24:27 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 16:24:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:24:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118501376; Read time: 0; Write time: 95684 16:24:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294490112; Read time: 12; Write time: 164784 16:24:27 INFO - Running post-run listener: _upload_blobber_files 16:24:27 INFO - Blob upload gear active. 16:24:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:24:27 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 16:24:27 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'] 16:24:27 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 16:24:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:24:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:31 INFO - (blobuploader) - INFO - Done attempting. 16:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:32 INFO - (blobuploader) - INFO - Done attempting. 16:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:33 INFO - (blobuploader) - INFO - Done attempting. 16:24:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:24:33 INFO - Return code: 0 16:24:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:24:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:24:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69e33a03c554fb88ca99c27edacd007691f3bdbaa5901fae80d55a4f36d33016e3143aeddb479fbfaa1fa3266038625ab8410b04ffb746b90e886c68dea712a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/45f7c69320e192f833db56f87f1a7b171ca634ee7c87cd08869e32d609e085a03c9bea4e26341fca9a4e03d46a6de0b6ac6f5a703fcc1121ca9ce16ddfeb27a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c9ed241082d9c2a9907a6997871ca399006b563e0ae54e1267989f0afdcce0ee11d8a0bb26290e66b773fc35acb45bae3ad8ebfa7a75fbd52bb0b9ff4c7c6c0"} 16:24:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:24:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:24:33 INFO - Contents: 16:24:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69e33a03c554fb88ca99c27edacd007691f3bdbaa5901fae80d55a4f36d33016e3143aeddb479fbfaa1fa3266038625ab8410b04ffb746b90e886c68dea712a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/45f7c69320e192f833db56f87f1a7b171ca634ee7c87cd08869e32d609e085a03c9bea4e26341fca9a4e03d46a6de0b6ac6f5a703fcc1121ca9ce16ddfeb27a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c9ed241082d9c2a9907a6997871ca399006b563e0ae54e1267989f0afdcce0ee11d8a0bb26290e66b773fc35acb45bae3ad8ebfa7a75fbd52bb0b9ff4c7c6c0"} 16:24:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:24:33 INFO - Copying logs to upload dir... 16:24:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:24:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.391884 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-26 16:24:32.846832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 16:24:32.856639) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 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/69e33a03c554fb88ca99c27edacd007691f3bdbaa5901fae80d55a4f36d33016e3143aeddb479fbfaa1fa3266038625ab8410b04ffb746b90e886c68dea712a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/45f7c69320e192f833db56f87f1a7b171ca634ee7c87cd08869e32d609e085a03c9bea4e26341fca9a4e03d46a6de0b6ac6f5a703fcc1121ca9ce16ddfeb27a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c9ed241082d9c2a9907a6997871ca399006b563e0ae54e1267989f0afdcce0ee11d8a0bb26290e66b773fc35acb45bae3ad8ebfa7a75fbd52bb0b9ff4c7c6c0"} build_url:https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/UPYy7RoTSu6lQ0VpPJDXQA/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/69e33a03c554fb88ca99c27edacd007691f3bdbaa5901fae80d55a4f36d33016e3143aeddb479fbfaa1fa3266038625ab8410b04ffb746b90e886c68dea712a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/45f7c69320e192f833db56f87f1a7b171ca634ee7c87cd08869e32d609e085a03c9bea4e26341fca9a4e03d46a6de0b6ac6f5a703fcc1121ca9ce16ddfeb27a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c9ed241082d9c2a9907a6997871ca399006b563e0ae54e1267989f0afdcce0ee11d8a0bb26290e66b773fc35acb45bae3ad8ebfa7a75fbd52bb0b9ff4c7c6c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 16:24:32.889018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:24:32.889454) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466981755.739166-1246714144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:24:32.940351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 16:24:32.940775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 16:24:32.941175) ========= ========= Total master_lag: 0.17 =========