builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0307 starttime: 1487809388.66 results: success (0) buildid: 20170222145621 builduid: d63186baa88d422b9b9631892a5f0e27 revision: 499739e68fada7112afe8e5a9ce4744d1e4f07e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:08.660913) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:08.661265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:08.661534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:08.685209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:08.685573) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-22 16:23:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.85M=0.001s 2017-02-22 16:23:09 (7.85 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.500577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:09.207401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:09.207696) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020828 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:09.312623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 16:23:09.312971) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 499739e68fada7112afe8e5a9ce4744d1e4f07e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 499739e68fada7112afe8e5a9ce4744d1e4f07e6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-22 16:23:09,408 truncating revision to first 12 chars 2017-02-22 16:23:09,408 Setting DEBUG logging. 2017-02-22 16:23:09,408 attempt 1/10 2017-02-22 16:23:09,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/499739e68fad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 16:23:10,400 unpacking tar archive at: mozilla-central-499739e68fad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256165 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 16:23:10.595512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:10.595875) ========= script_repo_revision: 499739e68fada7112afe8e5a9ce4744d1e4f07e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:10.596341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:10.596687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 16:23:10.614452) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-22 16:23:10.614789) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:23:10 INFO - MultiFileLogger online at 20170222 16:23:10 in /builds/slave/test 16:23:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:23:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:10 INFO - {'append_to_log': False, 16:23:10 INFO - 'base_work_dir': '/builds/slave/test', 16:23:10 INFO - 'blob_upload_branch': 'Firefox', 16:23:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:10 INFO - 'branch': 'Firefox', 16:23:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:10 INFO - 'config_files': ('talos/mac_config.py',), 16:23:10 INFO - 'default_actions': ('clobber', 16:23:10 INFO - 'read-buildbot-config', 16:23:10 INFO - 'download-and-extract', 16:23:10 INFO - 'populate-webroot', 16:23:10 INFO - 'create-virtualenv', 16:23:10 INFO - 'install', 16:23:10 INFO - 'run-tests'), 16:23:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:10 INFO - 'download_minidump_stackwalk': True, 16:23:10 INFO - 'download_symbols': 'ondemand', 16:23:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:10 INFO - 'gecko_profile': False, 16:23:10 INFO - 'gecko_profile_interval': 0, 16:23:10 INFO - 'installer_path': 'installer.exe', 16:23:10 INFO - 'log_level': 'info', 16:23:10 INFO - 'log_name': 'talos', 16:23:10 INFO - 'log_to_console': True, 16:23:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:23:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:23:10 INFO - 'opt_config_files': (), 16:23:10 INFO - 'pip_index': False, 16:23:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:23:10 INFO - 'cmd': ('bash', 16:23:10 INFO - '-c', 16:23:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:23:10 INFO - 'enabled': True, 16:23:10 INFO - 'halt_on_failure': False, 16:23:10 INFO - 'name': 'check_screen_resolution'},), 16:23:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:23:10 INFO - 'cmd': ('bash', 16:23:10 INFO - '-c', 16:23:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:23:10 INFO - 'enabled': True, 16:23:10 INFO - 'halt_on_failure': False, 16:23:10 INFO - 'name': 'check_screen_resolution'},), 16:23:10 INFO - 'run_cmd_checks_enabled': True, 16:23:10 INFO - 'suite': 'dromaeojs', 16:23:10 INFO - 'system_bits': '32', 16:23:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:10 INFO - 'title': 't-yosemite-r7-0307', 16:23:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:10 INFO - 'use_talos_json': True, 16:23:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:10 INFO - 'work_dir': 'build'} 16:23:10 INFO - [mozharness: 2017-02-23 00:23:10.830878Z] Running clobber step. 16:23:10 INFO - Running pre-action listener: _resource_record_pre_action 16:23:10 INFO - Running main action method: clobber 16:23:10 INFO - rmtree: /builds/slave/test/build 16:23:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:14 INFO - Running post-action listener: _resource_record_post_action 16:23:14 INFO - [mozharness: 2017-02-23 00:23:14.269028Z] Finished clobber step (success) 16:23:14 INFO - [mozharness: 2017-02-23 00:23:14.269294Z] Running read-buildbot-config step. 16:23:14 INFO - Running pre-action listener: _resource_record_pre_action 16:23:14 INFO - Running main action method: read_buildbot_config 16:23:14 INFO - Using buildbot properties: 16:23:14 INFO - { 16:23:14 INFO - "project": "", 16:23:14 INFO - "product": "firefox", 16:23:14 INFO - "script_repo_revision": "production", 16:23:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:23:14 INFO - "repository": "", 16:23:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:23:14 INFO - "buildid": "20170222145621", 16:23:14 INFO - "pgo_build": "False", 16:23:14 INFO - "basedir": "/builds/slave/test", 16:23:14 INFO - "buildnumber": 2, 16:23:14 INFO - "slavename": "t-yosemite-r7-0307", 16:23:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:23:14 INFO - "platform": "yosemite_r7", 16:23:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:23:14 INFO - "branch": "mozilla-central", 16:23:14 INFO - "repo_path": "mozilla-central", 16:23:14 INFO - "revision": "499739e68fada7112afe8e5a9ce4744d1e4f07e6", 16:23:14 INFO - "stage_platform": "macosx64", 16:23:14 INFO - "builduid": "d63186baa88d422b9b9631892a5f0e27", 16:23:14 INFO - "slavebuilddir": "test" 16:23:14 INFO - } 16:23:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 16:23:14 INFO - Running post-action listener: _resource_record_post_action 16:23:14 INFO - [mozharness: 2017-02-23 00:23:14.275039Z] Finished read-buildbot-config step (success) 16:23:14 INFO - [mozharness: 2017-02-23 00:23:14.275265Z] Running download-and-extract step. 16:23:14 INFO - Running pre-action listener: _resource_record_pre_action 16:23:14 INFO - Running main action method: download_and_extract 16:23:14 INFO - mkdir: /builds/slave/test/build/tests 16:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:14 INFO - trying https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 16:23:14 INFO - Downloading https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 16:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 16:23:15 INFO - Downloaded 1199 bytes. 16:23:15 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 16:23:15 INFO - Using the following test package requirements: 16:23:15 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 16:23:15 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 16:23:15 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 16:23:15 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'jsshell-mac.zip'], 16:23:15 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 16:23:15 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 16:23:15 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 16:23:15 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 16:23:15 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 16:23:15 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:23:15 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 16:23:15 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:23:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 16:23:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:23:15 INFO - Fetch https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 16:23:16 INFO - Expected file size: 51468750 16:23:16 INFO - Obtained file size: 51468750 16:23:33 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:23:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 16:23:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:23:33 INFO - Fetch https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 16:23:34 INFO - Expected file size: 51468750 16:23:34 INFO - Obtained file size: 51468750 16:23:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 16:23:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:23:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 16:23:50 INFO - Expected file size: 14404319 16:23:50 INFO - Obtained file size: 14404319 16:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:51 INFO - trying https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:23:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 16:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 16:23:53 INFO - Downloaded 74930890 bytes. 16:23:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:23:53 INFO - mkdir: /builds/slave/test/properties 16:23:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:53 INFO - Contents: 16:23:53 INFO - build_url:https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:23:54 INFO - Running post-action listener: _resource_record_post_action 16:23:54 INFO - Running post-action listener: set_extra_try_arguments 16:23:54 INFO - [mozharness: 2017-02-23 00:23:54.093804Z] Finished download-and-extract step (success) 16:23:54 INFO - [mozharness: 2017-02-23 00:23:54.093961Z] Running populate-webroot step. 16:23:54 INFO - Running pre-action listener: _resource_record_pre_action 16:23:54 INFO - Running main action method: populate_webroot 16:23:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:54 INFO - '--tppagecycles', 16:23:54 INFO - '7'], 16:23:54 INFO - 'tests': ['tsvgm']}}, 16:23:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['damp', 'tps']}, 16:23:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'tests': ['damp', 'tps']}, 16:23:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['dromaeo_dom']}, 16:23:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['basic_compositor_video']}, 16:23:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:23:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['a11yr', 16:23:54 INFO - 'ts_paint', 16:23:54 INFO - 'tpaint', 16:23:54 INFO - 'sessionrestore', 16:23:54 INFO - 'sessionrestore_no_auto_restore', 16:23:54 INFO - 'tabpaint']}, 16:23:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['tsvgx', 16:23:54 INFO - 'tsvgr_opacity', 16:23:54 INFO - 'tart', 16:23:54 INFO - 'tscrollx', 16:23:54 INFO - 'cart', 16:23:54 INFO - 'tsvg_static']}, 16:23:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:54 INFO - 'tsvgr_opacity', 16:23:54 INFO - 'tart', 16:23:54 INFO - 'tscrollx', 16:23:54 INFO - 'cart', 16:23:54 INFO - 'tsvg_static']}, 16:23:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'talos_options': ['--disable-e10s'], 16:23:54 INFO - 'tests': ['tp5o']}, 16:23:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:23:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'talos_options': ['--disable-e10s', 16:23:54 INFO - '--xperf_path', 16:23:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:54 INFO - 'tests': ['tp5n']}, 16:23:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:23:54 INFO - 'talos_options': ['--xperf_path', 16:23:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:54 INFO - 'tests': ['tp5n']}}, 16:23:54 INFO - 'talos.zip': {'path': '', 16:23:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:54 INFO - Running post-action listener: _resource_record_post_action 16:23:54 INFO - [mozharness: 2017-02-23 00:23:54.112065Z] Finished populate-webroot step (success) 16:23:54 INFO - [mozharness: 2017-02-23 00:23:54.112179Z] Running create-virtualenv step. 16:23:54 INFO - Running pre-action listener: _resource_record_pre_action 16:23:54 INFO - Running main action method: create_virtualenv 16:23:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:23:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:54 INFO - Using real prefix '/tools/python27' 16:23:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:57 INFO - Installing pip.................done. 16:23:57 INFO - Return code: 0 16:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:23:58 INFO - Reading from file tmpfile_stdout 16:23:58 INFO - Output received: 16:23:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:23:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:58 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 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:23:58 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:23:58 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:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:58 INFO - 'HOME': '/Users/cltbld', 16:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:58 INFO - 'LOGNAME': 'cltbld', 16:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:58 INFO - 'MOZ_NO_REMOTE': '1', 16:23:58 INFO - 'NO_EM_RESTART': '1', 16:23:58 INFO - 'PAGER': '/bin/cat', 16:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:58 INFO - 'PWD': '/builds/slave/test', 16:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:58 INFO - 'SHELL': '/bin/bash', 16:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:23:58 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:58 INFO - 'USER': 'cltbld', 16:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:58 INFO - 'XPC_FLAGS': '0x0', 16:23:58 INFO - 'XPC_SERVICE_NAME': '0', 16:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:58 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:23:58 INFO - Cleaning up... 16:23:58 INFO - Return code: 0 16:23:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:58 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 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:23:58 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:23:58 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:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:58 INFO - 'HOME': '/Users/cltbld', 16:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:58 INFO - 'LOGNAME': 'cltbld', 16:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:58 INFO - 'MOZ_NO_REMOTE': '1', 16:23:58 INFO - 'NO_EM_RESTART': '1', 16:23:58 INFO - 'PAGER': '/bin/cat', 16:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:58 INFO - 'PWD': '/builds/slave/test', 16:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:58 INFO - 'SHELL': '/bin/bash', 16:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:23:58 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:58 INFO - 'USER': 'cltbld', 16:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:58 INFO - 'XPC_FLAGS': '0x0', 16:23:58 INFO - 'XPC_SERVICE_NAME': '0', 16:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:58 INFO - Downloading/unpacking psutil>=3.1.1 16:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:02 INFO - Installing collected packages: psutil 16:24:02 INFO - Running setup.py install for psutil 16:24:02 INFO - building 'psutil._psutil_osx' extension 16:24:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:24:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:24:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:24:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:24:03 INFO - building 'psutil._psutil_posix' extension 16:24:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:24:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:24:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:24:03 INFO - ^ 16:24:03 INFO - 1 warning generated. 16:24:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:03 INFO - Successfully installed psutil 16:24:03 INFO - Cleaning up... 16:24:03 INFO - Return code: 0 16:24:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:03 INFO - 'HOME': '/Users/cltbld', 16:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:03 INFO - 'LOGNAME': 'cltbld', 16:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:03 INFO - 'MOZ_NO_REMOTE': '1', 16:24:03 INFO - 'NO_EM_RESTART': '1', 16:24:03 INFO - 'PAGER': '/bin/cat', 16:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:03 INFO - 'PWD': '/builds/slave/test', 16:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:03 INFO - 'SHELL': '/bin/bash', 16:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:03 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:03 INFO - 'USER': 'cltbld', 16:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:03 INFO - 'XPC_FLAGS': '0x0', 16:24:03 INFO - 'XPC_SERVICE_NAME': '0', 16:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:06 INFO - Installing collected packages: mozsystemmonitor 16:24:06 INFO - Running setup.py install for mozsystemmonitor 16:24:06 INFO - Successfully installed mozsystemmonitor 16:24:06 INFO - Cleaning up... 16:24:06 INFO - Return code: 0 16:24:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:06 INFO - 'HOME': '/Users/cltbld', 16:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:06 INFO - 'LOGNAME': 'cltbld', 16:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:06 INFO - 'MOZ_NO_REMOTE': '1', 16:24:06 INFO - 'NO_EM_RESTART': '1', 16:24:06 INFO - 'PAGER': '/bin/cat', 16:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:06 INFO - 'PWD': '/builds/slave/test', 16:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:06 INFO - 'SHELL': '/bin/bash', 16:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:06 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:06 INFO - 'USER': 'cltbld', 16:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:06 INFO - 'XPC_FLAGS': '0x0', 16:24:06 INFO - 'XPC_SERVICE_NAME': '0', 16:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:06 INFO - Downloading/unpacking jsonschema==2.5.1 16:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:09 INFO - warning: no files found matching '*.txt' 16:24:09 INFO - no previously-included directories found matching 'build' 16:24:09 INFO - no previously-included directories found matching 'dist' 16:24:09 INFO - no previously-included directories found matching '.git*' 16:24:09 INFO - Installing collected packages: jsonschema, functools32 16:24:09 INFO - Running setup.py install for functools32 16:24:10 INFO - warning: no files found matching '*.txt' 16:24:10 INFO - no previously-included directories found matching 'build' 16:24:10 INFO - no previously-included directories found matching 'dist' 16:24:10 INFO - no previously-included directories found matching '.git*' 16:24:10 INFO - Successfully installed jsonschema functools32 16:24:10 INFO - Cleaning up... 16:24:10 INFO - Return code: 0 16:24:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:24:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:10 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:10 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:24:10 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 functools32==3.2.3-2 16:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:10 INFO - 'HOME': '/Users/cltbld', 16:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:10 INFO - 'LOGNAME': 'cltbld', 16:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:10 INFO - 'MOZ_NO_REMOTE': '1', 16:24:10 INFO - 'NO_EM_RESTART': '1', 16:24:10 INFO - 'PAGER': '/bin/cat', 16:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:10 INFO - 'PWD': '/builds/slave/test', 16:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:10 INFO - 'SHELL': '/bin/bash', 16:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:10 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:10 INFO - 'USER': 'cltbld', 16:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:10 INFO - 'XPC_FLAGS': '0x0', 16:24:10 INFO - 'XPC_SERVICE_NAME': '0', 16:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:24:10 INFO - Cleaning up... 16:24:10 INFO - Return code: 0 16:24:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:24:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:10 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 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:10 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:24:10 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:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:10 INFO - 'HOME': '/Users/cltbld', 16:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:10 INFO - 'LOGNAME': 'cltbld', 16:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:10 INFO - 'MOZ_NO_REMOTE': '1', 16:24:10 INFO - 'NO_EM_RESTART': '1', 16:24:10 INFO - 'PAGER': '/bin/cat', 16:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:10 INFO - 'PWD': '/builds/slave/test', 16:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:10 INFO - 'SHELL': '/bin/bash', 16:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:10 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:10 INFO - 'USER': 'cltbld', 16:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:10 INFO - 'XPC_FLAGS': '0x0', 16:24:10 INFO - 'XPC_SERVICE_NAME': '0', 16:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:13 INFO - Downloading blobuploader-1.2.4.tar.gz 16:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:24:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:24:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:14 INFO - Downloading docopt-0.6.1.tar.gz 16:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:24:14 INFO - Installing collected packages: blobuploader, requests, docopt 16:24:14 INFO - Running setup.py install for blobuploader 16:24:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:24:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:24:14 INFO - Running setup.py install for requests 16:24:15 INFO - Running setup.py install for docopt 16:24:15 INFO - Successfully installed blobuploader requests docopt 16:24:15 INFO - Cleaning up... 16:24:15 INFO - Return code: 0 16:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 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 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:15 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:24:15 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:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:15 INFO - 'HOME': '/Users/cltbld', 16:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:15 INFO - 'LOGNAME': 'cltbld', 16:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:15 INFO - 'MOZ_NO_REMOTE': '1', 16:24:15 INFO - 'NO_EM_RESTART': '1', 16:24:15 INFO - 'PAGER': '/bin/cat', 16:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:15 INFO - 'PWD': '/builds/slave/test', 16:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:15 INFO - 'SHELL': '/bin/bash', 16:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:15 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:15 INFO - 'USER': 'cltbld', 16:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:15 INFO - 'XPC_FLAGS': '0x0', 16:24:15 INFO - 'XPC_SERVICE_NAME': '0', 16:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:15 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-Gxinn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:15 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-m_uTX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-QDlJhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-Xhb2Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-W44ZNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-YhAl1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-a6A72e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-F_nS7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-Dlp31a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-A7tExu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:16 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-WO4l76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5IWWKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-JU7bVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-S8YN7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-9tlPYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RSzk5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:17 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-tdcU9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:24:17 INFO - Running setup.py install for manifestparser 16:24:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:24:17 INFO - Running setup.py install for mozcrash 16:24:17 INFO - Running setup.py install for mozdebug 16:24:18 INFO - Running setup.py install for mozdevice 16:24:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Running setup.py install for mozfile 16:24:18 INFO - Running setup.py install for mozhttpd 16:24:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Running setup.py install for mozinfo 16:24:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Running setup.py install for mozInstall 16:24:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:18 INFO - Running setup.py install for mozleak 16:24:18 INFO - Running setup.py install for mozlog 16:24:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Running setup.py install for moznetwork 16:24:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Running setup.py install for mozprocess 16:24:19 INFO - Running setup.py install for mozprofile 16:24:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Running setup.py install for mozrunner 16:24:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:19 INFO - Running setup.py install for mozscreenshot 16:24:19 INFO - Running setup.py install for moztest 16:24:20 INFO - Running setup.py install for mozversion 16:24:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:20 INFO - Cleaning up... 16:24:20 INFO - Return code: 0 16:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:20 INFO - 'HOME': '/Users/cltbld', 16:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:20 INFO - 'LOGNAME': 'cltbld', 16:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:20 INFO - 'MOZ_NO_REMOTE': '1', 16:24:20 INFO - 'NO_EM_RESTART': '1', 16:24:20 INFO - 'PAGER': '/bin/cat', 16:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:20 INFO - 'PWD': '/builds/slave/test', 16:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:20 INFO - 'SHELL': '/bin/bash', 16:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:20 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:20 INFO - 'USER': 'cltbld', 16:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:20 INFO - 'XPC_FLAGS': '0x0', 16:24:20 INFO - 'XPC_SERVICE_NAME': '0', 16:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:20 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-6aAnTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:20 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:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:20 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-Ck_LX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:20 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-6OLyB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:20 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:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:20 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-6CpHGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-_xzW3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5lWazB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-F2NAYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-XxGfQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-mRSaLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-6tGjcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-5bb7C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-c8sFqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-D7rlay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:21 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:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:21 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-DoScZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:22 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-c2OZe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:22 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-oUhVe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:22 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-gZQKai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:24:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24: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:24: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:24: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:24: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:24: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:24: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:24:25 INFO - Downloading blessings-1.6.tar.gz 16:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:25 INFO - Installing collected packages: blessings 16:24:25 INFO - Running setup.py install for blessings 16:24:25 INFO - Successfully installed blessings 16:24:25 INFO - Cleaning up... 16:24:25 INFO - Return code: 0 16:24:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:25 INFO - Reading from file tmpfile_stdout 16:24:25 INFO - Current package versions: 16:24:25 INFO - blessings == 1.6 16:24:25 INFO - blobuploader == 1.2.4 16:24:25 INFO - docopt == 0.6.1 16:24:25 INFO - functools32 == 3.2.3-2 16:24:25 INFO - jsonschema == 2.5.1 16:24:25 INFO - manifestparser == 1.1 16:24:25 INFO - mozInstall == 1.12 16:24:25 INFO - mozcrash == 1.0 16:24:25 INFO - mozdebug == 0.1 16:24:25 INFO - mozdevice == 0.49 16:24:25 INFO - mozfile == 1.2 16:24:25 INFO - mozhttpd == 0.7 16:24:25 INFO - mozinfo == 0.9 16:24:25 INFO - mozleak == 0.1 16:24:25 INFO - mozlog == 3.4 16:24:25 INFO - moznetwork == 0.27 16:24:25 INFO - mozprocess == 0.25 16:24:25 INFO - mozprofile == 0.28 16:24:25 INFO - mozrunner == 6.13 16:24:25 INFO - mozscreenshot == 0.1 16:24:25 INFO - mozsystemmonitor == 0.3 16:24:25 INFO - moztest == 0.8 16:24:25 INFO - mozversion == 1.4 16:24:25 INFO - psutil == 3.1.1 16:24:25 INFO - requests == 1.2.3 16:24:25 INFO - wsgiref == 0.1.2 16:24:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:25 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 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:25 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:24:25 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:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:25 INFO - 'HOME': '/Users/cltbld', 16:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:25 INFO - 'LOGNAME': 'cltbld', 16:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:25 INFO - 'MOZ_NO_REMOTE': '1', 16:24:25 INFO - 'NO_EM_RESTART': '1', 16:24:25 INFO - 'PAGER': '/bin/cat', 16:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:25 INFO - 'PWD': '/builds/slave/test', 16:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:25 INFO - 'SHELL': '/bin/bash', 16:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:25 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:25 INFO - 'USER': 'cltbld', 16:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:25 INFO - 'XPC_FLAGS': '0x0', 16:24:25 INFO - 'XPC_SERVICE_NAME': '0', 16:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 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:24:25 INFO - Cleaning up... 16:24:25 INFO - Return code: 0 16:24:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107461b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107464768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea05cd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:26 INFO - 'HOME': '/Users/cltbld', 16:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:26 INFO - 'LOGNAME': 'cltbld', 16:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:26 INFO - 'MOZ_NO_REMOTE': '1', 16:24:26 INFO - 'NO_EM_RESTART': '1', 16:24:26 INFO - 'PAGER': '/bin/cat', 16:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:26 INFO - 'PWD': '/builds/slave/test', 16:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:26 INFO - 'SHELL': '/bin/bash', 16:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:26 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:26 INFO - 'USER': 'cltbld', 16:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:26 INFO - 'XPC_FLAGS': '0x0', 16:24:26 INFO - 'XPC_SERVICE_NAME': '0', 16:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:26 INFO - Cleaning up... 16:24:26 INFO - Return code: 0 16:24:26 INFO - Running post-action listener: _resource_record_post_action 16:24:26 INFO - Running post-action listener: _start_resource_monitoring 16:24:26 INFO - Starting resource monitoring. 16:24:26 INFO - [mozharness: 2017-02-23 00:24:26.286097Z] Finished create-virtualenv step (success) 16:24:26 INFO - [mozharness: 2017-02-23 00:24:26.287069Z] Running install step. 16:24:26 INFO - Running pre-action listener: _resource_record_pre_action 16:24:26 INFO - Running main action method: install 16:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:26 INFO - Reading from file tmpfile_stdout 16:24:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:26 INFO - Reading from file tmpfile_stdout 16:24:26 INFO - Output received: 16:24:26 INFO - Usage: mozinstall [options] installer 16:24:26 INFO - Options: 16:24:26 INFO - -h, --help show this help message and exit 16:24:26 INFO - -d DEST, --destination=DEST 16:24:26 INFO - Directory to install application into. [default: 16:24:26 INFO - "/builds/slave/test"] 16:24:26 INFO - --app=APP Application being installed. [default: firefox] 16:24:26 INFO - mkdir: /builds/slave/test/build/application 16:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:24:46 INFO - Reading from file tmpfile_stdout 16:24:46 INFO - Output received: 16:24:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:24:46 INFO - Running post-action listener: _resource_record_post_action 16:24:46 INFO - [mozharness: 2017-02-23 00:24:46.748066Z] Finished install step (success) 16:24:46 INFO - [mozharness: 2017-02-23 00:24:46.748195Z] Running run-tests step. 16:24:46 INFO - Running pre-action listener: _resource_record_pre_action 16:24:46 INFO - Running main action method: run_tests 16:24:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:24:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:24:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:24:46 INFO - 2017-02-22 16:24:46.763 screenresolution[1906:62368] starting screenresolution argv=screenresolution get 16:24:46 INFO - 2017-02-22 16:24:46.765 screenresolution[1906:62368] Display 0: 1600x1200x32@60 16:24:46 INFO - 2017-02-22 16:24:46.770 screenresolution[1907:62370] starting screenresolution argv=screenresolution list 16:24:46 INFO - Available Modes on Display 0 16:24:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:24:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:24:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:24:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:24:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:24:47 INFO - Intel Iris: 16:24:47 INFO - Chipset Model: Intel Iris 16:24:47 INFO - Type: GPU 16:24:47 INFO - Bus: Built-In 16:24:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:24:47 INFO - Vendor: Intel (0x8086) 16:24:47 INFO - Device ID: 0x0a2e 16:24:47 INFO - Revision ID: 0x0009 16:24:47 INFO - Displays: 16:24:47 INFO - Display: 16:24:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:24:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:24:47 INFO - Display Serial Number: 1600x1200 60 16:24:47 INFO - Main Display: Yes 16:24:47 INFO - Mirror: Off 16:24:47 INFO - Online: Yes 16:24:47 INFO - Rotation: Supported 16:24:47 INFO - Return code: 0 16:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:47 INFO - Python 2.7.3 16:24:47 INFO - Return code: 0 16:24:47 INFO - grabbing minidump binary from tooltool 16:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:47 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/macosx64/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 0x10723fd30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107234be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:47 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:24:47 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:24:47 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:24:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:47 INFO - Return code: 0 16:24:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:24:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:47 INFO - ENV: RUST_BACKTRACE is now 1 16:24:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:24:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0307 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AhdR2ncoHF/Render', 16:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:47 INFO - 'HOME': '/Users/cltbld', 16:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:47 INFO - 'LOGNAME': 'cltbld', 16:24:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:47 INFO - 'MOZ_NO_REMOTE': '1', 16:24:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:47 INFO - 'NO_EM_RESTART': '1', 16:24:47 INFO - 'PAGER': '/bin/cat', 16:24:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:47 INFO - 'PWD': '/builds/slave/test', 16:24:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:47 INFO - 'RUST_BACKTRACE': '1', 16:24:47 INFO - 'SHELL': '/bin/bash', 16:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners', 16:24:47 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 16:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:47 INFO - 'USER': 'cltbld', 16:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:47 INFO - 'XPC_FLAGS': '0x0', 16:24:47 INFO - 'XPC_SERVICE_NAME': '0', 16:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:24:47 INFO - mozversion application_buildid: 20170222145621 16:24:47 INFO - mozversion application_changeset: 499739e68fada7112afe8e5a9ce4744d1e4f07e6 16:24:47 INFO - mozversion application_display_name: Nightly 16:24:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:47 INFO - mozversion application_name: Firefox 16:24:47 INFO - mozversion application_remotingname: firefox 16:24:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:24:47 INFO - mozversion application_vendor: Mozilla 16:24:47 INFO - mozversion application_version: 54.0a1 16:24:47 INFO - mozversion platform_buildid: 20170222145621 16:24:47 INFO - mozversion platform_changeset: 499739e68fada7112afe8e5a9ce4744d1e4f07e6 16:24:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:24:47 INFO - mozversion platform_version: 54.0a1 16:24:47 INFO - using testdate: 1487809487 16:24:47 INFO - actual date: 1487809487 16:24:47 INFO - starting webserver on 'localhost:63178' 16:24:47 INFO - SUITE-START | Running 2 tests 16:24:47 INFO - TEST-START | dromaeo_css 16:24:47 INFO - operating with platform_type : mac_ 16:24:47 INFO - Initialising browser for dromaeo_css test... 16:24:47 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpAVS_i2/profile http://localhost:63178/getInfo.html) 16:24:49 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 16:24:49 INFO - PROCESS | 1917 | colorDepth:24 16:24:49 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 16:24:49 INFO - PROCESS | 1917 | __metrics 16:24:49 INFO - PROCESS | 1917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:24:49 INFO - PROCESS | 1917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:50 INFO - TEST-INFO | 1917: exit 0 16:24:50 INFO - Browser initialized. 16:24:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:50 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpAVS_i2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:03 INFO - PROCESS | 1919 | RSS: Main: 231256064 16:25:03 INFO - PROCESS | 1919 | 16:28:05 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63178/tests/dromaeo/cssquery-ext.html) 16:28:09 INFO - PROCESS | 1919 | RSS: Main: 557555712 16:28:09 INFO - PROCESS | 1919 | 16:29:52 INFO - PROCESS | 1919 | ************************* 16:29:52 INFO - PROCESS | 1919 | A coding exception was thrown and uncaught in a Task. 16:29:52 INFO - PROCESS | 1919 | 16:29:52 ERROR - PROCESS | 1919 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:29:52 INFO - PROCESS | 1919 | Full stack: 16:29:52 INFO - PROCESS | 1919 | ************************* 16:31:12 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-ext.html (next: http://localhost:63178/tests/dromaeo/cssquery-jquery.html) 16:31:12 INFO - PROCESS | 1919 | RSS: Main: 369373184 16:31:12 INFO - PROCESS | 1919 | 16:34:15 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63178/tests/dromaeo/cssquery-mootools.html) 16:34:16 INFO - PROCESS | 1919 | RSS: Main: 350756864 16:34:16 INFO - PROCESS | 1919 | 16:37:18 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63178/tests/dromaeo/cssquery-prototype.html) 16:37:19 INFO - PROCESS | 1919 | RSS: Main: 341319680 16:37:19 INFO - PROCESS | 1919 | 16:40:23 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63178/tests/dromaeo/cssquery-yui.html) 16:40:23 INFO - PROCESS | 1919 | RSS: Main: 339718144 16:40:23 INFO - PROCESS | 1919 | 16:43:26 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:63178/tests/dromaeo/cssquery-yui.html (next: http://localhost:63178/tests/dromaeo/cssquery-dojo.html) 16:43:27 INFO - PROCESS | 1919 | RSS: Main: 594452480 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | __start_tp_report 16:43:27 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 16:43:27 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 16:43:27 INFO - PROCESS | 1919 | |i|pagename|runs| 16:43:27 INFO - PROCESS | 1919 | |0;dojo.html;3231.91920201995;3258.6578409267026;3261.445554255776;3286.063471910506;3308.7683862129647;5383.542398896098;5471.699056551888;5554.139108438194;5584.553235741141;5673.404292549285;5435.293411856463;5505.834824955247;5507.862303442416;5511.255980442639;5519.199716041172;4235.915281694364;4970.130227210242;5014.8244811431605;5019.67372120811;5075.822346217883;5014.5737612303;5086.949130508703;5104;5114.897702045975;5115.283860259567;5073.898522029557;5077.669951453162;5078.035173317076;5078.847634570969;5109.080365534202;5110.616703747234;5111.003354345923;5119.872003199913;5123.359580052494;5129.204973229118;4915.016996600694;5042.773075211588;5056.089903817311;5065.062963351755;5066.645334826564;5549.1676248562635;5629;5629.521490673298;5658.886822263532;5671.092625179993;6072.119542666289;6086.6348019119;6096.0551114576865;6102.786402475892;6123.601965872249;5929.407059294079;5941.851453713649;6022.819315420501;6038.154658347835;6109.877802443926;5519.917201241985;5533.778648854041;5571.693556854412;5575.163725441175;5627.774889004476;6135.631862088289;6139.570230083851;6142.293636231891;6197.876042479125;6265.749370025148;6025.3974602540275;6039.305479869783;6048.032314829694;6050.788222412194;6086.786962456293;5873.676947767828;5974.581779275496;5977.880442391215;6004.54965877561;6145.385461453819;5074.49255074497;5826.271716035496;6018;6039.667818270037;6101.359357267512;4085.7752823594988;5762.827115186551;6031.306399764083;6039.456448919531;6044.637321760709;4754.572088512051;4846.927296090562;4849.248366503198;4856.4415092264135;4905.975470122627;4266.2960611499375;4348.891277718082;4352.260115780325;4352.325389564622;4364.672649551297;5615.550755939515;5619.7471113799975;5634.97182514093;5637.210790489335;5648.774049038075;6156.661383623854;6176;6204.627722336674;6206.875862482815;6213.5339849511465;4593.242115050979;5377.596680248997;5448.727563621803;5534.142207957773;5629.155626656035;5211.5049070338255;5236.973815130977;5245.370555533361;5250.212468129811;5263.789448422097;6198.752049917953;6202.100695399232;6202.503799696104;6202.782902598477;6223.502119830403;6091.664958427329;6091.878162436815;6092.69536523181;6094.847628809315;6102.206713127265;6195.380461953769;6225.470834979077;6227.657478838707;6229.750809967732;6229.906551401642;5843.678597677169;5892.7642894283745;5905.261842269716;5909.143174239625;5913.497352725067;6000.339962604197;6003.849903752266;6108.797423689574;6191.133241346125;6193.163922870535;4996.500349964975;5038.269450929668;5798.884022319446;5888.676122813286;6042.1843051187525;5691.77232910679;5762.366139724543;5969.04495280753;5989.221401217814;5995.850103747442;5592.468715472024;5703.173039909273;5720;5725.227094342211;5737.971310143423;4924.433690125681;5353.4646535346155;5418.918716219181;5853.473187413153;5872.442117998783;3994;5792.942070579409;5807.070868660994;5841.707914604338;5885.323187833283 16:43:27 INFO - PROCESS | 1919 | |1;ext.html;486.69095124595884;494.32524603915664;511.450191044627;526.931498905142;527.5199568392763;37130.814345928266;38912.41631375528;39145.80427097864;39200;39481.01297467565;40202.79391618256;40630.7968460158;40634.59365406345;40659;40665.593344066554;9158.633654653822;9316.254699624047;9357.344985850994;9374.203192728626;9394.953025234898;9117.49853758043;9198.080191980815;9210.217131543826;9230.261579073658;9235.769105772375;9216.30877684173;9249.537523123818;9256.120668536478;9274.44353338802;9275.582598783038;9216.953915230415;9241;9243.02948190437;9254.814903701888;9269.490178040205;9132.680356187502;9201.585928633227;9229.077092290785;9230.86153707695;9232.261419086457;36899.26201475982;37244.627553724386;37262;37306.25387492235;37310.44034339487;3668.633136686337;3704.253802281375;3710.091027698204;3732.5520937487404;3869.3228684980018;28630.713692863013;28866;29059.547022648996;29335.886724680102;29736.8513157435;3021.546767984798;3137.3254750228584;3235.835099364227;3248.2366643838677;3263.3310171414805;427666;430224.84887575987;430970;432226;435055;47090.293645595346;48433.75783121062;56229.43770562324;56375.71812140913;56573.32273402216;51776.74111629493;61197.38802612006;62487.0010399167;62591.06113408302;66475;14748.262586870827;14965.70068598622;15048.924755376152;15132;15179.013364131297;11604.593839215755;11746.353950532803;11752.11859110553;11755;11755.588554400725;12877.420516076612;16857.662846743;16870.409535666193;16887.577810554834;16923;4783.258594917794;5463.4263402342185;6802.489813264025;6810.557313774589;6855.691493882788;809.1988930958308;812.3866480806953;829.7966998085387;848.9617967191491;857.9485230886166;22154.88922555377;28028.71971280261;28251;28626.14121576356;28854.711452885622;1023.7645341571331;1052.21609900623;1054.7185170018465;1062.4953147254992;1071.6945670483874;13421.731565368638;14035.929820350833;14722.745719784287;14732.600402961702;14858.182799946107;554683;561876;562405;563912;563957;55049.72475137599;55299.44700552943;55357.72321138449;55390.89218215694;55407;1340.604521666111;1394.637394277495;1404.0873432268902;1406.69052808382;1408.0777091005407;26944.056958006375;27531.862340688167;27667.031653892016;28313.292167695974;28365.85817070984;46606.30090548577;46755.53244467648;46821.53178468172;46826.06347873092;46908.53091469042;347843;347866;347920;348505;348631;36296;37348.81325593355;37542;37554.812225938695;37645;41738.37392439055;42429.151416972105;42726.78636606922;42883.571164289206;43055.7847210762;29381.559276610442;29590.96431624883;33151.66848331486;33393.831215907325;34909.77815776537;29524.114276571738;33272.33455330928;34483.717650096616;35847.283054338244;36258.274834502634;27201.183964480304;34799.65200347964;35528.111797205274;35668.82165589155;35710.8214458926;26999.595006075317;29141.7085829139;31055.844720777157;31299.68700312968;31350.843245784537;21748.78251217531;22968.885155574782;23134;23475.94358253917;23573.764262357156 16:43:27 INFO - PROCESS | 1919 | |2;jquery.html;343.6803772491585;386.6500816760829;392.4015875789421;395.5451231084252;420.8463910672605;13040.673983150426;14169.433222671094;16829.15854207289;21585.56828863422;21659.025343859525;18904.069869170267;21299;21632.675509867324;22583.435414114654;22720.09119635217;5734.5125664318375;5882.6764527950945;5948.970255148718;6037.486813620848;6082.756689732428;3782.243551289753;5866.501347385477;6000.399960004008;6007.729652165663;6020.397960203988;3960.4059391091423;6202.3487533808975;6501.544891857572;6533.836654083639;6632.502562307822;5682.431756824326;6290.43386095249;6561.114249576294;6614.470842332626;6634.237062737799;5750.568707346965;5757.0788673811985;5757.769689212427;5757.884842303172;5758.971205143947;26192.214233573024;26856.731432685618;26927.92288308465;26932.09484624738;27209;2753.3116720819794;3116.766242531819;3133.749300056013;3152.2592190835135;3160.194150491633;15160.848391516165;15427.845721542753;15767.842321576753;15849.12829794361;16087.034777913246;1516.8938174327802;1767.6022894848556;1806.864485163618;1841.8066103059255;1842.68674325365;76356.61821690912;97280;124595.3770231143;126529;127508.72491275061;8294.58527073656;10804.837927431096;11159.27464714791;11401.543938242377;11635.825462618068;14825.70348593022;14846.109233446028;14876.776848347066;14883.33025013877;14892.404303827941;6998.440124790005;8189.549574773326;8447;8498.66005359791;8586.441881277697;8178.713745018896;8191.590420478952;8203.507789532647;8357.373197010249;8377.664893404195;6077.6961151943115;7097.92902070983;7166.703316474376;7195;7211.675474603656;1658.6516831465285;1928.2479832865195;1956.2664000999625;1976.1305025788606;1976.6046790641929;1009.421265141323;1050.581714685169;1051.4637534857277;1056.070657821128;1060.612876300145;22000.559988800134;22369.217077402212;22402.887985559966;22451.663225051638;22529.211477598205;1057.3338796558119;1062.4315990944963;1084.3331351218944;1085.2023762534532;1098.6154845803906;9205;10799.352038877692;11449.255798373246;11518.078553715683;11540.307581545134;331662;335612.32193839364;338100;364965;685132;112199;112452.43773781079;128128.35935820261;129437.35281323532;132844;936.1060187520901;994.4679596415883;1023.0434543701663;1024;1024.3546565663585;16587.502374928772;18136.818631813512;18503.81496185075;18526.629467410847;18861.528461788017;51548;51884.74057629688;52461.21308180304;53159.73420132875;53315.4668453326;73574.63212683902;82911;84226;84751;84873.57563212144;5721.713914304351;6158.661273629814;8068.677252910053;8105.230003149692;8193.631286592237;10794.596702428635;12674.366281685694;12856.871431285568;13213;13305.733885322046;10156.746081348025;10414.114800241761;11052.392118433563;11265.380404077854;11389.601363952223;10788.946055269673;10995;11116.333020018825;11299.322040677585;11425.942870285595;11351.659450216506;11360.715982100513;11782.587609433629;11787.823182652095;11850.703732406759;8232.62953167121;8414.789630259293;8451.746447606582;8466.74599762008;8509.702160424355;10150.13723833453;11162.386068766296;11465.197436179387;11500.53997840077;11511.251768635011 16:43:27 INFO - PROCESS | 1919 | |3;mootools.html;1365.4879420217417;1424.8931330150242;1447.3342262559215;1452.5424491285237;1463.7292100961322;6662;8472.957635211831;8477.406581539295;8480.533570653626;8482.787930301745;8068.878966815488;8332.041815191254;8352.749417517469;8447.36644751643;8452.704155354548;2258.062903894886;2299.5745787029455;2299.8620082795;2304.873231972241;2306.884655767213;1963.6956271777897;2255.8872056397113;2310.90756369745;2321.9071237150492;2323.6398358254414;1995.1919472613615;2025.5138766696034;2027.8174964253215;2027.959440811183;2029.9594008119902;1987.1951859496926;2188.6607575825774;2269.307861102363;2271.0915633746467;2281.406834223114;2290.7823756743082;2299.3331933739196;2300.9654855177187;2301.344116926668;2301.873396963166;6515.804525864231;7338.559686418832;8247.010358756988;8324.084350721416;8327.50034997902;4573.199690054227;4752.9762351188365;4756.31033500144;4756.762161891892;4772.284157376386;3413.9658603413895;3467.081223475781;3480.2343484433636;3539.3098345822573;3541.8052007139595;1213.7329787446836;1214.7995580729169;1223.8347823043864;1236.1038247270747;1257.1325785208269;10899.29154604948;10902;10982.835257471064;10985.01134897863;10990;3573.9285214296087;4354.390385346054;4481.641468682497;4485.147821913826;4486.484054333728;8675.262602678717;8715.520646364384;8720.607572659246;8725.781855453664;8730.69442569507;5105.489451054865;5106.744662766847;5112.4120726116225;5118.641695081308;5119.513646203679;4688.929666055012;4690.859274221779;4722.716637001791;4737.218358970731;4790.568848803624;3528.2943411317838;3547.2728090741334;3571.928561428757;3615.457681347819;3693.4644476550748;1122.680036189682;1128.8250321200228;1128.8917647644475;1131.8585176852894;1139.065965907964;792.8899540643146;827.841022568409;843.4896887383168;875.6541166239427;888.4136469929945;5250.212468129735;5374.5700343972385;5496.945030549723;5587.469190426984;5727.852055479195;911.2072496927715;927.2489283680105;973.6056896956744;985.9457729824785;1001.369137443406;3410.913123623125;3590.425531914881;3700.2599480104086;3718.572364178154;3724.6834019108137;9759.316847820726;10101.040401162025;10108.545115469822;10108.74728131788;10159.288849780445;10057.094861462358;10058.899411005943;10060.044295791888;10062.798744025078;10101.545430455648;7249.528780629243;7574.545527268381;7739.032620922385;7870.44906856526;7871.370290376756;5313.920291195558;5443.972780136074;5503.091989821634;5626.409227031267;5712.771489140554;9093.272538197061;9288.535573221447;9309.44143351401;9320.254379649747;9321.766955826159;9011.324150688593;9415;9450.149486546245;9469.621215151592;9478.431294122374;7160.820979475555;7299.343059124704;7308.671109800178;7313;7319.5242309249725;7833.686652533835;7852.018497687789;7897.526148431112;7930.246626570467;7933.1670174630835;5947.553933454921;6939.340762627744;7079.787606371817;7110.715571377294;7289.671964761705;6066.726997285221;6955.582665040114;7039.260877607982;7085.6457177141965;7088.893666594902;6254.312025677081;6417.486601071996;6418.486521078209;6422.197225346832;6423.357664233539;3765.4163604641326;3986.621270979252;4787.3776409066595;5046.8485945420225;5093.159628661378;4639.35049093134;4698.177818881751;4780.995990841823;4813.518648135158;4870.853874383774 16:43:27 INFO - PROCESS | 1919 | |4;prototype.html;352.15131533005456;358.8959201831469;359.07538089419745;361.2792479004387;367.69113944286795;4763.976180119103;4808.062427826575;4919.483454237307;5243;5319.627626066177;5138;5166.612504062192;5168.793248270074;5180.818671346504;5188.195829646411;3725.850965961365;3857.517810273716;3886.9028274293087;3892.377219644857;3940.8916229817055;3179.0780673604627;3600.5499312585926;3758.3422900992355;3877.3020856245867;3906.628870257321;3903.902402439933;3920.176762879799;3921.29416704993;3929.292727309083;3940.738963531671;3394.4908263760385;3666.9816650916573;3931.941020884689;3950.1902110067513;3957.960420395788;3370.9494357584654;3374.3926093303194;3380.4646515113664;3400.96599034009;3419.46998215277;4124.906320259805;4615.330777037344;4981.1532039553;4986.376702912136;5010.048090862724;3793.0465810107817;4004.7797371144575;4015.5984401559904;4447.866564003085;4461;4536.931946020813;4893.898872753638;5076.54311111998;5412.675239485604;5594.664320140804;3471.94792078119;3472.826358682056;3764.5106136202394;3774.320427409804;3777.131259810259;4908.64330691755;4966.491921579579;5096.515830996086;5739.971300143473;5759.285261006669;3186.8686616250898;3192.1859925718795;3609.458581212839;3621.8732344367822;3659.652333028358;3817.7900215488417;3820.369639009588;3826.3303921814127;3829.272438236782;3859.9614003860165;4422.690411671217;4423.203823311835;4447.310666846644;4465.955340446619;4478.552144785495;5239.947600524022;5452.345718513804;5472.2338872557875;5476.479734425223;5529.419410961871;1177.3289225141586;1228.7358217983176;1241.1250068701543;1256.6732649511193;1262.72851336963;736.6427282767853;841.884503033483;847.8050048488759;851.9616617252238;864.5417928497906;4378;4529.705569137996;4644.558766917205;4787.521247875255;4821.855344339605;4530.569595888385;4593.816247350135;4760.976195119071;5253.684778913277;5300.628955973045;4796.496367881392;4808.927866082012;4809.711417314972;4811.559734789642;4823.95176048235;2287.9885600572225;2437.926862194137;2619.59396293571;2716.673999120079;2809.735618971471;4821.841693690638;5166.948330516722;5507.339119305709;5529.695866727288;5551.750171242304;5094.6688465249645;5176.327077479904;5385.78456861729;5478.315210598676;5499.670019798825;4916.483769204254;5073.95562662407;5486.725663716878;5602.862397057661;5617.814728027645;4764.785584648768;5426.310109125832;5428.375736790162;5461.231750092424;5561.277033985556;4498.955010449854;5223.712695801767;5362.731863406736;5412.972935135299;5484.945150548443;5557.638753481173;5735.541156707537;5743.558987430409;5747.683877386784;5887.381824908323;4051.453053837812;4089.1003979124544;4092.4270602115134;4107.548169701271;4152.979235103805;4817.975910120427;4985.559963625087;5047.470015648304;5628.324601047901;5637.731510410125;4795.616350692006;5118.744062796771;5428.972855135699;5480.451954804487;5514.476124768141;5145.9228111579105;5396.0556902542685;5432.6468779529205;5434.375046869661;5443.700596467233;4914.795875010645;5290.338707661543;5337.797321607005;5376.650517716336;5407.83776486706;4030.3551431770775;5447.918281225706;5481.808136715196;5489.14564426504;5498.257735205856;4446.955530444783;4938.38270216223;5354.303940487867;5492.780288788404;5497.642653227527 16:43:27 INFO - PROCESS | 1919 | |5;yui.html;741.3513175971028;764.1288930619095;802.3901834605698;809.1625167951172;810.8662070758323;14690.63273418165;14991.625209369771;14998.325075371607;15054.84945150548;15065.32206050729;13562.118462299944;13602.251876146807;13620.931895340535;13624.114432561877;13628.591142265723;879.2131042716765;880.2297989259414;903.5798353765498;903.9819203615924;922.3313098003961;918.2516249256868;920.6363486422858;922.483409290796;924.7549399409128;926.6432423516961;805.8025783683006;899.5727029660924;933.2440723014346;952.0289304908989;952.105021279998;942.4392486470539;949.3449519831329;949.3876449689946;949.8622699708573;951.5289931483891;709.1490211745873;710.4387533848254;710.5452510393352;711.1608302203398;711.3206887422499;14887.478938237218;15141.621459463491;15261.771073433907;15654.452094176762;15669.451569195024;13539.59381218565;13623.523176688768;13729;13978.02153849231;14021.158730476203;11201.719957001058;11448.141389395829;11547.53809847605;12010;12050.819237711441;3589.975500305644;3633.564741926924;3637.3964213998356;3657.4330978698345;3668.5414323209598;92525.53737231271;102219.48890255575;102343.48828255886;104774.47612761964;105728;9482.668106616235;10629.25595208328;10744.623938162284;10781.460926953621;10817.945910270399;21806;22073.896305184677;22202.888985554968;22216.222432214796;22265.888670556542;7075.469339799535;7100.041494398293;7162.606056666829;7268.345848873521;7326.194118646945;3899;4071.3892916062828;4164.021454958082;4167.499900012018;4333.58830911063;3142.3558170575434;3280.2291461506525;3652.068722475805;3660;3695.1870588470492;674.3458844920419;675.7297081167474;684.2370756606448;691.7198534593498;694.4860803005739;626.5301024231826;657.4740207833714;662.3105742331527;674.8650269945932;696.1611258433576;9277.93424889714;9596.90403095974;9712.22302215821;9887.258455615858;9989.850152247722;638.4445532386853;641.086357223687;656.8784774816579;678.1997243253008;681.3765404654785;4415.381846541487;4521.61566266871;4613.777349002517;4746.620270378361;4771.812047211634;98262.50868745611;100364;102023.48988255011;103183.96816031894;105544.94455055505;84485.57757211174;84790.57604711936;86250;86502.56748716216;86666;64238;65737.67131164313;75883;76905.34148706781;77585.61207193928;8970.416922900251;9137.5888085035;9316.860247096434;9381.249500040118;9384.085119136711;31862.681373185973;42644.78677606592;43492.347614786435;44544;46254.37456254482;60944.695276523336;65500;69775.30224697688;70205;71034.28965710277;12260.816087758512;12346.753064938472;12438.689032774253;13164.00666984292;13390.995675324195;13634.590962271148;13886.09740366873;13940.58178254654;14066.156030638194;14102.647433814236;12719.745605088032;13079.803802942773;13082.345882706017;13102.803457948328;13221.603351899459;11236.044936180517;12463.376831158586;12845;13177.370015320494;13284.86715132875;10865.130789536975;12401.565945191875;12665.620031399072;12801.679958001125;13008.901247572334;10112.465552769374;10396.16830653561;10497.895021049691;10585.100266477435;10699.251052426256;8375.20435558621;8781.429207101519;9278.304127190622;10353.482325883826;10436.843447348449 16:43:27 INFO - PROCESS | 1919 | __end_tp_report 16:43:27 INFO - PROCESS | 1919 | __start_cc_report 16:43:27 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,3994 16:43:27 INFO - PROCESS | 1919 | __end_cc_report 16:43:27 INFO - PROCESS | 1919 | __startTimestamp1487810607167__endTimestamp 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | ------- Summary: start ------- 16:43:27 INFO - PROCESS | 1919 | Number of tests: 6 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#0] dojo.html Cycles:165 Average:5532.08 Median:5671.09 stddev:656.85 (11.6%) stddev-sans-first:633.59 16:43:27 INFO - PROCESS | 1919 | Values: 3231.9 3258.7 3261.4 3286.1 3308.8 5383.5 5471.7 5554.1 5584.6 5673.4 5435.3 5505.8 5507.9 5511.3 5519.2 4235.9 4970.1 5014.8 5019.7 5075.8 5014.6 5086.9 5104.0 5114.9 5115.3 5073.9 5077.7 5078.0 5078.8 5109.1 5110.6 5111.0 5119.9 5123.4 5129.2 4915.0 5042.8 5056.1 5065.1 5066.6 5549.2 5629.0 5629.5 5658.9 5671.1 6072.1 6086.6 6096.1 6102.8 6123.6 5929.4 5941.9 6022.8 6038.2 6109.9 5519.9 5533.8 5571.7 5575.2 5627.8 6135.6 6139.6 6142.3 6197.9 6265.7 6025.4 6039.3 6048.0 6050.8 6086.8 5873.7 5974.6 5977.9 6004.5 6145.4 5074.5 5826.3 6018.0 6039.7 6101.4 4085.8 5762.8 6031.3 6039.5 6044.6 4754.6 4846.9 4849.2 4856.4 4906.0 4266.3 4348.9 4352.3 4352.3 4364.7 5615.6 5619.7 5635.0 5637.2 5648.8 6156.7 6176.0 6204.6 6206.9 6213.5 4593.2 5377.6 5448.7 5534.1 5629.2 5211.5 5237.0 5245.4 5250.2 5263.8 6198.8 6202.1 6202.5 6202.8 6223.5 6091.7 6091.9 6092.7 6094.8 6102.2 6195.4 6225.5 6227.7 6229.8 6229.9 5843.7 5892.8 5905.3 5909.1 5913.5 6000.3 6003.8 6108.8 6191.1 6193.2 4996.5 5038.3 5798.9 5888.7 6042.2 5691.8 5762.4 5969.0 5989.2 5995.9 5592.5 5703.2 5720.0 5725.2 5738.0 4924.4 5353.5 5418.9 5853.5 5872.4 3994.0 5792.9 5807.1 5841.7 5885.3 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#1] ext.html Cycles:180 Average:58613.10 Median:20540.68 stddev:121286.89 (590.5%) stddev-sans-first:121548.61 16:43:27 INFO - PROCESS | 1919 | Values: 486.7 494.3 511.5 526.9 527.5 37130.8 38912.4 39145.8 39200.0 39481.0 40202.8 40630.8 40634.6 40659.0 40665.6 9158.6 9316.3 9357.3 9374.2 9395.0 9117.5 9198.1 9210.2 9230.3 9235.8 9216.3 9249.5 9256.1 9274.4 9275.6 9217.0 9241.0 9243.0 9254.8 9269.5 9132.7 9201.6 9229.1 9230.9 9232.3 36899.3 37244.6 37262.0 37306.3 37310.4 3668.6 3704.3 3710.1 3732.6 3869.3 28630.7 28866.0 29059.5 29335.9 29736.9 3021.5 3137.3 3235.8 3248.2 3263.3 427666.0 430224.8 430970.0 432226.0 435055.0 47090.3 48433.8 56229.4 56375.7 56573.3 51776.7 61197.4 62487.0 62591.1 66475.0 14748.3 14965.7 15048.9 15132.0 15179.0 11604.6 11746.4 11752.1 11755.0 11755.6 12877.4 16857.7 16870.4 16887.6 16923.0 4783.3 5463.4 6802.5 6810.6 6855.7 809.2 812.4 829.8 849.0 857.9 22154.9 28028.7 28251.0 28626.1 28854.7 1023.8 1052.2 1054.7 1062.5 1071.7 13421.7 14035.9 14722.7 14732.6 14858.2 554683.0 561876.0 562405.0 563912.0 563957.0 55049.7 55299.4 55357.7 55390.9 55407.0 1340.6 1394.6 1404.1 1406.7 1408.1 26944.1 27531.9 27667.0 28313.3 28365.9 46606.3 46755.5 46821.5 46826.1 46908.5 347843.0 347866.0 347920.0 348505.0 348631.0 36296.0 37348.8 37542.0 37554.8 37645.0 41738.4 42429.2 42726.8 42883.6 43055.8 29381.6 29591.0 33151.7 33393.8 34909.8 29524.1 33272.3 34483.7 35847.3 36258.3 27201.2 34799.7 35528.1 35668.8 35710.8 26999.6 29141.7 31055.8 31299.7 31350.8 21748.8 22968.9 23134.0 23475.9 23573.8 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#2] jquery.html Cycles:180 Average:29819.56 Median:22490.44 stddev:74261.28 (330.2%) stddev-sans-first:74436.62 16:43:27 INFO - PROCESS | 1919 | Values: 343.7 386.7 392.4 395.5 420.8 13040.7 14169.4 16829.2 21585.6 21659.0 18904.1 21299.0 21632.7 22583.4 22720.1 5734.5 5882.7 5949.0 6037.5 6082.8 3782.2 5866.5 6000.4 6007.7 6020.4 3960.4 6202.3 6501.5 6533.8 6632.5 5682.4 6290.4 6561.1 6614.5 6634.2 5750.6 5757.1 5757.8 5757.9 5759.0 26192.2 26856.7 26927.9 26932.1 27209.0 2753.3 3116.8 3133.7 3152.3 3160.2 15160.8 15427.8 15767.8 15849.1 16087.0 1516.9 1767.6 1806.9 1841.8 1842.7 76356.6 97280.0 124595.4 126529.0 127508.7 8294.6 10804.8 11159.3 11401.5 11635.8 14825.7 14846.1 14876.8 14883.3 14892.4 6998.4 8189.5 8447.0 8498.7 8586.4 8178.7 8191.6 8203.5 8357.4 8377.7 6077.7 7097.9 7166.7 7195.0 7211.7 1658.7 1928.2 1956.3 1976.1 1976.6 1009.4 1050.6 1051.5 1056.1 1060.6 22000.6 22369.2 22402.9 22451.7 22529.2 1057.3 1062.4 1084.3 1085.2 1098.6 9205.0 10799.4 11449.3 11518.1 11540.3 331662.0 335612.3 338100.0 364965.0 685132.0 112199.0 112452.4 128128.4 129437.4 132844.0 936.1 994.5 1023.0 1024.0 1024.4 16587.5 18136.8 18503.8 18526.6 18861.5 51548.0 51884.7 52461.2 53159.7 53315.5 73574.6 82911.0 84226.0 84751.0 84873.6 5721.7 6158.7 8068.7 8105.2 8193.6 10794.6 12674.4 12856.9 13213.0 13305.7 10156.7 10414.1 11052.4 11265.4 11389.6 10788.9 10995.0 11116.3 11299.3 11425.9 11351.7 11360.7 11782.6 11787.8 11850.7 8232.6 8414.8 8451.7 8466.7 8509.7 10150.1 11162.4 11465.2 11500.5 11511.3 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#3] mootools.html Cycles:180 Average:5334.49 Median:4802.04 stddev:2969.49 (61.8%) stddev-sans-first:2962.84 16:43:27 INFO - PROCESS | 1919 | Values: 1365.5 1424.9 1447.3 1452.5 1463.7 6662.0 8473.0 8477.4 8480.5 8482.8 8068.9 8332.0 8352.7 8447.4 8452.7 2258.1 2299.6 2299.9 2304.9 2306.9 1963.7 2255.9 2310.9 2321.9 2323.6 1995.2 2025.5 2027.8 2028.0 2030.0 1987.2 2188.7 2269.3 2271.1 2281.4 2290.8 2299.3 2301.0 2301.3 2301.9 6515.8 7338.6 8247.0 8324.1 8327.5 4573.2 4753.0 4756.3 4756.8 4772.3 3414.0 3467.1 3480.2 3539.3 3541.8 1213.7 1214.8 1223.8 1236.1 1257.1 10899.3 10902.0 10982.8 10985.0 10990.0 3573.9 4354.4 4481.6 4485.1 4486.5 8675.3 8715.5 8720.6 8725.8 8730.7 5105.5 5106.7 5112.4 5118.6 5119.5 4688.9 4690.9 4722.7 4737.2 4790.6 3528.3 3547.3 3571.9 3615.5 3693.5 1122.7 1128.8 1128.9 1131.9 1139.1 792.9 827.8 843.5 875.7 888.4 5250.2 5374.6 5496.9 5587.5 5727.9 911.2 927.2 973.6 985.9 1001.4 3410.9 3590.4 3700.3 3718.6 3724.7 9759.3 10101.0 10108.5 10108.7 10159.3 10057.1 10058.9 10060.0 10062.8 10101.5 7249.5 7574.5 7739.0 7870.4 7871.4 5313.9 5444.0 5503.1 5626.4 5712.8 9093.3 9288.5 9309.4 9320.3 9321.8 9011.3 9415.0 9450.1 9469.6 9478.4 7160.8 7299.3 7308.7 7313.0 7319.5 7833.7 7852.0 7897.5 7930.2 7933.2 5947.6 6939.3 7079.8 7110.7 7289.7 6066.7 6955.6 7039.3 7085.6 7088.9 6254.3 6417.5 6418.5 6422.2 6423.4 3765.4 3986.6 4787.4 5046.8 5093.2 4639.4 4698.2 4781.0 4813.5 4870.9 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#4] prototype.html Cycles:180 Average:4334.17 Median:4814.77 stddev:1324.46 (27.5%) stddev-sans-first:1294.01 16:43:27 INFO - PROCESS | 1919 | Values: 352.2 358.9 359.1 361.3 367.7 4764.0 4808.1 4919.5 5243.0 5319.6 5138.0 5166.6 5168.8 5180.8 5188.2 3725.9 3857.5 3886.9 3892.4 3940.9 3179.1 3600.5 3758.3 3877.3 3906.6 3903.9 3920.2 3921.3 3929.3 3940.7 3394.5 3667.0 3931.9 3950.2 3958.0 3370.9 3374.4 3380.5 3401.0 3419.5 4124.9 4615.3 4981.2 4986.4 5010.0 3793.0 4004.8 4015.6 4447.9 4461.0 4536.9 4893.9 5076.5 5412.7 5594.7 3471.9 3472.8 3764.5 3774.3 3777.1 4908.6 4966.5 5096.5 5740.0 5759.3 3186.9 3192.2 3609.5 3621.9 3659.7 3817.8 3820.4 3826.3 3829.3 3860.0 4422.7 4423.2 4447.3 4466.0 4478.6 5239.9 5452.3 5472.2 5476.5 5529.4 1177.3 1228.7 1241.1 1256.7 1262.7 736.6 841.9 847.8 852.0 864.5 4378.0 4529.7 4644.6 4787.5 4821.9 4530.6 4593.8 4761.0 5253.7 5300.6 4796.5 4808.9 4809.7 4811.6 4824.0 2288.0 2437.9 2619.6 2716.7 2809.7 4821.8 5166.9 5507.3 5529.7 5551.8 5094.7 5176.3 5385.8 5478.3 5499.7 4916.5 5074.0 5486.7 5602.9 5617.8 4764.8 5426.3 5428.4 5461.2 5561.3 4499.0 5223.7 5362.7 5413.0 5484.9 5557.6 5735.5 5743.6 5747.7 5887.4 4051.5 4089.1 4092.4 4107.5 4153.0 4818.0 4985.6 5047.5 5628.3 5637.7 4795.6 5118.7 5429.0 5480.5 5514.5 5145.9 5396.1 5432.6 5434.4 5443.7 4914.8 5290.3 5337.8 5376.7 5407.8 4030.4 5447.9 5481.8 5489.1 5498.3 4447.0 4938.4 5354.3 5492.8 5497.6 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - PROCESS | 1919 | [#5] yui.html Cycles:180 Average:19613.38 Median:23912.97 stddev:28309.43 (118.4%) stddev-sans-first:28353.38 16:43:27 INFO - PROCESS | 1919 | Values: 741.4 764.1 802.4 809.2 810.9 14690.6 14991.6 14998.3 15054.8 15065.3 13562.1 13602.3 13620.9 13624.1 13628.6 879.2 880.2 903.6 904.0 922.3 918.3 920.6 922.5 924.8 926.6 805.8 899.6 933.2 952.0 952.1 942.4 949.3 949.4 949.9 951.5 709.1 710.4 710.5 711.2 711.3 14887.5 15141.6 15261.8 15654.5 15669.5 13539.6 13623.5 13729.0 13978.0 14021.2 11201.7 11448.1 11547.5 12010.0 12050.8 3590.0 3633.6 3637.4 3657.4 3668.5 92525.5 102219.5 102343.5 104774.5 105728.0 9482.7 10629.3 10744.6 10781.5 10817.9 21806.0 22073.9 22202.9 22216.2 22265.9 7075.5 7100.0 7162.6 7268.3 7326.2 3899.0 4071.4 4164.0 4167.5 4333.6 3142.4 3280.2 3652.1 3660.0 3695.2 674.3 675.7 684.2 691.7 694.5 626.5 657.5 662.3 674.9 696.2 9277.9 9596.9 9712.2 9887.3 9989.9 638.4 641.1 656.9 678.2 681.4 4415.4 4521.6 4613.8 4746.6 4771.8 98262.5 100364.0 102023.5 103184.0 105544.9 84485.6 84790.6 86250.0 86502.6 86666.0 64238.0 65737.7 75883.0 76905.3 77585.6 8970.4 9137.6 9316.9 9381.2 9384.1 31862.7 42644.8 43492.3 44544.0 46254.4 60944.7 65500.0 69775.3 70205.0 71034.3 12260.8 12346.8 12438.7 13164.0 13391.0 13634.6 13886.1 13940.6 14066.2 14102.6 12719.7 13079.8 13082.3 13102.8 13221.6 11236.0 12463.4 12845.0 13177.4 13284.9 10865.1 12401.6 12665.6 12801.7 13008.9 10112.5 10396.2 10497.9 10585.1 10699.3 8375.2 8781.4 9278.3 10353.5 10436.8 16:43:27 INFO - PROCESS | 1919 | -------- Summary: end -------- 16:43:27 INFO - PROCESS | 1919 | 16:43:27 INFO - TEST-INFO | 1919: exit 0 16:43:27 INFO - TEST-OK | dromaeo_css | took 1120547ms 16:43:27 INFO - TEST-START | kraken 16:43:27 INFO - operating with platform_type : mac_ 16:43:27 INFO - Initialising browser for kraken test... 16:43:27 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmphn5VO3/profile http://localhost:63178/getInfo.html) 16:43:30 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 16:43:30 INFO - PROCESS | 1925 | colorDepth:24 16:43:30 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 16:43:30 INFO - PROCESS | 1925 | __metrics 16:43:30 INFO - PROCESS | 1925 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:43:30 INFO - PROCESS | 1925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:31 INFO - TEST-INFO | 1925: exit 0 16:43:31 INFO - Browser initialized. 16:43:31 INFO - Running cycle 1/1 for kraken test... 16:43:31 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmphn5VO3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:43 INFO - PROCESS | 1926 | RSS: Main: 232202240 16:43:43 INFO - PROCESS | 1926 | 16:43:46 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63178/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:47 INFO - PROCESS | 1926 | RSS: Main: 284098560 16:43:47 INFO - PROCESS | 1926 | 16:43:49 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63178/tests/kraken/driver.html?testName=audio-dft) 16:43:50 INFO - PROCESS | 1926 | RSS: Main: 286199808 16:43:50 INFO - PROCESS | 1926 | 16:43:53 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63178/tests/kraken/driver.html?testName=audio-fft) 16:43:54 INFO - PROCESS | 1926 | RSS: Main: 377880576 16:43:54 INFO - PROCESS | 1926 | 16:43:56 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63178/tests/kraken/driver.html?testName=audio-oscillator) 16:43:57 INFO - PROCESS | 1926 | RSS: Main: 282734592 16:43:57 INFO - PROCESS | 1926 | 16:43:59 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63178/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:59 INFO - PROCESS | 1926 | RSS: Main: 285478912 16:43:59 INFO - PROCESS | 1926 | 16:44:02 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63178/tests/kraken/driver.html?testName=imaging-darkroom) 16:44:03 INFO - PROCESS | 1926 | RSS: Main: 328540160 16:44:03 INFO - PROCESS | 1926 | 16:44:06 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63178/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:06 INFO - PROCESS | 1926 | RSS: Main: 329519104 16:44:06 INFO - PROCESS | 1926 | 16:44:09 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63178/tests/kraken/driver.html?testName=json-parse-financial) 16:44:10 INFO - PROCESS | 1926 | RSS: Main: 327581696 16:44:10 INFO - PROCESS | 1926 | 16:44:12 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63178/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:12 INFO - PROCESS | 1926 | RSS: Main: 301015040 16:44:12 INFO - PROCESS | 1926 | 16:44:14 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:15 INFO - PROCESS | 1926 | RSS: Main: 305274880 16:44:15 INFO - PROCESS | 1926 | 16:44:17 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:18 INFO - PROCESS | 1926 | RSS: Main: 306970624 16:44:18 INFO - PROCESS | 1926 | 16:44:21 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:22 INFO - PROCESS | 1926 | RSS: Main: 324780032 16:44:22 INFO - PROCESS | 1926 | 16:44:25 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:25 INFO - PROCESS | 1926 | RSS: Main: 319328256 16:44:25 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:63178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63178/tests/kraken/driver.html?testName=ai-astar) 16:44:27 INFO - PROCESS | 1926 | RSS: Main: 364314624 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | __start_tp_report 16:44:27 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 16:44:27 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 16:44:27 INFO - PROCESS | 1926 | |i|pagename|runs| 16:44:27 INFO - PROCESS | 1926 | |0;ai-astar;115;114;114;113;114;114;114;113;113;113 16:44:27 INFO - PROCESS | 1926 | |1;audio-beat-detection;147;116;111;151;114;135;139;141;135;114 16:44:27 INFO - PROCESS | 1926 | |2;audio-dft;187;187;186;187;185;184;183;185;183;183 16:44:27 INFO - PROCESS | 1926 | |3;audio-fft;82;60;63;94;64;59;61;62;81;62 16:44:27 INFO - PROCESS | 1926 | |4;audio-oscillator;91;57;90;99;102;103;121;67;68;86 16:44:27 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;92;136;89;89;89;88;89;88;89;88 16:44:27 INFO - PROCESS | 1926 | |6;imaging-darkroom;96;96;96;96;97;96;97;97;96;96 16:44:27 INFO - PROCESS | 1926 | |7;imaging-desaturate;87;84;104;132;141;86;85;95;85;85 16:44:27 INFO - PROCESS | 1926 | |8;json-parse-financial;60;60;60;59;58;58;58;57;57;57 16:44:27 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;65;71;75;73;71;69;68;68;68;69 16:44:27 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;82;77;81;98;96;108;86;90;90;90 16:44:27 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;140;142;155;144;141;142;141;144;184;140 16:44:27 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;175;172;176;175;173;175;173;193;233;196 16:44:27 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;69;68;65;66;67;68;67;68;65;66 16:44:27 INFO - PROCESS | 1926 | __end_tp_report 16:44:27 INFO - PROCESS | 1926 | __start_cc_report 16:44:27 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,2164 16:44:27 INFO - PROCESS | 1926 | __end_cc_report 16:44:27 INFO - PROCESS | 1926 | __startTimestamp1487810667719__endTimestamp 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | ------- Summary: start ------- 16:44:27 INFO - PROCESS | 1926 | Number of tests: 14 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 16:44:27 INFO - PROCESS | 1926 | Values: 115.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:137.00 stddev:15.09 (11.0%) stddev-sans-first:14.75 16:44:27 INFO - PROCESS | 1926 | Values: 147.0 116.0 111.0 151.0 114.0 135.0 139.0 141.0 135.0 114.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:1.70 (0.9%) stddev-sans-first:1.64 16:44:27 INFO - PROCESS | 1926 | Values: 187.0 187.0 186.0 187.0 185.0 184.0 183.0 185.0 183.0 183.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:68.80 Median:63.50 stddev:12.21 (19.2%) stddev-sans-first:11.98 16:44:27 INFO - PROCESS | 1926 | Values: 82.0 60.0 63.0 94.0 64.0 59.0 61.0 62.0 81.0 62.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:77.00 stddev:19.57 (25.4%) stddev-sans-first:20.74 16:44:27 INFO - PROCESS | 1926 | Values: 91.0 57.0 90.0 99.0 102.0 103.0 121.0 67.0 68.0 86.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:89.00 stddev:14.91 (16.7%) stddev-sans-first:15.80 16:44:27 INFO - PROCESS | 1926 | Values: 92.0 136.0 89.0 89.0 89.0 88.0 89.0 88.0 89.0 88.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:44:27 INFO - PROCESS | 1926 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:85.00 stddev:21.13 (24.9%) stddev-sans-first:22.00 16:44:27 INFO - PROCESS | 1926 | Values: 87.0 84.0 104.0 132.0 141.0 86.0 85.0 95.0 85.0 85.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:1.26 (2.2%) stddev-sans-first:1.20 16:44:27 INFO - PROCESS | 1926 | Values: 60.0 60.0 60.0 59.0 58.0 58.0 58.0 57.0 57.0 57.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:2.87 (4.1%) stddev-sans-first:2.49 16:44:27 INFO - PROCESS | 1926 | Values: 65.0 71.0 75.0 73.0 71.0 69.0 68.0 68.0 68.0 69.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:90.00 stddev:9.15 (10.2%) stddev-sans-first:9.26 16:44:27 INFO - PROCESS | 1926 | Values: 82.0 77.0 81.0 98.0 96.0 108.0 86.0 90.0 90.0 90.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:143.00 stddev:13.62 (9.5%) stddev-sans-first:14.19 16:44:27 INFO - PROCESS | 1926 | Values: 140.0 142.0 155.0 144.0 141.0 142.0 141.0 144.0 184.0 140.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.10 Median:175.50 stddev:19.20 (10.9%) stddev-sans-first:20.08 16:44:27 INFO - PROCESS | 1926 | Values: 175.0 172.0 176.0 175.0 173.0 175.0 173.0 193.0 233.0 196.0 16:44:27 INFO - PROCESS | 1926 | 16:44:27 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.37 (2.0%) stddev-sans-first:1.22 16:44:27 INFO - PROCESS | 1926 | Values: 69.0 68.0 65.0 66.0 67.0 68.0 67.0 68.0 65.0 66.0 16:44:27 INFO - PROCESS | 1926 | -------- Summary: end -------- 16:44:27 INFO - PROCESS | 1926 | 16:44:28 INFO - TEST-INFO | 1926: exit 0 16:44:28 INFO - TEST-OK | kraken | took 60861ms 16:44:28 INFO - SUITE-END | took 1181s 16:44:28 INFO - Completed test suite (00:19:41) 16:44:28 INFO - javascript benchmark 16:44:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7060.601611203377, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3231.91920201995, 3258.6578409267026, 3261.445554255776, 3286.063471910506, 3308.7683862129647, 5383.542398896098, 5471.699056551888, 5554.139108438194, 5584.553235741141, 5673.404292549285, 5435.293411856463, 5505.834824955247, 5507.862303442416, 5511.255980442639, 5519.199716041172, 4235.915281694364, 4970.130227210242, 5014.8244811431605, 5019.67372120811, 5075.822346217883, 5014.5737612303, 5086.949130508703, 5104.0, 5114.897702045975, 5115.283860259567, 5073.898522029557, 5077.669951453162, 5078.035173317076, 5078.847634570969, 5109.080365534202, 5110.616703747234, 5111.003354345923, 5119.872003199913, 5123.359580052494, 5129.204973229118, 4915.016996600694, 5042.773075211588, 5056.089903817311, 5065.062963351755, 5066.645334826564, 5549.1676248562635, 5629.0, 5629.521490673298, 5658.886822263532, 5671.092625179993, 6072.119542666289, 6086.6348019119, 6096.0551114576865, 6102.786402475892, 6123.601965872249, 5929.407059294079, 5941.851453713649, 6022.819315420501, 6038.154658347835, 6109.877802443926, 5519.917201241985, 5533.778648854041, 5571.693556854412, 5575.163725441175, 5627.774889004476, 6135.631862088289, 6139.570230083851, 6142.293636231891, 6197.876042479125, 6265.749370025148, 6025.3974602540275, 6039.305479869783, 6048.032314829694, 6050.788222412194, 6086.786962456293, 5873.676947767828, 5974.581779275496, 5977.880442391215, 6004.54965877561, 6145.385461453819, 5074.49255074497, 5826.271716035496, 6018.0, 6039.667818270037, 6101.359357267512, 4085.7752823594988, 5762.827115186551, 6031.306399764083, 6039.456448919531, 6044.637321760709, 4754.572088512051, 4846.927296090562, 4849.248366503198, 4856.4415092264135, 4905.975470122627, 4266.2960611499375, 4348.891277718082, 4352.260115780325, 4352.325389564622, 4364.672649551297, 5615.550755939515, 5619.7471113799975, 5634.97182514093, 5637.210790489335, 5648.774049038075, 6156.661383623854, 6176.0, 6204.627722336674, 6206.875862482815, 6213.5339849511465, 4593.242115050979, 5377.596680248997, 5448.727563621803, 5534.142207957773, 5629.155626656035, 5211.5049070338255, 5236.973815130977, 5245.370555533361, 5250.212468129811, 5263.789448422097, 6198.752049917953, 6202.100695399232, 6202.503799696104, 6202.782902598477, 6223.502119830403, 6091.664958427329, 6091.878162436815, 6092.69536523181, 6094.847628809315, 6102.206713127265, 6195.380461953769, 6225.470834979077, 6227.657478838707, 6229.750809967732, 6229.906551401642, 5843.678597677169, 5892.7642894283745, 5905.261842269716, 5909.143174239625, 5913.497352725067, 6000.339962604197, 6003.849903752266, 6108.797423689574, 6191.133241346125, 6193.163922870535, 4996.500349964975, 5038.269450929668, 5798.884022319446, 5888.676122813286, 6042.1843051187525, 5691.77232910679, 5762.366139724543, 5969.04495280753, 5989.221401217814, 5995.850103747442, 5592.468715472024, 5703.173039909273, 5720.0, 5725.227094342211, 5737.971310143423, 4924.433690125681, 5353.4646535346155, 5418.918716219181, 5853.473187413153, 5872.442117998783, 3994.0, 5792.942070579409, 5807.070868660994, 5841.707914604338, 5885.323187833283], "value": 5492.694889694147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.69095124595884, 494.32524603915664, 511.450191044627, 526.931498905142, 527.5199568392763, 37130.814345928266, 38912.41631375528, 39145.80427097864, 39200.0, 39481.01297467565, 40202.79391618256, 40630.7968460158, 40634.59365406345, 40659.0, 40665.593344066554, 9158.633654653822, 9316.254699624047, 9357.344985850994, 9374.203192728626, 9394.953025234898, 9117.49853758043, 9198.080191980815, 9210.217131543826, 9230.261579073658, 9235.769105772375, 9216.30877684173, 9249.537523123818, 9256.120668536478, 9274.44353338802, 9275.582598783038, 9216.953915230415, 9241.0, 9243.02948190437, 9254.814903701888, 9269.490178040205, 9132.680356187502, 9201.585928633227, 9229.077092290785, 9230.86153707695, 9232.261419086457, 36899.26201475982, 37244.627553724386, 37262.0, 37306.25387492235, 37310.44034339487, 3668.633136686337, 3704.253802281375, 3710.091027698204, 3732.5520937487404, 3869.3228684980018, 28630.713692863013, 28866.0, 29059.547022648996, 29335.886724680102, 29736.8513157435, 3021.546767984798, 3137.3254750228584, 3235.835099364227, 3248.2366643838677, 3263.3310171414805, 427666.0, 430224.84887575987, 430970.0, 432226.0, 435055.0, 47090.293645595346, 48433.75783121062, 56229.43770562324, 56375.71812140913, 56573.32273402216, 51776.74111629493, 61197.38802612006, 62487.0010399167, 62591.06113408302, 66475.0, 14748.262586870827, 14965.70068598622, 15048.924755376152, 15132.0, 15179.013364131297, 11604.593839215755, 11746.353950532803, 11752.11859110553, 11755.0, 11755.588554400725, 12877.420516076612, 16857.662846743, 16870.409535666193, 16887.577810554834, 16923.0, 4783.258594917794, 5463.4263402342185, 6802.489813264025, 6810.557313774589, 6855.691493882788, 809.1988930958308, 812.3866480806953, 829.7966998085387, 848.9617967191491, 857.9485230886166, 22154.88922555377, 28028.71971280261, 28251.0, 28626.14121576356, 28854.711452885622, 1023.7645341571331, 1052.21609900623, 1054.7185170018465, 1062.4953147254992, 1071.6945670483874, 13421.731565368638, 14035.929820350833, 14722.745719784287, 14732.600402961702, 14858.182799946107, 554683.0, 561876.0, 562405.0, 563912.0, 563957.0, 55049.72475137599, 55299.44700552943, 55357.72321138449, 55390.89218215694, 55407.0, 1340.604521666111, 1394.637394277495, 1404.0873432268902, 1406.69052808382, 1408.0777091005407, 26944.056958006375, 27531.862340688167, 27667.031653892016, 28313.292167695974, 28365.85817070984, 46606.30090548577, 46755.53244467648, 46821.53178468172, 46826.06347873092, 46908.53091469042, 347843.0, 347866.0, 347920.0, 348505.0, 348631.0, 36296.0, 37348.81325593355, 37542.0, 37554.812225938695, 37645.0, 41738.37392439055, 42429.151416972105, 42726.78636606922, 42883.571164289206, 43055.7847210762, 29381.559276610442, 29590.96431624883, 33151.66848331486, 33393.831215907325, 34909.77815776537, 29524.114276571738, 33272.33455330928, 34483.717650096616, 35847.283054338244, 36258.274834502634, 27201.183964480304, 34799.65200347964, 35528.111797205274, 35668.82165589155, 35710.8214458926, 26999.595006075317, 29141.7085829139, 31055.844720777157, 31299.68700312968, 31350.843245784537, 21748.78251217531, 22968.885155574782, 23134.0, 23475.94358253917, 23573.764262357156], "value": 18545.270253155322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6803772491585, 386.6500816760829, 392.4015875789421, 395.5451231084252, 420.8463910672605, 13040.673983150426, 14169.433222671094, 16829.15854207289, 21585.56828863422, 21659.025343859525, 18904.069869170267, 21299.0, 21632.675509867324, 22583.435414114654, 22720.09119635217, 5734.5125664318375, 5882.6764527950945, 5948.970255148718, 6037.486813620848, 6082.756689732428, 3782.243551289753, 5866.501347385477, 6000.399960004008, 6007.729652165663, 6020.397960203988, 3960.4059391091423, 6202.3487533808975, 6501.544891857572, 6533.836654083639, 6632.502562307822, 5682.431756824326, 6290.43386095249, 6561.114249576294, 6614.470842332626, 6634.237062737799, 5750.568707346965, 5757.0788673811985, 5757.769689212427, 5757.884842303172, 5758.971205143947, 26192.214233573024, 26856.731432685618, 26927.92288308465, 26932.09484624738, 27209.0, 2753.3116720819794, 3116.766242531819, 3133.749300056013, 3152.2592190835135, 3160.194150491633, 15160.848391516165, 15427.845721542753, 15767.842321576753, 15849.12829794361, 16087.034777913246, 1516.8938174327802, 1767.6022894848556, 1806.864485163618, 1841.8066103059255, 1842.68674325365, 76356.61821690912, 97280.0, 124595.3770231143, 126529.0, 127508.72491275061, 8294.58527073656, 10804.837927431096, 11159.27464714791, 11401.543938242377, 11635.825462618068, 14825.70348593022, 14846.109233446028, 14876.776848347066, 14883.33025013877, 14892.404303827941, 6998.440124790005, 8189.549574773326, 8447.0, 8498.66005359791, 8586.441881277697, 8178.713745018896, 8191.590420478952, 8203.507789532647, 8357.373197010249, 8377.664893404195, 6077.6961151943115, 7097.92902070983, 7166.703316474376, 7195.0, 7211.675474603656, 1658.6516831465285, 1928.2479832865195, 1956.2664000999625, 1976.1305025788606, 1976.6046790641929, 1009.421265141323, 1050.581714685169, 1051.4637534857277, 1056.070657821128, 1060.612876300145, 22000.559988800134, 22369.217077402212, 22402.887985559966, 22451.663225051638, 22529.211477598205, 1057.3338796558119, 1062.4315990944963, 1084.3331351218944, 1085.2023762534532, 1098.6154845803906, 9205.0, 10799.352038877692, 11449.255798373246, 11518.078553715683, 11540.307581545134, 331662.0, 335612.32193839364, 338100.0, 364965.0, 685132.0, 112199.0, 112452.43773781079, 128128.35935820261, 129437.35281323532, 132844.0, 936.1060187520901, 994.4679596415883, 1023.0434543701663, 1024.0, 1024.3546565663585, 16587.502374928772, 18136.818631813512, 18503.81496185075, 18526.629467410847, 18861.528461788017, 51548.0, 51884.74057629688, 52461.21308180304, 53159.73420132875, 53315.4668453326, 73574.63212683902, 82911.0, 84226.0, 84751.0, 84873.57563212144, 5721.713914304351, 6158.661273629814, 8068.677252910053, 8105.230003149692, 8193.631286592237, 10794.596702428635, 12674.366281685694, 12856.871431285568, 13213.0, 13305.733885322046, 10156.746081348025, 10414.114800241761, 11052.392118433563, 11265.380404077854, 11389.601363952223, 10788.946055269673, 10995.0, 11116.333020018825, 11299.322040677585, 11425.942870285595, 11351.659450216506, 11360.715982100513, 11782.587609433629, 11787.823182652095, 11850.703732406759, 8232.62953167121, 8414.789630259293, 8451.746447606582, 8466.74599762008, 8509.702160424355, 10150.13723833453, 11162.386068766296, 11465.197436179387, 11500.53997840077, 11511.251768635011], "value": 9797.338837328549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.4879420217417, 1424.8931330150242, 1447.3342262559215, 1452.5424491285237, 1463.7292100961322, 6662.0, 8472.957635211831, 8477.406581539295, 8480.533570653626, 8482.787930301745, 8068.878966815488, 8332.041815191254, 8352.749417517469, 8447.36644751643, 8452.704155354548, 2258.062903894886, 2299.5745787029455, 2299.8620082795, 2304.873231972241, 2306.884655767213, 1963.6956271777897, 2255.8872056397113, 2310.90756369745, 2321.9071237150492, 2323.6398358254414, 1995.1919472613615, 2025.5138766696034, 2027.8174964253215, 2027.959440811183, 2029.9594008119902, 1987.1951859496926, 2188.6607575825774, 2269.307861102363, 2271.0915633746467, 2281.406834223114, 2290.7823756743082, 2299.3331933739196, 2300.9654855177187, 2301.344116926668, 2301.873396963166, 6515.804525864231, 7338.559686418832, 8247.010358756988, 8324.084350721416, 8327.50034997902, 4573.199690054227, 4752.9762351188365, 4756.31033500144, 4756.762161891892, 4772.284157376386, 3413.9658603413895, 3467.081223475781, 3480.2343484433636, 3539.3098345822573, 3541.8052007139595, 1213.7329787446836, 1214.7995580729169, 1223.8347823043864, 1236.1038247270747, 1257.1325785208269, 10899.29154604948, 10902.0, 10982.835257471064, 10985.01134897863, 10990.0, 3573.9285214296087, 4354.390385346054, 4481.641468682497, 4485.147821913826, 4486.484054333728, 8675.262602678717, 8715.520646364384, 8720.607572659246, 8725.781855453664, 8730.69442569507, 5105.489451054865, 5106.744662766847, 5112.4120726116225, 5118.641695081308, 5119.513646203679, 4688.929666055012, 4690.859274221779, 4722.716637001791, 4737.218358970731, 4790.568848803624, 3528.2943411317838, 3547.2728090741334, 3571.928561428757, 3615.457681347819, 3693.4644476550748, 1122.680036189682, 1128.8250321200228, 1128.8917647644475, 1131.8585176852894, 1139.065965907964, 792.8899540643146, 827.841022568409, 843.4896887383168, 875.6541166239427, 888.4136469929945, 5250.212468129735, 5374.5700343972385, 5496.945030549723, 5587.469190426984, 5727.852055479195, 911.2072496927715, 927.2489283680105, 973.6056896956744, 985.9457729824785, 1001.369137443406, 3410.913123623125, 3590.425531914881, 3700.2599480104086, 3718.572364178154, 3724.6834019108137, 9759.316847820726, 10101.040401162025, 10108.545115469822, 10108.74728131788, 10159.288849780445, 10057.094861462358, 10058.899411005943, 10060.044295791888, 10062.798744025078, 10101.545430455648, 7249.528780629243, 7574.545527268381, 7739.032620922385, 7870.44906856526, 7871.370290376756, 5313.920291195558, 5443.972780136074, 5503.091989821634, 5626.409227031267, 5712.771489140554, 9093.272538197061, 9288.535573221447, 9309.44143351401, 9320.254379649747, 9321.766955826159, 9011.324150688593, 9415.0, 9450.149486546245, 9469.621215151592, 9478.431294122374, 7160.820979475555, 7299.343059124704, 7308.671109800178, 7313.0, 7319.5242309249725, 7833.686652533835, 7852.018497687789, 7897.526148431112, 7930.246626570467, 7933.1670174630835, 5947.553933454921, 6939.340762627744, 7079.787606371817, 7110.715571377294, 7289.671964761705, 6066.726997285221, 6955.582665040114, 7039.260877607982, 7085.6457177141965, 7088.893666594902, 6254.312025677081, 6417.486601071996, 6418.486521078209, 6422.197225346832, 6423.357664233539, 3765.4163604641326, 3986.621270979252, 4787.3776409066595, 5046.8485945420225, 5093.159628661378, 4639.35049093134, 4698.177818881751, 4780.995990841823, 4813.518648135158, 4870.853874383774], "value": 4313.5110835354135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.15131533005456, 358.8959201831469, 359.07538089419745, 361.2792479004387, 367.69113944286795, 4763.976180119103, 4808.062427826575, 4919.483454237307, 5243.0, 5319.627626066177, 5138.0, 5166.612504062192, 5168.793248270074, 5180.818671346504, 5188.195829646411, 3725.850965961365, 3857.517810273716, 3886.9028274293087, 3892.377219644857, 3940.8916229817055, 3179.0780673604627, 3600.5499312585926, 3758.3422900992355, 3877.3020856245867, 3906.628870257321, 3903.902402439933, 3920.176762879799, 3921.29416704993, 3929.292727309083, 3940.738963531671, 3394.4908263760385, 3666.9816650916573, 3931.941020884689, 3950.1902110067513, 3957.960420395788, 3370.9494357584654, 3374.3926093303194, 3380.4646515113664, 3400.96599034009, 3419.46998215277, 4124.906320259805, 4615.330777037344, 4981.1532039553, 4986.376702912136, 5010.048090862724, 3793.0465810107817, 4004.7797371144575, 4015.5984401559904, 4447.866564003085, 4461.0, 4536.931946020813, 4893.898872753638, 5076.54311111998, 5412.675239485604, 5594.664320140804, 3471.94792078119, 3472.826358682056, 3764.5106136202394, 3774.320427409804, 3777.131259810259, 4908.64330691755, 4966.491921579579, 5096.515830996086, 5739.971300143473, 5759.285261006669, 3186.8686616250898, 3192.1859925718795, 3609.458581212839, 3621.8732344367822, 3659.652333028358, 3817.7900215488417, 3820.369639009588, 3826.3303921814127, 3829.272438236782, 3859.9614003860165, 4422.690411671217, 4423.203823311835, 4447.310666846644, 4465.955340446619, 4478.552144785495, 5239.947600524022, 5452.345718513804, 5472.2338872557875, 5476.479734425223, 5529.419410961871, 1177.3289225141586, 1228.7358217983176, 1241.1250068701543, 1256.6732649511193, 1262.72851336963, 736.6427282767853, 841.884503033483, 847.8050048488759, 851.9616617252238, 864.5417928497906, 4378.0, 4529.705569137996, 4644.558766917205, 4787.521247875255, 4821.855344339605, 4530.569595888385, 4593.816247350135, 4760.976195119071, 5253.684778913277, 5300.628955973045, 4796.496367881392, 4808.927866082012, 4809.711417314972, 4811.559734789642, 4823.95176048235, 2287.9885600572225, 2437.926862194137, 2619.59396293571, 2716.673999120079, 2809.735618971471, 4821.841693690638, 5166.948330516722, 5507.339119305709, 5529.695866727288, 5551.750171242304, 5094.6688465249645, 5176.327077479904, 5385.78456861729, 5478.315210598676, 5499.670019798825, 4916.483769204254, 5073.95562662407, 5486.725663716878, 5602.862397057661, 5617.814728027645, 4764.785584648768, 5426.310109125832, 5428.375736790162, 5461.231750092424, 5561.277033985556, 4498.955010449854, 5223.712695801767, 5362.731863406736, 5412.972935135299, 5484.945150548443, 5557.638753481173, 5735.541156707537, 5743.558987430409, 5747.683877386784, 5887.381824908323, 4051.453053837812, 4089.1003979124544, 4092.4270602115134, 4107.548169701271, 4152.979235103805, 4817.975910120427, 4985.559963625087, 5047.470015648304, 5628.324601047901, 5637.731510410125, 4795.616350692006, 5118.744062796771, 5428.972855135699, 5480.451954804487, 5514.476124768141, 5145.9228111579105, 5396.0556902542685, 5432.6468779529205, 5434.375046869661, 5443.700596467233, 4914.795875010645, 5290.338707661543, 5337.797321607005, 5376.650517716336, 5407.83776486706, 4030.3551431770775, 5447.918281225706, 5481.808136715196, 5489.14564426504, 5498.257735205856, 4446.955530444783, 4938.38270216223, 5354.303940487867, 5492.780288788404, 5497.642653227527], "value": 3926.1790455128034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.3513175971028, 764.1288930619095, 802.3901834605698, 809.1625167951172, 810.8662070758323, 14690.63273418165, 14991.625209369771, 14998.325075371607, 15054.84945150548, 15065.32206050729, 13562.118462299944, 13602.251876146807, 13620.931895340535, 13624.114432561877, 13628.591142265723, 879.2131042716765, 880.2297989259414, 903.5798353765498, 903.9819203615924, 922.3313098003961, 918.2516249256868, 920.6363486422858, 922.483409290796, 924.7549399409128, 926.6432423516961, 805.8025783683006, 899.5727029660924, 933.2440723014346, 952.0289304908989, 952.105021279998, 942.4392486470539, 949.3449519831329, 949.3876449689946, 949.8622699708573, 951.5289931483891, 709.1490211745873, 710.4387533848254, 710.5452510393352, 711.1608302203398, 711.3206887422499, 14887.478938237218, 15141.621459463491, 15261.771073433907, 15654.452094176762, 15669.451569195024, 13539.59381218565, 13623.523176688768, 13729.0, 13978.02153849231, 14021.158730476203, 11201.719957001058, 11448.141389395829, 11547.53809847605, 12010.0, 12050.819237711441, 3589.975500305644, 3633.564741926924, 3637.3964213998356, 3657.4330978698345, 3668.5414323209598, 92525.53737231271, 102219.48890255575, 102343.48828255886, 104774.47612761964, 105728.0, 9482.668106616235, 10629.25595208328, 10744.623938162284, 10781.460926953621, 10817.945910270399, 21806.0, 22073.896305184677, 22202.888985554968, 22216.222432214796, 22265.888670556542, 7075.469339799535, 7100.041494398293, 7162.606056666829, 7268.345848873521, 7326.194118646945, 3899.0, 4071.3892916062828, 4164.021454958082, 4167.499900012018, 4333.58830911063, 3142.3558170575434, 3280.2291461506525, 3652.068722475805, 3660.0, 3695.1870588470492, 674.3458844920419, 675.7297081167474, 684.2370756606448, 691.7198534593498, 694.4860803005739, 626.5301024231826, 657.4740207833714, 662.3105742331527, 674.8650269945932, 696.1611258433576, 9277.93424889714, 9596.90403095974, 9712.22302215821, 9887.258455615858, 9989.850152247722, 638.4445532386853, 641.086357223687, 656.8784774816579, 678.1997243253008, 681.3765404654785, 4415.381846541487, 4521.61566266871, 4613.777349002517, 4746.620270378361, 4771.812047211634, 98262.50868745611, 100364.0, 102023.48988255011, 103183.96816031894, 105544.94455055505, 84485.57757211174, 84790.57604711936, 86250.0, 86502.56748716216, 86666.0, 64238.0, 65737.67131164313, 75883.0, 76905.34148706781, 77585.61207193928, 8970.416922900251, 9137.5888085035, 9316.860247096434, 9381.249500040118, 9384.085119136711, 31862.681373185973, 42644.78677606592, 43492.347614786435, 44544.0, 46254.37456254482, 60944.695276523336, 65500.0, 69775.30224697688, 70205.0, 71034.28965710277, 12260.816087758512, 12346.753064938472, 12438.689032774253, 13164.00666984292, 13390.995675324195, 13634.590962271148, 13886.09740366873, 13940.58178254654, 14066.156030638194, 14102.647433814236, 12719.745605088032, 13079.803802942773, 13082.345882706017, 13102.803457948328, 13221.603351899459, 11236.044936180517, 12463.376831158586, 12845.0, 13177.370015320494, 13284.86715132875, 10865.130789536975, 12401.565945191875, 12665.620031399072, 12801.679958001125, 13008.901247572334, 10112.465552769374, 10396.16830653561, 10497.895021049691, 10585.100266477435, 10699.251052426256, 8375.20435558621, 8781.429207101519, 9278.304127190622, 10353.482325883826, 10436.843447348449], "value": 7329.496854280045, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 111.0, 151.0, 114.0, 135.0, 139.0, 141.0, 135.0, 114.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 186.0, 187.0, 185.0, 184.0, 183.0, 185.0, 183.0, 183.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 63.0, 94.0, 64.0, 59.0, 61.0, 62.0, 81.0, 62.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 57.0, 90.0, 99.0, 102.0, 103.0, 121.0, 67.0, 68.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 136.0, 89.0, 89.0, 89.0, 88.0, 89.0, 88.0, 89.0, 88.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 104.0, 132.0, 141.0, 86.0, 85.0, 95.0, 85.0, 85.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 75.0, 73.0, 71.0, 69.0, 68.0, 68.0, 68.0, 69.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 81.0, 98.0, 96.0, 108.0, 86.0, 90.0, 90.0, 90.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 155.0, 144.0, 141.0, 142.0, 141.0, 144.0, 184.0, 140.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 176.0, 175.0, 173.0, 175.0, 173.0, 193.0, 233.0, 196.0], "value": 184.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 65.0, 66.0, 67.0, 68.0, 67.0, 68.0, 65.0, 66.0], "value": 66.9, "unit": "score"}]}]} 16:44:28 INFO - Return code: 0 16:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:29 ERROR - # TBPL SUCCESS # 16:44:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:44:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:44:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:44:29 INFO - 2017-02-22 16:44:29.077 screenresolution[1930:64963] starting screenresolution argv=screenresolution get 16:44:29 INFO - 2017-02-22 16:44:29.080 screenresolution[1930:64963] Display 0: 1600x1200x32@60 16:44:29 INFO - 2017-02-22 16:44:29.086 screenresolution[1931:64966] starting screenresolution argv=screenresolution list 16:44:29 INFO - Available Modes on Display 0 16:44:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:44:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:44:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:44:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:44:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:44:29 INFO - Intel Iris: 16:44:29 INFO - Chipset Model: Intel Iris 16:44:29 INFO - Type: GPU 16:44:29 INFO - Bus: Built-In 16:44:29 INFO - VRAM (Dynamic, Max): 1536 MB 16:44:29 INFO - Vendor: Intel (0x8086) 16:44:29 INFO - Device ID: 0x0a2e 16:44:29 INFO - Revision ID: 0x0009 16:44:29 INFO - Displays: 16:44:29 INFO - Display: 16:44:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:44:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:44:29 INFO - Display Serial Number: 1600x1200 60 16:44:29 INFO - Main Display: Yes 16:44:29 INFO - Mirror: Off 16:44:29 INFO - Online: Yes 16:44:29 INFO - Rotation: Supported 16:44:29 INFO - Return code: 0 16:44:29 INFO - Running post-action listener: _resource_record_post_action 16:44:29 INFO - [mozharness: 2017-02-23 00:44:29.327372Z] Finished run-tests step (success) 16:44:29 INFO - Running post-run listener: _resource_record_post_run 16:44:29 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 106496; Write bytes: 517504000; Read time: 4; Write time: 1594 16:44:29 INFO - TinderboxPrint: CPU usage
53.9% 16:44:29 INFO - TinderboxPrint: I/O read bytes / time
106,496 / 4 16:44:29 INFO - TinderboxPrint: I/O write bytes / time
517,504,000 / 1,594 16:44:29 INFO - TinderboxPrint: CPU idle
2,216.2 (46.1%) 16:44:29 INFO - TinderboxPrint: CPU system
964.0 (20.0%) 16:44:29 INFO - TinderboxPrint: CPU user
1,629.4 (33.9%) 16:44:29 INFO - TinderboxPrint: Swap in / out
209,965,056 / 0 16:44:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206033408; Write bytes: 205629440; Read time: 15564; Write time: 448 16:44:29 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 106496; Write bytes: 301126656; Read time: 4; Write time: 1108 16:44:29 INFO - Running post-run listener: _upload_blobber_files 16:44:29 INFO - Blob upload gear active. 16:44:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:29 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:44:29 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:44:29 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:30 INFO - (blobuploader) - INFO - Done attempting. 16:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:32 INFO - (blobuploader) - INFO - Done attempting. 16:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:44:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:34 INFO - (blobuploader) - INFO - Done attempting. 16:44:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:36 INFO - (blobuploader) - INFO - Done attempting. 16:44:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:36 INFO - Return code: 0 16:44:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480f1e58c7b4b549176144780bf94d62e4accb3ae5f9f5f10aa7dfa940b452f6dd1500acfa1fbbcb1d80c7017058a82317f39aff4dbb2fac2d2b24d42e16247e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00ef8fd214c4220f2edc11ae8c78424930d315ba4e7a3151938f589981ad40cbc0dc18b1979af1902446c8476bd723453f7973f5a9c1c5da5221ed98f2a00bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb0c858ad38d5381226e973cceec6cff3d32a7ef8ec83145f00ef03dc3266acf8f41a7837228742aac85ad1f96cbe4e1a3da8bb9bd063d4f7738e1fcc786c896", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc956a3cc404b39d60e022a720882d145259d257b22eb510d5f1b08ee89585095092d4e12537379cdd0e4f1564a472fcd39955301147eb5c670b0c0f1fac74f9"} 16:44:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:36 INFO - Contents: 16:44:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480f1e58c7b4b549176144780bf94d62e4accb3ae5f9f5f10aa7dfa940b452f6dd1500acfa1fbbcb1d80c7017058a82317f39aff4dbb2fac2d2b24d42e16247e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00ef8fd214c4220f2edc11ae8c78424930d315ba4e7a3151938f589981ad40cbc0dc18b1979af1902446c8476bd723453f7973f5a9c1c5da5221ed98f2a00bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb0c858ad38d5381226e973cceec6cff3d32a7ef8ec83145f00ef03dc3266acf8f41a7837228742aac85ad1f96cbe4e1a3da8bb9bd063d4f7738e1fcc786c896", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc956a3cc404b39d60e022a720882d145259d257b22eb510d5f1b08ee89585095092d4e12537379cdd0e4f1564a472fcd39955301147eb5c670b0c0f1fac74f9"} 16:44:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:36 INFO - Copying logs to upload dir... 16:44:36 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.106471 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-22 16:44:36.778383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 16:44:36.786016) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480f1e58c7b4b549176144780bf94d62e4accb3ae5f9f5f10aa7dfa940b452f6dd1500acfa1fbbcb1d80c7017058a82317f39aff4dbb2fac2d2b24d42e16247e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00ef8fd214c4220f2edc11ae8c78424930d315ba4e7a3151938f589981ad40cbc0dc18b1979af1902446c8476bd723453f7973f5a9c1c5da5221ed98f2a00bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb0c858ad38d5381226e973cceec6cff3d32a7ef8ec83145f00ef03dc3266acf8f41a7837228742aac85ad1f96cbe4e1a3da8bb9bd063d4f7738e1fcc786c896", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc956a3cc404b39d60e022a720882d145259d257b22eb510d5f1b08ee89585095092d4e12537379cdd0e4f1564a472fcd39955301147eb5c670b0c0f1fac74f9"} build_url:https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/GnZOYabGR7aqI_hPVTBN5w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/480f1e58c7b4b549176144780bf94d62e4accb3ae5f9f5f10aa7dfa940b452f6dd1500acfa1fbbcb1d80c7017058a82317f39aff4dbb2fac2d2b24d42e16247e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00ef8fd214c4220f2edc11ae8c78424930d315ba4e7a3151938f589981ad40cbc0dc18b1979af1902446c8476bd723453f7973f5a9c1c5da5221ed98f2a00bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb0c858ad38d5381226e973cceec6cff3d32a7ef8ec83145f00ef03dc3266acf8f41a7837228742aac85ad1f96cbe4e1a3da8bb9bd063d4f7738e1fcc786c896", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc956a3cc404b39d60e022a720882d145259d257b22eb510d5f1b08ee89585095092d4e12537379cdd0e4f1564a472fcd39955301147eb5c670b0c0f1fac74f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 16:44:36.818648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:44:36.818962) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AhdR2ncoHF/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.AgrbMtSeq1/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005482 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 16:44:36.867381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 16:44:36.867698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 16:44:36.868003) ========= ========= Total master_lag: 0.25 =========