builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0130 starttime: 1491237422.86 results: success (0) buildid: 20170403080823 builduid: a9c425810d9c4250b32979f514838112 revision: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:02.864987) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:02.865415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:02.865705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:02.896154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:02.896512) ========= 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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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-04-03 09:37:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.1M=0s 2017-04-03 09:37:03 (72.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100657 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:03.024911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:03.025241) ========= 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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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.027823 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:03.075438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 09:37:03.075801) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b --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 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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-04-03 09:37:03,209 truncating revision to first 12 chars 2017-04-03 09:37:03,210 Setting DEBUG logging. 2017-04-03 09:37:03,210 attempt 1/10 2017-04-03 09:37:03,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9aacfa8081b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 09:37:04,473 unpacking tar archive at: mozilla-central-9aacfa8081b3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.543705 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 09:37:04.645754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:04.646053) ========= script_repo_revision: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:04.646435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:04.646775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 09:37:04.667233) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-03 09:37:04.668065) ========= /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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:37:04 INFO - MultiFileLogger online at 20170403 09:37:04 in /builds/slave/test 09:37:04 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 09:37:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:04 INFO - {'append_to_log': False, 09:37:04 INFO - 'base_work_dir': '/builds/slave/test', 09:37:04 INFO - 'blob_upload_branch': 'Firefox', 09:37:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:04 INFO - 'branch': 'Firefox', 09:37:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:04 INFO - 'config_files': ('talos/mac_config.py',), 09:37:04 INFO - 'default_actions': ('clobber', 09:37:04 INFO - 'read-buildbot-config', 09:37:04 INFO - 'download-and-extract', 09:37:04 INFO - 'populate-webroot', 09:37:04 INFO - 'create-virtualenv', 09:37:04 INFO - 'install', 09:37:04 INFO - 'run-tests'), 09:37:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:04 INFO - 'download_minidump_stackwalk': True, 09:37:04 INFO - 'download_symbols': 'ondemand', 09:37:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:04 INFO - 'gecko_profile': False, 09:37:04 INFO - 'gecko_profile_interval': 0, 09:37:04 INFO - 'installer_path': 'installer.exe', 09:37:04 INFO - 'log_level': 'info', 09:37:04 INFO - 'log_name': 'talos', 09:37:04 INFO - 'log_to_console': True, 09:37:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:37:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:37:04 INFO - 'opt_config_files': (), 09:37:04 INFO - 'pip_index': False, 09:37:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:04 INFO - 'cmd': ('bash', 09:37:04 INFO - '-c', 09:37:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:04 INFO - 'enabled': True, 09:37:04 INFO - 'halt_on_failure': False, 09:37:04 INFO - 'name': 'check_screen_resolution'},), 09:37:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:04 INFO - 'cmd': ('bash', 09:37:04 INFO - '-c', 09:37:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:04 INFO - 'enabled': True, 09:37:04 INFO - 'halt_on_failure': False, 09:37:04 INFO - 'name': 'check_screen_resolution'},), 09:37:04 INFO - 'run_cmd_checks_enabled': True, 09:37:04 INFO - 'suite': 'dromaeojs', 09:37:04 INFO - 'system_bits': '32', 09:37:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:04 INFO - 'title': 't-yosemite-r7-0130', 09:37:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:04 INFO - 'use_talos_json': True, 09:37:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:04 INFO - 'work_dir': 'build'} 09:37:04 INFO - [mozharness: 2017-04-03 16:37:04.907127Z] Running clobber step. 09:37:04 INFO - Running pre-action listener: _resource_record_pre_action 09:37:04 INFO - Running main action method: clobber 09:37:04 INFO - rmtree: /builds/slave/test/build 09:37:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:07 INFO - Running post-action listener: _resource_record_post_action 09:37:07 INFO - [mozharness: 2017-04-03 16:37:07.407531Z] Finished clobber step (success) 09:37:07 INFO - [mozharness: 2017-04-03 16:37:07.407675Z] Running read-buildbot-config step. 09:37:07 INFO - Running pre-action listener: _resource_record_pre_action 09:37:07 INFO - Running main action method: read_buildbot_config 09:37:07 INFO - Using buildbot properties: 09:37:07 INFO - { 09:37:07 INFO - "project": "", 09:37:07 INFO - "product": "firefox", 09:37:07 INFO - "script_repo_revision": "production", 09:37:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:37:07 INFO - "repository": "", 09:37:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:37:07 INFO - "buildid": "20170403080823", 09:37:07 INFO - "pgo_build": "False", 09:37:07 INFO - "basedir": "/builds/slave/test", 09:37:07 INFO - "buildnumber": 24, 09:37:07 INFO - "slavename": "t-yosemite-r7-0130", 09:37:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:37:07 INFO - "platform": "yosemite_r7", 09:37:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:37:07 INFO - "branch": "mozilla-central", 09:37:07 INFO - "repo_path": "mozilla-central", 09:37:07 INFO - "revision": "9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b", 09:37:07 INFO - "stage_platform": "macosx64", 09:37:07 INFO - "builduid": "a9c425810d9c4250b32979f514838112", 09:37:07 INFO - "slavebuilddir": "test" 09:37:07 INFO - } 09:37:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:37:07 INFO - Running post-action listener: _resource_record_post_action 09:37:07 INFO - [mozharness: 2017-04-03 16:37:07.410866Z] Finished read-buildbot-config step (success) 09:37:07 INFO - [mozharness: 2017-04-03 16:37:07.410999Z] Running download-and-extract step. 09:37:07 INFO - Running pre-action listener: _resource_record_pre_action 09:37:07 INFO - Running main action method: download_and_extract 09:37:07 INFO - mkdir: /builds/slave/test/build/tests 09:37:07 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')]} 09:37:07 INFO - trying https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:37:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:37:08 INFO - Downloaded 1325 bytes. 09:37:08 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:37:08 INFO - Using the following test package requirements: 09:37:08 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:37:08 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:37:08 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:37:08 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:37:08 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'jsshell-mac.zip'], 09:37:08 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:37:08 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:37:08 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:37:08 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:37:08 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:37:08 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:37:08 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:37:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:37:10 INFO - Expected file size: 52515799 09:37:10 INFO - Obtained file size: 52515799 09:37:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:37:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:37:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:37:26 INFO - Fetch https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:37:27 INFO - Expected file size: 52515799 09:37:27 INFO - Obtained file size: 52515799 09:37:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:37:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:37:43 INFO - Fetch https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:37:44 INFO - Expected file size: 14404152 09:37:44 INFO - Obtained file size: 14404152 09:37:44 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')]} 09:37:44 INFO - trying https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:44 INFO - Downloading https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:37:47 INFO - Downloaded 75570027 bytes. 09:37:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:47 INFO - mkdir: /builds/slave/test/properties 09:37:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:47 INFO - Contents: 09:37:47 INFO - build_url:https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:37:47 INFO - Running post-action listener: _resource_record_post_action 09:37:47 INFO - Running post-action listener: set_extra_try_arguments 09:37:47 INFO - [mozharness: 2017-04-03 16:37:47.785184Z] Finished download-and-extract step (success) 09:37:47 INFO - [mozharness: 2017-04-03 16:37:47.785334Z] Running populate-webroot step. 09:37:47 INFO - Running pre-action listener: _resource_record_pre_action 09:37:47 INFO - Running main action method: populate_webroot 09:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:47 INFO - '--tppagecycles', 09:37:47 INFO - '7'], 09:37:47 INFO - 'tests': ['tsvgm']}}, 09:37:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['damp', 'tps']}, 09:37:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'tests': ['damp', 'tps']}, 09:37:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['dromaeo_dom']}, 09:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['basic_compositor_video']}, 09:37:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tsvgx', 09:37:47 INFO - 'tsvgr_opacity', 09:37:47 INFO - 'tart', 09:37:47 INFO - 'tscrollx', 09:37:47 INFO - 'cart', 09:37:47 INFO - 'tsvg_static']}, 09:37:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:47 INFO - 'tsvgr_opacity', 09:37:47 INFO - 'tart', 09:37:47 INFO - 'tscrollx', 09:37:47 INFO - 'cart', 09:37:47 INFO - 'tsvg_static']}, 09:37:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tp5o']}, 09:37:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:37:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s', 09:37:47 INFO - '--xperf_path', 09:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:47 INFO - 'tests': ['tp5n']}, 09:37:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:37:47 INFO - 'talos_options': ['--xperf_path', 09:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:47 INFO - 'tests': ['tp5n']}}, 09:37:47 INFO - 'talos.zip': {'path': '', 09:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:47 INFO - Running post-action listener: _resource_record_post_action 09:37:47 INFO - [mozharness: 2017-04-03 16:37:47.804168Z] Finished populate-webroot step (success) 09:37:47 INFO - [mozharness: 2017-04-03 16:37:47.804279Z] Running create-virtualenv step. 09:37:47 INFO - Running pre-action listener: _resource_record_pre_action 09:37:47 INFO - Running main action method: create_virtualenv 09:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:47 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 09:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:47 INFO - Using real prefix '/tools/python27' 09:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:51 INFO - Installing pip.................done. 09:37:51 INFO - Return code: 0 09:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:51 INFO - Reading from file tmpfile_stdout 09:37:51 INFO - Output received: 09:37:51 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) 09:37:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:52 INFO - 'HOME': '/Users/cltbld', 09:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PAGER': '/bin/cat', 09:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:37:52 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - 'XPC_FLAGS': '0x0', 09:37:52 INFO - 'XPC_SERVICE_NAME': '0', 09:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 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 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:52 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')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:53 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:37:53 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 09:37:53 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 09:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:53 INFO - 'HOME': '/Users/cltbld', 09:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:53 INFO - 'LOGNAME': 'cltbld', 09:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:53 INFO - 'MOZ_NO_REMOTE': '1', 09:37:53 INFO - 'NO_EM_RESTART': '1', 09:37:53 INFO - 'PAGER': '/bin/cat', 09:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:53 INFO - 'PWD': '/builds/slave/test', 09:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:53 INFO - 'SHELL': '/bin/bash', 09:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:37:53 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:53 INFO - 'USER': 'cltbld', 09:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:53 INFO - 'XPC_FLAGS': '0x0', 09:37:53 INFO - 'XPC_SERVICE_NAME': '0', 09:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:53 INFO - Downloading/unpacking psutil>=3.1.1 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:57 INFO - Installing collected packages: psutil 09:37:57 INFO - Running setup.py install for psutil 09:37:57 INFO - building 'psutil._psutil_osx' extension 09:37:57 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 09:37:57 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 09:37:58 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 09:37:58 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 09:37:58 INFO - building 'psutil._psutil_posix' extension 09:37:58 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 09:37:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:37:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:37:58 INFO - ^ 09:37:58 INFO - 1 warning generated. 09:37:58 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 09:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:58 INFO - Successfully installed psutil 09:37:58 INFO - Cleaning up... 09:37:58 INFO - Return code: 0 09:37:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:37: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 mozsystemmonitor==0.3 09:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:58 INFO - 'HOME': '/Users/cltbld', 09:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:58 INFO - 'LOGNAME': 'cltbld', 09:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:58 INFO - 'MOZ_NO_REMOTE': '1', 09:37:58 INFO - 'NO_EM_RESTART': '1', 09:37:58 INFO - 'PAGER': '/bin/cat', 09:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:58 INFO - 'PWD': '/builds/slave/test', 09:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:58 INFO - 'SHELL': '/bin/bash', 09:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:37:58 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:58 INFO - 'USER': 'cltbld', 09:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:58 INFO - 'XPC_FLAGS': '0x0', 09:37:58 INFO - 'XPC_SERVICE_NAME': '0', 09:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:38:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:38:01 INFO - Installing collected packages: mozsystemmonitor 09:38:01 INFO - Running setup.py install for mozsystemmonitor 09:38:01 INFO - Successfully installed mozsystemmonitor 09:38:01 INFO - Cleaning up... 09:38:01 INFO - Return code: 0 09:38:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:38:01 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')]} 09:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:01 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')]} 09:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:01 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:01 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 09:38:01 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 09:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:01 INFO - 'HOME': '/Users/cltbld', 09:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:01 INFO - 'LOGNAME': 'cltbld', 09:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:01 INFO - 'MOZ_NO_REMOTE': '1', 09:38:01 INFO - 'NO_EM_RESTART': '1', 09:38:01 INFO - 'PAGER': '/bin/cat', 09:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:01 INFO - 'PWD': '/builds/slave/test', 09:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:01 INFO - 'SHELL': '/bin/bash', 09:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:01 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:01 INFO - 'USER': 'cltbld', 09:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:01 INFO - 'XPC_FLAGS': '0x0', 09:38:01 INFO - 'XPC_SERVICE_NAME': '0', 09:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:38:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:38:05 INFO - warning: no files found matching '*.txt' 09:38:05 INFO - no previously-included directories found matching 'build' 09:38:05 INFO - no previously-included directories found matching 'dist' 09:38:05 INFO - no previously-included directories found matching '.git*' 09:38:05 INFO - Installing collected packages: jsonschema, functools32 09:38:05 INFO - Running setup.py install for functools32 09:38:05 INFO - warning: no files found matching '*.txt' 09:38:05 INFO - no previously-included directories found matching 'build' 09:38:05 INFO - no previously-included directories found matching 'dist' 09:38:05 INFO - no previously-included directories found matching '.git*' 09:38:05 INFO - Successfully installed jsonschema functools32 09:38:05 INFO - Cleaning up... 09:38:05 INFO - Return code: 0 09:38:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:38:05 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')]} 09:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:05 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')]} 09:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:05 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:05 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 09:38:05 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 09:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:05 INFO - 'HOME': '/Users/cltbld', 09:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:05 INFO - 'LOGNAME': 'cltbld', 09:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:05 INFO - 'MOZ_NO_REMOTE': '1', 09:38:05 INFO - 'NO_EM_RESTART': '1', 09:38:05 INFO - 'PAGER': '/bin/cat', 09:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:05 INFO - 'PWD': '/builds/slave/test', 09:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:05 INFO - 'SHELL': '/bin/bash', 09:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:05 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:05 INFO - 'USER': 'cltbld', 09:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:05 INFO - 'XPC_FLAGS': '0x0', 09:38:05 INFO - 'XPC_SERVICE_NAME': '0', 09:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:38:05 INFO - Cleaning up... 09:38:05 INFO - Return code: 0 09:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38:05 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')]} 09:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:05 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')]} 09:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:05 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:05 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 09:38:05 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 09:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:05 INFO - 'HOME': '/Users/cltbld', 09:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:05 INFO - 'LOGNAME': 'cltbld', 09:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:05 INFO - 'MOZ_NO_REMOTE': '1', 09:38:05 INFO - 'NO_EM_RESTART': '1', 09:38:05 INFO - 'PAGER': '/bin/cat', 09:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:05 INFO - 'PWD': '/builds/slave/test', 09:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:05 INFO - 'SHELL': '/bin/bash', 09:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:05 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:05 INFO - 'USER': 'cltbld', 09:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:05 INFO - 'XPC_FLAGS': '0x0', 09:38:05 INFO - 'XPC_SERVICE_NAME': '0', 09:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:09 INFO - Downloading docopt-0.6.1.tar.gz 09:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:09 INFO - Running setup.py install for blobuploader 09:38:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:10 INFO - Running setup.py install for requests 09:38:10 INFO - Running setup.py install for docopt 09:38:10 INFO - Successfully installed blobuploader requests docopt 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:10 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 09:38:10 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 09:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:10 INFO - 'HOME': '/Users/cltbld', 09:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PAGER': '/bin/cat', 09:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:10 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - 'XPC_FLAGS': '0x0', 09:38:10 INFO - 'XPC_SERVICE_NAME': '0', 09:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-PsJ18J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-aD0bRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-xHpCuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-FuvyKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-d2mp8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-PE4kWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-clAuTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-RjBXH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:11 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-JW1sK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-wyO074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-feh504-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-QYYsap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-QwQt9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-QXGiQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-lalKfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-nXeSH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:12 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-aAEXnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:12 INFO - Running setup.py install for manifestparser 09:38:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:12 INFO - Running setup.py install for mozcrash 09:38:13 INFO - Running setup.py install for mozdebug 09:38:13 INFO - Running setup.py install for mozdevice 09:38:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozfile 09:38:13 INFO - Running setup.py install for mozhttpd 09:38:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozinfo 09:38:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozInstall 09:38:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozleak 09:38:14 INFO - Running setup.py install for mozlog 09:38:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for moznetwork 09:38:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozprocess 09:38:14 INFO - Running setup.py install for mozprofile 09:38:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozrunner 09:38:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozscreenshot 09:38:15 INFO - Running setup.py install for moztest 09:38:15 INFO - Running setup.py install for mozversion 09:38:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:15 INFO - Cleaning up... 09:38:15 INFO - Return code: 0 09:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:15 INFO - 'HOME': '/Users/cltbld', 09:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:15 INFO - 'LOGNAME': 'cltbld', 09:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:15 INFO - 'MOZ_NO_REMOTE': '1', 09:38:15 INFO - 'NO_EM_RESTART': '1', 09:38:15 INFO - 'PAGER': '/bin/cat', 09:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:15 INFO - 'PWD': '/builds/slave/test', 09:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:15 INFO - 'SHELL': '/bin/bash', 09:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:15 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:15 INFO - 'USER': 'cltbld', 09:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:15 INFO - 'XPC_FLAGS': '0x0', 09:38:15 INFO - 'XPC_SERVICE_NAME': '0', 09:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:15 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-LZ3bIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:15 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-YX0hDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:15 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)) 09:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:15 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-7fpRFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-Vy_3Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-CajaQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-0zVvcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-Gu9Iuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-sg9eSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-UtHXb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-L6tl_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-6I0heg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-Z1Qp1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:16 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-EJvJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:17 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-4z1pHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:17 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-TM9hQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:17 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-4UO5v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:17 INFO - Running setup.py (path:/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/pip-Yxsjgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:20 INFO - Downloading blessings-1.6.tar.gz 09:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:20 INFO - Installing collected packages: blessings 09:38:20 INFO - Running setup.py install for blessings 09:38:20 INFO - Successfully installed blessings 09:38:20 INFO - Cleaning up... 09:38:20 INFO - Return code: 0 09:38:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:20 INFO - Reading from file tmpfile_stdout 09:38:20 INFO - Current package versions: 09:38:20 INFO - blessings == 1.6 09:38:20 INFO - blobuploader == 1.2.4 09:38:20 INFO - docopt == 0.6.1 09:38:20 INFO - functools32 == 3.2.3-2 09:38:20 INFO - jsonschema == 2.5.1 09:38:20 INFO - manifestparser == 1.1 09:38:20 INFO - mozInstall == 1.12 09:38:20 INFO - mozcrash == 1.0 09:38:20 INFO - mozdebug == 0.1 09:38:20 INFO - mozdevice == 0.49 09:38:20 INFO - mozfile == 1.2 09:38:20 INFO - mozhttpd == 0.7 09:38:20 INFO - mozinfo == 0.9 09:38:20 INFO - mozleak == 0.1 09:38:20 INFO - mozlog == 3.4 09:38:20 INFO - moznetwork == 0.27 09:38:20 INFO - mozprocess == 0.25 09:38:20 INFO - mozprofile == 0.28 09:38:20 INFO - mozrunner == 6.13 09:38:20 INFO - mozscreenshot == 0.1 09:38:20 INFO - mozsystemmonitor == 0.3 09:38:20 INFO - moztest == 0.8 09:38:20 INFO - mozversion == 1.4 09:38:20 INFO - psutil == 3.1.1 09:38:20 INFO - requests == 1.2.3 09:38:20 INFO - wsgiref == 0.1.2 09:38:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:20 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 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:20 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 09:38:20 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 09:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:20 INFO - 'HOME': '/Users/cltbld', 09:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:20 INFO - 'LOGNAME': 'cltbld', 09:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:20 INFO - 'MOZ_NO_REMOTE': '1', 09:38:20 INFO - 'NO_EM_RESTART': '1', 09:38:20 INFO - 'PAGER': '/bin/cat', 09:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:20 INFO - 'PWD': '/builds/slave/test', 09:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:20 INFO - 'SHELL': '/bin/bash', 09:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:20 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:20 INFO - 'USER': 'cltbld', 09:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:20 INFO - 'XPC_FLAGS': '0x0', 09:38:20 INFO - 'XPC_SERVICE_NAME': '0', 09:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 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)) 09:38:20 INFO - Cleaning up... 09:38:20 INFO - Return code: 0 09:38:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10acbdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5bacb4970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, '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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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 09:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:20 INFO - 'HOME': '/Users/cltbld', 09:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:20 INFO - 'LOGNAME': 'cltbld', 09:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:20 INFO - 'MOZ_NO_REMOTE': '1', 09:38:20 INFO - 'NO_EM_RESTART': '1', 09:38:20 INFO - 'PAGER': '/bin/cat', 09:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:20 INFO - 'PWD': '/builds/slave/test', 09:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:20 INFO - 'SHELL': '/bin/bash', 09:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:20 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:20 INFO - 'USER': 'cltbld', 09:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:20 INFO - 'XPC_FLAGS': '0x0', 09:38:20 INFO - 'XPC_SERVICE_NAME': '0', 09:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:38:21 INFO - Cleaning up... 09:38:21 INFO - Return code: 0 09:38:21 INFO - Running post-action listener: _resource_record_post_action 09:38:21 INFO - Running post-action listener: _start_resource_monitoring 09:38:21 INFO - Starting resource monitoring. 09:38:21 INFO - [mozharness: 2017-04-03 16:38:21.276651Z] Finished create-virtualenv step (success) 09:38:21 INFO - [mozharness: 2017-04-03 16:38:21.277600Z] Running install step. 09:38:21 INFO - Running pre-action listener: _resource_record_pre_action 09:38:21 INFO - Running main action method: install 09:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:21 INFO - Reading from file tmpfile_stdout 09:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:21 INFO - Reading from file tmpfile_stdout 09:38:21 INFO - Output received: 09:38:21 INFO - Usage: mozinstall [options] installer 09:38:21 INFO - Options: 09:38:21 INFO - -h, --help show this help message and exit 09:38:21 INFO - -d DEST, --destination=DEST 09:38:21 INFO - Directory to install application into. [default: 09:38:21 INFO - "/builds/slave/test"] 09:38:21 INFO - --app=APP Application being installed. [default: firefox] 09:38:21 INFO - mkdir: /builds/slave/test/build/application 09:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:38:42 INFO - Reading from file tmpfile_stdout 09:38:42 INFO - Output received: 09:38:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:38:42 INFO - Running post-action listener: _resource_record_post_action 09:38:42 INFO - [mozharness: 2017-04-03 16:38:42.112201Z] Finished install step (success) 09:38:42 INFO - [mozharness: 2017-04-03 16:38:42.112356Z] Running run-tests step. 09:38:42 INFO - Running pre-action listener: _resource_record_pre_action 09:38:42 INFO - Running main action method: run_tests 09:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:42 INFO - 2017-04-03 09:38:42.126 screenresolution[1623:7329] starting screenresolution argv=screenresolution get 09:38:42 INFO - 2017-04-03 09:38:42.129 screenresolution[1623:7329] Display 0: 1600x1200x32@60 09:38:42 INFO - 2017-04-03 09:38:42.135 screenresolution[1624:7331] starting screenresolution argv=screenresolution list 09:38:42 INFO - Available Modes on Display 0 09:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:42 INFO - Intel Iris: 09:38:42 INFO - Chipset Model: Intel Iris 09:38:42 INFO - Type: GPU 09:38:42 INFO - Bus: Built-In 09:38:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:42 INFO - Vendor: Intel (0x8086) 09:38:42 INFO - Device ID: 0x0a2e 09:38:42 INFO - Revision ID: 0x0009 09:38:42 INFO - Displays: 09:38:42 INFO - Display: 09:38:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:42 INFO - Display Serial Number: 1600x1200 60 09:38:42 INFO - Main Display: Yes 09:38:42 INFO - Mirror: Off 09:38:42 INFO - Online: Yes 09:38:42 INFO - Rotation: Supported 09:38:42 INFO - Return code: 0 09:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:42 INFO - Python 2.7.3 09:38:42 INFO - Return code: 0 09:38:42 INFO - grabbing minidump binary from tooltool 09:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:42 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 0x10aa9bd30>, '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 0x10a9c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa90be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:42 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 09:38:42 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 09:38:42 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 09:38:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:42 INFO - Return code: 0 09:38:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:38:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:42 INFO - ENV: RUST_BACKTRACE is now 1 09:38:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:38:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:42 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/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 09:38:42 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/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 09:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J3hc3KTjLH/Render', 09:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:42 INFO - 'HOME': '/Users/cltbld', 09:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:42 INFO - 'LOGNAME': 'cltbld', 09:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:42 INFO - 'MOZ_NO_REMOTE': '1', 09:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:42 INFO - 'NO_EM_RESTART': '1', 09:38:42 INFO - 'PAGER': '/bin/cat', 09:38:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:42 INFO - 'PWD': '/builds/slave/test', 09:38:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:42 INFO - 'RUST_BACKTRACE': '1', 09:38:42 INFO - 'SHELL': '/bin/bash', 09:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gIAOVfodQ5/Listeners', 09:38:42 INFO - 'TMPDIR': '/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/', 09:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:42 INFO - 'USER': 'cltbld', 09:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:42 INFO - 'XPC_FLAGS': '0x0', 09:38:42 INFO - 'XPC_SERVICE_NAME': '0', 09:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:42 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/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 09:38:42 INFO - mozversion application_buildid: 20170403080823 09:38:42 INFO - mozversion application_changeset: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b 09:38:42 INFO - mozversion application_display_name: Nightly 09:38:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:42 INFO - mozversion application_name: Firefox 09:38:42 INFO - mozversion application_remotingname: firefox 09:38:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:38:42 INFO - mozversion application_vendor: Mozilla 09:38:42 INFO - mozversion application_version: 55.0a1 09:38:42 INFO - mozversion platform_buildid: 20170403080823 09:38:42 INFO - mozversion platform_changeset: 9aacfa8081b35bb8ae1a59ce3fd9d7aba57cfc7b 09:38:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:38:42 INFO - mozversion platform_version: 55.0a1 09:38:42 INFO - using testdate: 1491237522 09:38:42 INFO - actual date: 1491237522 09:38:42 INFO - starting webserver on 'localhost:49235' 09:38:42 INFO - SUITE-START | Running 2 tests 09:38:42 INFO - TEST-START | dromaeo_css 09:38:42 INFO - operating with platform_type : mac_ 09:38:42 INFO - Initialising browser for dromaeo_css test... 09:38:42 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/tmpfZv789/profile http://localhost:49235/getInfo.html) 09:38:45 INFO - PID 1634 | __metrics Screen width/height:1600/1200 09:38:45 INFO - PID 1634 | colorDepth:24 09:38:45 INFO - PID 1634 | Browser inner width/height: 1024/689 09:38:45 INFO - PID 1634 | __metrics 09:38:45 INFO - PID 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:45 INFO - PID 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:46 INFO - TEST-INFO | 1634: exit 0 09:38:46 INFO - Browser initialized. 09:38:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:46 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/tmpfZv789/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:58 INFO - PID 1636 | RSS: Main: 234332160 09:38:58 INFO - PID 1636 | 09:42:03 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 09:42:05 INFO - PID 1636 | RSS: Main: 420155392 09:42:05 INFO - PID 1636 | 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:43:48 INFO - PID 1636 | 09:43:48 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:48 INFO - PID 1636 | Full stack: 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:43:48 INFO - PID 1636 | 09:43:48 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:48 INFO - PID 1636 | Full stack: 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:43:48 INFO - PID 1636 | 09:43:48 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:48 INFO - PID 1636 | Full stack: 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | ************************* 09:43:48 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:43:48 INFO - PID 1636 | 09:43:48 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:43:48 INFO - PID 1636 | Full stack: 09:43:48 INFO - PID 1636 | ************************* 09:45:08 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 09:45:09 INFO - PID 1636 | RSS: Main: 367742976 09:45:09 INFO - PID 1636 | 09:48:11 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 09:48:11 INFO - PID 1636 | RSS: Main: 357634048 09:48:11 INFO - PID 1636 | 09:51:14 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 09:51:15 INFO - PID 1636 | RSS: Main: 330829824 09:51:15 INFO - PID 1636 | 09:54:18 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 09:54:19 INFO - PID 1636 | RSS: Main: 331153408 09:54:19 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 09:57:22 INFO - PID 1636 | RSS: Main: 626855936 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | __start_tp_report 09:57:22 INFO - PID 1636 | _x_x_mozilla_page_load 09:57:22 INFO - PID 1636 | _x_x_mozilla_page_load_details 09:57:22 INFO - PID 1636 | |i|pagename|runs| 09:57:22 INFO - PID 1636 | |0;dojo.html;3186.697263759943;3478.982605086974;3494.6155922848484;3526.8589256429746;3547.9467807982883;5289.629725919187;5951.851203719909;6011.098335249704;6096.194094249977;6186.969065154668;6001.87996240075;6098.756049758015;6111.755529778803;6131.325554189047;6137.324894261627;5243.292155558998;5258.44786297439;5277.525022747952;5282.498162674559;5404.675719456825;5376.78492860287;5382.434844341346;5389.919151212715;5392.352917649888;5394.244805727201;5427.755750991215;5434.2935418395555;5476.452354764511;5492.286002819628;5494.120940649497;5451.04606693829;5457.590680698963;5457.617966742329;5460.836174914759;5461.1262198048125;5191.351081114861;5392.946070539284;5398.730063496849;5408.567314614861;5435.809746658848;6086.269647642267;6180.47465965389;6193.2877719062435;6198.101275315099;6217.471514921237;6549.345065493412;6551.115599394068;6553.4101930826455;6555.082288479617;6557.213134423852;6187.876242475125;6393.041043843415;6608.504362172808;6642.368974947372;6655.035019922084;6176.660283684396;6179.351168127372;6233.252009758858;6247;6279.434850863444;6837.418819400406;6840.726370945206;6841.452683785285;6849.1438570178725;6862.348076932683;6479.935200647933;6505.674716264168;6526.086347911296;6526.412622863965;6545.181852268466;6312.368763123651;6418.807435776934;6423.74305027803;6430;6608.768693095719;6317.4630156437215;6371.23545174582;6371.426571608577;6374.649394283359;6384.265809431882;5822.592418530747;6358.650274234961;6459.612423254526;6478.384553467413;6561.704723287464;5250.317458730341;5257.974694934451;5262.736863156827;5274.7890084396195;5302.734863256822;4690.530946905282;4709.905801884011;4726.1492931272705;4727.621790256771;4744.572988431058;6108.107033517593;6207.286162091417;6208.192934918432;6259.123722678829;6333.271673757485;6582.111414959015;6613.2394774601535;6614.570052946543;6628.933710662928;6633.369829866155;6325.209348831396;6325.652089135142;6333.619982801047;6333.968330158412;6342.651154186472;5662.462066103713;5749.482546570829;5753.33836608787;5777.682227477445;5811.88376232473;5525.585581081355;6543.640099794557;6560.343965603402;6580.901286480803;6592.241892182268;6393.073004414427;6395.776147834804;6417.101605775289;6419.2938776735455;6522.543421960607;6759.391654750899;6865.588064716133;6880.552764070319;6892.793216203522;6895.138107736533;6523.67381630907;6551.377619126175;6556.0493728410065;6562.409383155348;6569.113169722026;6368.044793280859;6410.326915673787;6653.567518111307;6658.866822663423;6678.332166783282;5391;5680.943190568041;6322.36776322364;6381.266154392119;6424.614523128627;6438.935610644021;6464.935350646433;6465.741370345134;6469.385408386196;6480;6340.1440805490665;6348.460380867678;6366.267879193952;6369.681515924278;6387.712552935222;6208.130861679459;6267.905981410374;6274.372562743689;6359.904601431075;6470;6270.2475702915945;6295.496360291258;6306.46395056407;6307.495400368051;6321.051842223703 09:57:22 INFO - PID 1636 | |1;ext.html;735.8234023834282;799.1568894815969;816.5917041479258;1137.7383201863577;1159.7100724818795;27856;28098.719012809866;28110.578341324846;28141.57787633187;28173;37713.81143094288;37827.86516404512;37907;38025.619743802556;38196.23607527848;8131.959340203305;8583.484990900535;8586.570671466432;8605.31157507401;8612.39713220075;6004.039353703409;6161.014237721965;8418;8589.09814469481;8594.613242404075;8381.497110173379;8587.31301495882;8587.742367728946;8589.355798315151;8604.268637165816;8568.700095496659;8605.741827745178;8610.268127209194;8623.13768623139;8647.524386158759;5640.2667653205235;6058.333583305833;7988.161243069452;8348.165183481664;8484.32125429964;37283.4407483888;37465.625343746484;37518.43722344167;37561.43657845134;37590.62409375898;2938.427006733688;2941.4117176564773;2984.582158497812;2986.6266716660416;3066.9386612267854;27447.783598930226;27461.86269068642;27659.723402765914;28138.015169469174;28200.153995380173;2763.226296636945;2799.860006999642;2813.127930341601;2830.3490197254746;2933.0467598030727;315758;316252;317959.4102029475;318956.40521797474;319316;50065.74967125214;50066.499335006185;50104.74947625311;50433;50518.24222636663;51300.48699513032;52043.47956520387;52107.73946130321;52164.47835521672;52222.73888630533;14325.92837035829;14357.78463323051;14409.567712968628;14427.278636068364;14433.391652086979;11747.060235181165;11756.58851940178;11762.70593235176;11764.235324703866;11765.411729413496;11029.503672334764;11214.271072380268;12024.977876880388;12758.55345062937;12950.611481655566;5414.620976531605;5431.53831924283;5448.727563621803;5474.124140137559;5489.58828087895;866.4151697604218;954.3224310739453;961.6441916490943;976.6728146071003;991.1674193677345;22543.661845072336;23691.881540592185;23807.047718091082;23849.523009539713;23905.16331928374;898.6764764684708;1061.1510791366875;1083.2525557365393;1106.1869525898458;1110.8333749937412;9061.954690226507;10532.052115309505;11496.42517874103;11850.170488065925;12157.027437804954;405518;410933;412316;413135;421816;55002.724986374815;55085;55266.17100743412;55287.447125529034;55547.72226138844;1434.8923830712738;1464.3044553836842;1475.0412232049255;1487.174618086972;1502.5417247739326;27763.167104986882;28121.296967575974;28539.42921141607;28708;28742.568861467513;37152.88541343764;37228;37270.25459490849;37317.44023839699;37340.813295933345;384939;386203;387142.0642896767;388119.05940470117;388396;31821.681783181873;32225.35549289048;32651.67348326486;32655.673443266212;32686.83656581702;33971.15072123217;41527.96180095522;41683.583164169184;41824.581754182065;42310.51913183024;27587.862060689567;28205.57691634586;28763.5685464714;29440.969566065083;29916.662083997264;28807.56788648214;28905.710942891143;29338.826446941883;29477;29740.85129574338;34036.659633403346;34709.826450867586;34820;34831.12922176966;34957.30085398227;27957.720422796327;28938.710612893603;29567.55648665315;29810;30014.84992575023;23376.883115584315;23472.943717533093;23477.17829875946;23677.289681309587;23805.880970595037 09:57:22 INFO - PID 1636 | |2;jquery.html;391.5594955674866;411.88055463915464;427.11800132725926;428.33607907743;440.8853698038509;13571.932140339297;15514.285000124975;22254.221102261425;22370.105195792188;22809;23144.3056708299;23195.07219711214;23610.173643922466;23614.881925590347;23765.336426450154;5923;6310.999999999977;6334.429901308881;6342.746290148389;6347.555671103025;6009;6190.411910868483;6219.315875253718;6271.341509141543;6328.493720502349;6180.598261113036;6199.194104766374;6222.595531290452;6232.563720539564;6243;5924.881502369972;6102.542309326774;6173.1048997895505;6195.4424101831055;6233.1273621693;5363.9463605363835;5495.862603434946;5502.367227768817;5511.807086751985;5526.778928842841;26790.732092679213;27507.449851003068;27595.724042759517;27913.441731165465;27946.441071178666;2024.2004408258802;2035.2571311471354;2036.0634108310196;2067.390119914629;2068.855180137391;16252.674946501122;16829.91585042079;16931.407400740914;17126.14369281531;17141.48575542736;1857.7677790276216;1878.7745470543487;1882.5011371986434;1886.6132442849182;1896.1941175000707;138323;144315.27842360825;145267.273663631;145461;146660;11359.716007099889;11668.474918628683;12168.81746773799;12179.08656850722;12228.327441990776;16239.350425983064;16264.349426022827;16274.674506509804;16294.185290735415;16315.51053468398;7566.924330756732;8521.744347669579;8811.471311721318;8884.466931984101;8980.550972451481;6860.656967151623;8433.451825631315;8461.703840365557;8659.913400865911;8677.479351238946;6731.394174524316;7612.8477430451085;7783.688652453839;7791.805204869924;7813.960930195312;2102.653062244743;2110.504031552615;2111.0500274876367;2112.0812446585783;2115.323096609101;942.9811403771886;963.8120566489467;967.3373738988674;977;980.2403137568441;19899.005049747455;20033.59932801336;21591.460213494473;21684.89157554202;21699.023543940562;917.2391102780546;978.3738407419257;1005.3515482513884;1008.4806324742764;1023.4217667018111;8366.991072626184;10272.640457584099;10935.28920620157;10999.875046857429;11014.724631884266;699888;701904;702405;705684;711752;120697;152419;153522;156104.438955609;168380.68764155183;1032.9380237185792;1217.8355921950601;1262.1291308996763;1267.518343029643;1268.8731126887237;17735.911320443833;19716.90141549283;20234;21417.822019789062;21481.322862250745;59592.21223363306;62572.687136564025;63193.42016449625;63569.682151588946;64515.03227451686;67591.66204169144;71821.6408917952;86686;86863;88379.55810221165;8465.195806398382;8493.830123397622;8574.742757717278;8815.823683526165;9081.228095611947;12136.089793265717;12221.755564888475;13721.588352349445;14016.159030458206;14376.424943002163;11697;11734.765304693688;11887.583934562595;12051.698707532381;12102;9240.122188392092;10824.917508249113;11095.611653592085;11291.153163512605;11447.599334023269;9333.719988400358;12099.455524501594;12278.263304201777;12350.011999040235;12383.504659813507;6942.826429339307;8571.100034496289;8607.741767746978;8913.019567847401;8917.687880924137;10773.676789696321;11404.82892756626;11741.530338786353;11771.47028383742;12156.1490695654 09:57:22 INFO - PID 1636 | |3;mootools.html;1294.5598496511184;1435.4975758484532;1459.212025506226;1467.3836988464843;1469.5444412232202;9133.634654613825;10569.841452378221;10979;11040.171987100959;11057.281276717007;10620.78758424831;10775.407352595605;10827.67516974492;10944.890551094486;10947.56209751609;2373.32360277321;2445.0464318915638;2445.327534927891;2449.069353645612;2453.5706251406023;2048.426440596628;2286.7141607299086;2374.15717420315;2377.5126099149634;2422.9636555451684;1781.991090044548;2132.76539580646;2359.8466099703464;2435.0138194031356;2445.0464318915638;2405.0860672944254;2415.5410472010262;2417.504411595619;2420.165043060141;2425.4300239443714;2038.0828627117708;2370.6605767741344;2412.589859723851;2413.80689544836;2421.4672771990136;9320.533973301375;10494.422806745626;10781.02970732638;10809.405482698448;10830.891691083147;6044.153818465418;6266.561340706153;6271.02799066141;6275.09011193379;6283.403076707751;3976.562578116405;3983.780892050936;3992.820323085439;4049.1699201663587;4054.1891621675486;1165.370699822095;1176.7764124816342;1197.5099710024442;1215.4773447417606;1231.975360492785;14593.78109328361;14902.254887255594;14955.925220373938;14956.925215373962;14959.775603365959;5542.944570554324;5701.486866182064;5769.163471296639;5829.59192856496;5872.354041055481;12614.180078294881;12632.115751897463;12648.87351126477;12651.177673451197;12673;6432.967835160888;6433.839154021093;6435.903461448082;6441.355864413615;6444.226692796894;5260.868478288074;5739.253896993364;5829.708514574254;5834.066549352084;5834.15404766315;4252.787360632018;4406.471223453142;4413.293872980308;4469.061497085583;4470.821167153343;1358;1403.4035534897628;1408.1973275233224;1426.4222989689192;1430.8926830487756;760.6878135216817;761.9276168763959;765.7900517182837;789.2817536042289;799.9760007199793;5714.285714285715;5854.941450585439;5900.350961394243;5955;6032.969835150884;570.7415149595133;584.7953216374235;593.092568370394;601.2664549249909;601.6811090122242;3471.253680458663;3745;3990.86031988879;4097.672186225154;4159.480064991876;10318.468165633385;13096.869031309565;13225.603231902865;13379.866201338056;13380.130291531019;12713;13047.412866421033;13183.274919879499;13272.668183295495;13274.800877986838;9782.902170978341;9815.41107533536;9848.852267215998;9958.950205249072;9966.80066398668;6103.206583144163;6258.468030217483;6352.237731472253;6359.109724638647;6432.292447830641;11741.17811753169;11904.404779760804;11934.462949167135;12021.158518903592;12141.15011949155;12068.939655301667;12146.514139434325;12171.33057681836;12318.630441086782;12320.568780092653;8514.148585141436;8760.956195218983;8772.736817895473;8785.604647790737;8794.780130496532;9584.66453674118;9655.662051828152;9777.608895644094;9930.304878658713;10016;8391;8499.192576705203;8540.060593334852;8579.914200857911;8742.737717868475;7138.892916606359;8247.793805154919;8330.833383332421;8440.577971101298;8510.872336915076;6237.313895471585;7724.6910123594425;7794.649240784065;7822.5697586631;7828.686852525835;5832.737526811388;5894.056950887837;5939.732712027882;6001.5798894077;6019.4883434908525;5926.881462370815;5984.311804142405;6042.516598672008;6086.817395478142;6118.5411094169 09:57:22 INFO - PID 1636 | |4;prototype.html;386.2564563215809;390.9628585284397;393.5002546765609;398.79661372699917;400.035913448589;4704.576588107074;5904;5964.79123230687;5969.492593129578;6002.789902353418;4611.19304121779;4796.880077998052;5762.135679648044;5841.561882858781;5916.0830071338905;4502.302143167814;4507.616852567536;4536.637069034469;4539.954600453986;4543.568361005708;4528.894064260118;4529.660275479336;4532.342810292505;4535.70517916336;4549.954500455003;3882.854557905425;4096.549379568245;4283.7215580987295;4406.766105490467;4527.2530032544755;4149.98725618075;4446.288593825005;4446.510883802779;4457.818678050303;4479.148961697283;3753;3991.1818077294083;4007.2786898358286;4019.658329042035;4027.536833264183;4376.365427013097;5745.339285982123;5747.971260143672;5778.075507918713;5820.9708951455395;5210.97394513025;5214.843554693365;5219.765110569995;5220.92168617471;5225.137852254374;6304.684765761694;6359.745610175587;6379.617222966637;6390.968045159791;6400.39196276353;3564.554430696163;4040.959590404117;4226.436218599108;4299.118680670486;4300.61294483498;6075.908861367083;6115.92971230033;6386.9680651596445;6425.907595708741;6582.440492558138;3862.748921320105;3869.1294458746556;4089.6114869087387;4153.460050193456;4357.433533640607;3715.5727091384297;4387.648988080946;4429.468463784367;4442.888927776831;4448.621867141329;4741.716767360436;4923.212286034217;5064.49355064498;5177.524405544402;5198.9740051299505;5398.24424580559;6094;6293.874122517615;6368.617882927039;6372.299047104815;1289.7162624222656;1410.7249086428048;1425.600831767107;1519.7720341948575;1520.8022957015517;985.5072463768116;998.5556427389741;1009.1472705563787;1009.5608410341525;1021.8978102189722;5851.707414629252;5933.910991335133;5968.671723055187;5997.7001149942325;6023.849403764853;5956.374580668968;5963.135345374896;6301.747930082745;6444.355564443518;6529.314421985718;5713.714314284269;5728.198052272685;5924.7926322578505;5941.940580594139;5968.582199246098;3386.407378708716;3410.8914602754203;3429.6913277805115;3436.226848958964;3439.8108104054018;6597.439217666456;6756.425703815133;6774.729010839511;6774.729010839511;6781.932180678229;5290.603204759658;6690;6695.598264104169;6748.898766518506;6765.661716914233;6163.106349579376;6250.406211409909;6725.9663701681175;6747.414357625954;6749.291324410866;4884.462709101925;5234.031704134747;6117.6846977898185;6382.329855365306;6510.967445162744;5367.275417818544;6385.93614063872;6407.070974708734;6419.683964787114;6431.710573024318;5967.46292833647;6403.359664033559;6461.19235095613;6675.532712710064;6836.0858959491425;4321.178975994551;4330.41539392178;4338.739675619473;4343.4136391586735;4343.652507799432;5550.361708403424;6264.771279386487;6541.364658835291;6570.441512471493;6600.867982640224;5446.828931779686;6080.847978800565;6322.683865806599;6322.968385158229;6348.5238607105575;5429.67421954684;6208.379162083756;6331.303556608677;6368.115449575847;6379.628379898344;5380.488853558905;6010.557466208166;6124.385663483338;6192.287886893065;6213.9067913982235;5291.682499050069;5492.91760623583;6311.990081586924;6316.6841657916;6355.14205582259;5199.958024555526;6111.477506644962;6164.137020816999;6185.226846644169;6207.351310307598 09:57:22 INFO - PID 1636 | |5;yui.html;658.6871236162822;723.7032816545214;727.6652739739719;732.103173612325;745.2696357569582;15399.692006159885;15896.205189740496;16191.433299834509;16264.75602865958;16309.755353669674;15202.467913623026;15440.150791706452;15453.30460129294;15457.690846183097;15522.30149643266;954.4750387286999;971.218169373654;972.2173650211577;974.4786539201529;978.0806042320232;976.7167521418816;979.6865003198943;984.3650845204838;984.9606015759362;986.2061040862103;1008.5058321422487;1049.5172220778452;1050.8844027157006;1054.088213695152;1054.752133248686;1037.222083437422;1037.6005237983354;1050.154625526451;1051.0435503691604;1052.0636633396207;769.3114662377197;769.3921801776589;772.5364781131276;773.6827900560743;775.9030121234846;16812.411565595146;16816.32734690611;16911.900726452743;17009.829901701072;17021.23404446803;12007.699807504794;14780.926095369561;15031.699366012619;15263.236838158047;15758.448454304043;11591.884081159165;11748.236364636357;11844.541022787915;11926.344051077274;11986.460609272604;2985.402919416104;3036.4686179918426;3052.13014290926;3064.55563943227;3175.0157451189975;120428.39785801103;122466.82900163974;124301;125066;127290.36354818166;11499.597514086967;11525.827112593317;11646.70883227926;11903.70240743971;11904.464299106561;25540.74459255421;25577.104801332236;25599.87200064025;25604.871975640373;25672.871635641703;7878.448508604342;7921.920780792118;7951.403644726669;8091.878621820678;8134.59327033646;4142.5857414258335;4203.60138331274;4237.978810105929;4240.257954857888;4251.80866860992;4068.06434520062;4102.200070986189;4175.352820312856;4177.561356057631;4200.5169405518145;778.4706399648294;780.3523075847147;798.5887268056955;798.6765360029198;806.4113197365956;469.7017393954863;512.0373697448772;537.2263939926494;549.3929208224934;551.3081083240587;9211.631534738535;9698.951505242429;10441.947790261;10492.580296788195;10500.947495262628;523.3170712220513;552.4422717698012;561.2983770287141;571.5399103721544;592.4963780786297;4221.261279276176;4550.453945526558;4822.083804077214;4855.417349918032;4902.28916807061;105666.47166764116;105913.47043264734;106636;107881.4605926981;108204;89629;90197;90988.54505727561;93066;94644;58938;62018.68990655018;77920;80205.19794801978;81540.66134047964;8254.752357429286;9148.908510914805;9652.131308182297;9658.57794847506;9682.661106861226;35187.82406087953;39761.80119099386;40098.79950600228;40167;41895.7905210472;44105.77947110372;51033.489665102876;53026.469735302155;53029.46970530245;53946.460535394144;11682.415879205835;11747.118966077407;11863;12195.451204695988;12335.629931102081;11655.708607284885;12682.873171268538;12761.361931903553;12920.547780827626;13002.739945201232;10472.005159509834;11667.6079224008;11709.180357374902;11919.284842909454;12324.445399957203;9887.4067555944;11744.471498782746;11935.224210426295;12430.502779888704;12689.4289756963;11684.941575292069;11806.586769463027;11839.348835814113;12091.093168012258;12295.56965506203;9104.726858194264;9278.907210928075;9283.62865485373;9442.38624489406;9488.383255088396;8058.033036035713;8971.461712297283;9154.633814647339;9654.903450965681;10121.59513619447 09:57:22 INFO - PID 1636 | __end_tp_report 09:57:22 INFO - PID 1636 | __start_cc_report 09:57:22 INFO - PID 1636 | _x_x_mozilla_cycle_collect,2003 09:57:22 INFO - PID 1636 | __end_cc_report 09:57:22 INFO - PID 1636 | __startTimestamp1491238642770__endTimestamp 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | ------- Summary: start ------- 09:57:22 INFO - PID 1636 | Number of tests: 6 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6045.98 Median:6317.46 stddev:698.39 (11.1%) stddev-sans-first:663.53 09:57:22 INFO - PID 1636 | Values: 3186.7 3479.0 3494.6 3526.9 3547.9 5289.6 5951.9 6011.1 6096.2 6187.0 6001.9 6098.8 6111.8 6131.3 6137.3 5243.3 5258.4 5277.5 5282.5 5404.7 5376.8 5382.4 5389.9 5392.4 5394.2 5427.8 5434.3 5476.5 5492.3 5494.1 5451.0 5457.6 5457.6 5460.8 5461.1 5191.4 5392.9 5398.7 5408.6 5435.8 6086.3 6180.5 6193.3 6198.1 6217.5 6549.3 6551.1 6553.4 6555.1 6557.2 6187.9 6393.0 6608.5 6642.4 6655.0 6176.7 6179.4 6233.3 6247.0 6279.4 6837.4 6840.7 6841.5 6849.1 6862.3 6479.9 6505.7 6526.1 6526.4 6545.2 6312.4 6418.8 6423.7 6430.0 6608.8 6317.5 6371.2 6371.4 6374.6 6384.3 5822.6 6358.7 6459.6 6478.4 6561.7 5250.3 5258.0 5262.7 5274.8 5302.7 4690.5 4709.9 4726.1 4727.6 4744.6 6108.1 6207.3 6208.2 6259.1 6333.3 6582.1 6613.2 6614.6 6628.9 6633.4 6325.2 6325.7 6333.6 6334.0 6342.7 5662.5 5749.5 5753.3 5777.7 5811.9 5525.6 6543.6 6560.3 6580.9 6592.2 6393.1 6395.8 6417.1 6419.3 6522.5 6759.4 6865.6 6880.6 6892.8 6895.1 6523.7 6551.4 6556.0 6562.4 6569.1 6368.0 6410.3 6653.6 6658.9 6678.3 5391.0 5680.9 6322.4 6381.3 6424.6 6438.9 6464.9 6465.7 6469.4 6480.0 6340.1 6348.5 6366.3 6369.7 6387.7 6208.1 6267.9 6274.4 6359.9 6470.0 6270.2 6295.5 6306.5 6307.5 6321.1 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:50522.82 Median:34003.91 stddev:99234.76 (291.8%) stddev-sans-first:99442.74 09:57:22 INFO - PID 1636 | Values: 735.8 799.2 816.6 1137.7 1159.7 27856.0 28098.7 28110.6 28141.6 28173.0 37713.8 37827.9 37907.0 38025.6 38196.2 8132.0 8583.5 8586.6 8605.3 8612.4 6004.0 6161.0 8418.0 8589.1 8594.6 8381.5 8587.3 8587.7 8589.4 8604.3 8568.7 8605.7 8610.3 8623.1 8647.5 5640.3 6058.3 7988.2 8348.2 8484.3 37283.4 37465.6 37518.4 37561.4 37590.6 2938.4 2941.4 2984.6 2986.6 3066.9 27447.8 27461.9 27659.7 28138.0 28200.2 2763.2 2799.9 2813.1 2830.3 2933.0 315758.0 316252.0 317959.4 318956.4 319316.0 50065.7 50066.5 50104.7 50433.0 50518.2 51300.5 52043.5 52107.7 52164.5 52222.7 14325.9 14357.8 14409.6 14427.3 14433.4 11747.1 11756.6 11762.7 11764.2 11765.4 11029.5 11214.3 12025.0 12758.6 12950.6 5414.6 5431.5 5448.7 5474.1 5489.6 866.4 954.3 961.6 976.7 991.2 22543.7 23691.9 23807.0 23849.5 23905.2 898.7 1061.2 1083.3 1106.2 1110.8 9062.0 10532.1 11496.4 11850.2 12157.0 405518.0 410933.0 412316.0 413135.0 421816.0 55002.7 55085.0 55266.2 55287.4 55547.7 1434.9 1464.3 1475.0 1487.2 1502.5 27763.2 28121.3 28539.4 28708.0 28742.6 37152.9 37228.0 37270.3 37317.4 37340.8 384939.0 386203.0 387142.1 388119.1 388396.0 31821.7 32225.4 32651.7 32655.7 32686.8 33971.2 41528.0 41683.6 41824.6 42310.5 27587.9 28205.6 28763.6 29441.0 29916.7 28807.6 28905.7 29338.8 29477.0 29740.9 34036.7 34709.8 34820.0 34831.1 34957.3 27957.7 28938.7 29567.6 29810.0 30014.8 23376.9 23472.9 23477.2 23677.3 23805.9 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:40245.13 Median:23169.69 stddev:117753.45 (508.2%) stddev-sans-first:118045.75 09:57:22 INFO - PID 1636 | Values: 391.6 411.9 427.1 428.3 440.9 13571.9 15514.3 22254.2 22370.1 22809.0 23144.3 23195.1 23610.2 23614.9 23765.3 5923.0 6311.0 6334.4 6342.7 6347.6 6009.0 6190.4 6219.3 6271.3 6328.5 6180.6 6199.2 6222.6 6232.6 6243.0 5924.9 6102.5 6173.1 6195.4 6233.1 5363.9 5495.9 5502.4 5511.8 5526.8 26790.7 27507.4 27595.7 27913.4 27946.4 2024.2 2035.3 2036.1 2067.4 2068.9 16252.7 16829.9 16931.4 17126.1 17141.5 1857.8 1878.8 1882.5 1886.6 1896.2 138323.0 144315.3 145267.3 145461.0 146660.0 11359.7 11668.5 12168.8 12179.1 12228.3 16239.4 16264.3 16274.7 16294.2 16315.5 7566.9 8521.7 8811.5 8884.5 8980.6 6860.7 8433.5 8461.7 8659.9 8677.5 6731.4 7612.8 7783.7 7791.8 7814.0 2102.7 2110.5 2111.1 2112.1 2115.3 943.0 963.8 967.3 977.0 980.2 19899.0 20033.6 21591.5 21684.9 21699.0 917.2 978.4 1005.4 1008.5 1023.4 8367.0 10272.6 10935.3 10999.9 11014.7 699888.0 701904.0 702405.0 705684.0 711752.0 120697.0 152419.0 153522.0 156104.4 168380.7 1032.9 1217.8 1262.1 1267.5 1268.9 17735.9 19716.9 20234.0 21417.8 21481.3 59592.2 62572.7 63193.4 63569.7 64515.0 67591.7 71821.6 86686.0 86863.0 88379.6 8465.2 8493.8 8574.7 8815.8 9081.2 12136.1 12221.8 13721.6 14016.2 14376.4 11697.0 11734.8 11887.6 12051.7 12102.0 9240.1 10824.9 11095.6 11291.2 11447.6 9333.7 12099.5 12278.3 12350.0 12383.5 6942.8 8571.1 8607.7 8913.0 8917.7 10773.7 11404.8 11741.5 11771.5 12156.1 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:6653.34 Median:4051.68 stddev:4072.27 (100.5%) stddev-sans-first:4063.78 09:57:22 INFO - PID 1636 | Values: 1294.6 1435.5 1459.2 1467.4 1469.5 9133.6 10569.8 10979.0 11040.2 11057.3 10620.8 10775.4 10827.7 10944.9 10947.6 2373.3 2445.0 2445.3 2449.1 2453.6 2048.4 2286.7 2374.2 2377.5 2423.0 1782.0 2132.8 2359.8 2435.0 2445.0 2405.1 2415.5 2417.5 2420.2 2425.4 2038.1 2370.7 2412.6 2413.8 2421.5 9320.5 10494.4 10781.0 10809.4 10830.9 6044.2 6266.6 6271.0 6275.1 6283.4 3976.6 3983.8 3992.8 4049.2 4054.2 1165.4 1176.8 1197.5 1215.5 1232.0 14593.8 14902.3 14955.9 14956.9 14959.8 5542.9 5701.5 5769.2 5829.6 5872.4 12614.2 12632.1 12648.9 12651.2 12673.0 6433.0 6433.8 6435.9 6441.4 6444.2 5260.9 5739.3 5829.7 5834.1 5834.2 4252.8 4406.5 4413.3 4469.1 4470.8 1358.0 1403.4 1408.2 1426.4 1430.9 760.7 761.9 765.8 789.3 800.0 5714.3 5854.9 5900.4 5955.0 6033.0 570.7 584.8 593.1 601.3 601.7 3471.3 3745.0 3990.9 4097.7 4159.5 10318.5 13096.9 13225.6 13379.9 13380.1 12713.0 13047.4 13183.3 13272.7 13274.8 9782.9 9815.4 9848.9 9959.0 9966.8 6103.2 6258.5 6352.2 6359.1 6432.3 11741.2 11904.4 11934.5 12021.2 12141.2 12068.9 12146.5 12171.3 12318.6 12320.6 8514.1 8761.0 8772.7 8785.6 8794.8 9584.7 9655.7 9777.6 9930.3 10016.0 8391.0 8499.2 8540.1 8579.9 8742.7 7138.9 8247.8 8330.8 8440.6 8510.9 6237.3 7724.7 7794.6 7822.6 7828.7 5832.7 5894.1 5939.7 6001.6 6019.5 5926.9 5984.3 6042.5 6086.8 6118.5 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5083.73 Median:5736.77 stddev:1571.08 (27.4%) stddev-sans-first:1535.41 09:57:22 INFO - PID 1636 | Values: 386.3 391.0 393.5 398.8 400.0 4704.6 5904.0 5964.8 5969.5 6002.8 4611.2 4796.9 5762.1 5841.6 5916.1 4502.3 4507.6 4536.6 4540.0 4543.6 4528.9 4529.7 4532.3 4535.7 4550.0 3882.9 4096.5 4283.7 4406.8 4527.3 4150.0 4446.3 4446.5 4457.8 4479.1 3753.0 3991.2 4007.3 4019.7 4027.5 4376.4 5745.3 5748.0 5778.1 5821.0 5211.0 5214.8 5219.8 5220.9 5225.1 6304.7 6359.7 6379.6 6391.0 6400.4 3564.6 4041.0 4226.4 4299.1 4300.6 6075.9 6115.9 6387.0 6425.9 6582.4 3862.7 3869.1 4089.6 4153.5 4357.4 3715.6 4387.6 4429.5 4442.9 4448.6 4741.7 4923.2 5064.5 5177.5 5199.0 5398.2 6094.0 6293.9 6368.6 6372.3 1289.7 1410.7 1425.6 1519.8 1520.8 985.5 998.6 1009.1 1009.6 1021.9 5851.7 5933.9 5968.7 5997.7 6023.8 5956.4 5963.1 6301.7 6444.4 6529.3 5713.7 5728.2 5924.8 5941.9 5968.6 3386.4 3410.9 3429.7 3436.2 3439.8 6597.4 6756.4 6774.7 6774.7 6781.9 5290.6 6690.0 6695.6 6748.9 6765.7 6163.1 6250.4 6726.0 6747.4 6749.3 4884.5 5234.0 6117.7 6382.3 6511.0 5367.3 6385.9 6407.1 6419.7 6431.7 5967.5 6403.4 6461.2 6675.5 6836.1 4321.2 4330.4 4338.7 4343.4 4343.7 5550.4 6264.8 6541.4 6570.4 6600.9 5446.8 6080.8 6322.7 6323.0 6348.5 5429.7 6208.4 6331.3 6368.1 6379.6 5380.5 6010.6 6124.4 6192.3 6213.9 5291.7 5492.9 6312.0 6316.7 6355.1 5200.0 6111.5 6164.1 6185.2 6207.4 09:57:22 INFO - PID 1636 | 09:57:22 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:20175.04 Median:40132.90 stddev:30430.74 (75.8%) stddev-sans-first:30480.82 09:57:22 INFO - PID 1636 | Values: 658.7 723.7 727.7 732.1 745.3 15399.7 15896.2 16191.4 16264.8 16309.8 15202.5 15440.2 15453.3 15457.7 15522.3 954.5 971.2 972.2 974.5 978.1 976.7 979.7 984.4 985.0 986.2 1008.5 1049.5 1050.9 1054.1 1054.8 1037.2 1037.6 1050.2 1051.0 1052.1 769.3 769.4 772.5 773.7 775.9 16812.4 16816.3 16911.9 17009.8 17021.2 12007.7 14780.9 15031.7 15263.2 15758.4 11591.9 11748.2 11844.5 11926.3 11986.5 2985.4 3036.5 3052.1 3064.6 3175.0 120428.4 122466.8 124301.0 125066.0 127290.4 11499.6 11525.8 11646.7 11903.7 11904.5 25540.7 25577.1 25599.9 25604.9 25672.9 7878.4 7921.9 7951.4 8091.9 8134.6 4142.6 4203.6 4238.0 4240.3 4251.8 4068.1 4102.2 4175.4 4177.6 4200.5 778.5 780.4 798.6 798.7 806.4 469.7 512.0 537.2 549.4 551.3 9211.6 9699.0 10441.9 10492.6 10500.9 523.3 552.4 561.3 571.5 592.5 4221.3 4550.5 4822.1 4855.4 4902.3 105666.5 105913.5 106636.0 107881.5 108204.0 89629.0 90197.0 90988.5 93066.0 94644.0 58938.0 62018.7 77920.0 80205.2 81540.7 8254.8 9148.9 9652.1 9658.6 9682.7 35187.8 39761.8 40098.8 40167.0 41895.8 44105.8 51033.5 53026.5 53029.5 53946.5 11682.4 11747.1 11863.0 12195.5 12335.6 11655.7 12682.9 12761.4 12920.5 13002.7 10472.0 11667.6 11709.2 11919.3 12324.4 9887.4 11744.5 11935.2 12430.5 12689.4 11684.9 11806.6 11839.3 12091.1 12295.6 9104.7 9278.9 9283.6 9442.4 9488.4 8058.0 8971.5 9154.6 9654.9 10121.6 09:57:22 INFO - PID 1636 | -------- Summary: end -------- 09:57:22 INFO - PID 1636 | 09:57:23 INFO - TEST-INFO | 1636: exit 0 09:57:23 INFO - TEST-OK | dromaeo_css | took 1120812ms 09:57:23 INFO - TEST-START | kraken 09:57:23 INFO - operating with platform_type : mac_ 09:57:23 INFO - Initialising browser for kraken test... 09:57:23 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/tmplQxOKU/profile http://localhost:49235/getInfo.html) 09:57:25 INFO - PID 1646 | __metrics Screen width/height:1600/1200 09:57:25 INFO - PID 1646 | colorDepth:24 09:57:25 INFO - PID 1646 | Browser inner width/height: 1024/689 09:57:25 INFO - PID 1646 | __metrics 09:57:25 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:25 INFO - PID 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:26 INFO - TEST-INFO | 1646: exit 0 09:57:26 INFO - Browser initialized. 09:57:26 INFO - Running cycle 1/1 for kraken test... 09:57:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/T/tmplQxOKU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:38 INFO - PID 1647 | RSS: Main: 232140800 09:57:38 INFO - PID 1647 | 09:57:41 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:42 INFO - PID 1647 | RSS: Main: 285999104 09:57:42 INFO - PID 1647 | 09:57:45 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 09:57:45 INFO - PID 1647 | RSS: Main: 286879744 09:57:45 INFO - PID 1647 | 09:57:49 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 09:57:50 INFO - PID 1647 | RSS: Main: 379752448 09:57:50 INFO - PID 1647 | 09:57:52 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 09:57:52 INFO - PID 1647 | RSS: Main: 284086272 09:57:52 INFO - PID 1647 | 09:57:55 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:55 INFO - PID 1647 | RSS: Main: 286056448 09:57:55 INFO - PID 1647 | 09:57:58 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:59 INFO - PID 1647 | RSS: Main: 326406144 09:57:59 INFO - PID 1647 | 09:58:02 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:03 INFO - PID 1647 | RSS: Main: 337457152 09:58:03 INFO - PID 1647 | 09:58:06 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 09:58:07 INFO - PID 1647 | RSS: Main: 343502848 09:58:07 INFO - PID 1647 | 09:58:08 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:09 INFO - PID 1647 | RSS: Main: 304910336 09:58:09 INFO - PID 1647 | 09:58:11 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:11 INFO - PID 1647 | RSS: Main: 307343360 09:58:11 INFO - PID 1647 | 09:58:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:58:14 INFO - PID 1647 | RSS: Main: 310022144 09:58:14 INFO - PID 1647 | 09:58:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:58:18 INFO - PID 1647 | RSS: Main: 329150464 09:58:18 INFO - PID 1647 | 09:58:22 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:58:23 INFO - PID 1647 | RSS: Main: 310493184 09:58:23 INFO - PID 1647 | 09:58:24 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 09:58:25 INFO - PID 1647 | RSS: Main: 376954880 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | __start_tp_report 09:58:25 INFO - PID 1647 | _x_x_mozilla_page_load 09:58:25 INFO - PID 1647 | _x_x_mozilla_page_load_details 09:58:25 INFO - PID 1647 | |i|pagename|runs| 09:58:25 INFO - PID 1647 | |0;ai-astar;111;123;123;124;123;123;124;123;123;123 09:58:25 INFO - PID 1647 | |1;audio-beat-detection;161;120;121;163;124;121;119;115;142;122 09:58:25 INFO - PID 1647 | |2;audio-dft;210;215;213;220;209;211;210;214;212;216 09:58:25 INFO - PID 1647 | |3;audio-fft;91;65;62;100;65;65;64;62;82;63 09:58:25 INFO - PID 1647 | |4;audio-oscillator;93;76;98;76;74;77;92;73;76;92 09:58:25 INFO - PID 1647 | |5;imaging-gaussian-blur;99;91;91;93;91;91;92;91;93;91 09:58:25 INFO - PID 1647 | |6;imaging-darkroom;100;113;144;101;102;100;117;157;100;100 09:58:25 INFO - PID 1647 | |7;imaging-desaturate;103;100;101;100;101;103;102;102;100;101 09:58:25 INFO - PID 1647 | |8;json-parse-financial;53;52;52;52;51;53;54;53;53;52 09:58:25 INFO - PID 1647 | |9;json-stringify-tinderbox;58;57;75;69;67;65;65;65;65;67 09:58:25 INFO - PID 1647 | |10;stanford-crypto-aes;89;92;93;91;91;90;91;90;92;90 09:58:25 INFO - PID 1647 | |11;stanford-crypto-ccm;157;160;170;145;158;137;171;182;199;161 09:58:25 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;236;244;221;195;230;219;243;258;215;260 09:58:25 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;74;75;77;73;73;75;71;72;78;99 09:58:25 INFO - PID 1647 | __end_tp_report 09:58:25 INFO - PID 1647 | __start_cc_report 09:58:25 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2158 09:58:25 INFO - PID 1647 | __end_cc_report 09:58:25 INFO - PID 1647 | __startTimestamp1491238705200__endTimestamp 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | ------- Summary: start ------- 09:58:25 INFO - PID 1647 | Number of tests: 14 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:122.00 Median:123.00 stddev:3.89 (3.2%) stddev-sans-first:0.44 09:58:25 INFO - PID 1647 | Values: 111.0 123.0 123.0 124.0 123.0 123.0 124.0 123.0 123.0 123.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:123.00 stddev:17.94 (14.6%) stddev-sans-first:15.34 09:58:25 INFO - PID 1647 | Values: 161.0 120.0 121.0 163.0 124.0 121.0 119.0 115.0 142.0 122.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:213.00 Median:213.50 stddev:3.37 (1.6%) stddev-sans-first:3.39 09:58:25 INFO - PID 1647 | Values: 210.0 215.0 213.0 220.0 209.0 211.0 210.0 214.0 212.0 216.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:71.90 Median:65.00 stddev:13.89 (21.4%) stddev-sans-first:12.90 09:58:25 INFO - PID 1647 | Values: 91.0 65.0 62.0 100.0 65.0 65.0 64.0 62.0 82.0 63.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:84.50 stddev:9.72 (11.5%) stddev-sans-first:9.57 09:58:25 INFO - PID 1647 | Values: 93.0 76.0 98.0 76.0 74.0 77.0 92.0 73.0 76.0 92.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:91.50 stddev:2.50 (2.7%) stddev-sans-first:0.88 09:58:25 INFO - PID 1647 | Values: 99.0 91.0 91.0 93.0 91.0 91.0 92.0 91.0 93.0 91.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:107.50 stddev:20.69 (19.2%) stddev-sans-first:21.37 09:58:25 INFO - PID 1647 | Values: 100.0 113.0 144.0 101.0 102.0 100.0 117.0 157.0 100.0 100.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:101.50 stddev:1.16 (1.1%) stddev-sans-first:1.05 09:58:25 INFO - PID 1647 | Values: 103.0 100.0 101.0 100.0 101.0 103.0 102.0 102.0 100.0 101.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 09:58:25 INFO - PID 1647 | Values: 53.0 52.0 52.0 52.0 51.0 53.0 54.0 53.0 53.0 52.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.00 stddev:5.12 (7.8%) stddev-sans-first:4.70 09:58:25 INFO - PID 1647 | Values: 58.0 57.0 75.0 69.0 67.0 65.0 65.0 65.0 65.0 67.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:91.00 stddev:1.20 (1.3%) stddev-sans-first:1.05 09:58:25 INFO - PID 1647 | Values: 89.0 92.0 93.0 91.0 91.0 90.0 91.0 90.0 92.0 90.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:164.00 Median:165.50 stddev:17.75 (10.7%) stddev-sans-first:18.64 09:58:25 INFO - PID 1647 | Values: 157.0 160.0 170.0 145.0 158.0 137.0 171.0 182.0 199.0 161.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:232.10 Median:239.50 stddev:20.26 (8.5%) stddev-sans-first:21.44 09:58:25 INFO - PID 1647 | Values: 236.0 244.0 221.0 195.0 230.0 219.0 243.0 258.0 215.0 260.0 09:58:25 INFO - PID 1647 | 09:58:25 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:75.00 stddev:8.12 (10.8%) stddev-sans-first:8.56 09:58:25 INFO - PID 1647 | Values: 74.0 75.0 77.0 73.0 73.0 75.0 71.0 72.0 78.0 99.0 09:58:25 INFO - PID 1647 | -------- Summary: end -------- 09:58:25 INFO - PID 1647 | 09:58:26 INFO - TEST-INFO | 1647: exit 0 09:58:26 INFO - TEST-OK | kraken | took 62629ms 09:58:26 INFO - SUITE-END | took 1183s 09:58:26 INFO - Completed test suite (00:19:43) 09:58:26 INFO - javascript benchmark 09:58:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7540.9110219218455, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.697263759943, 3478.982605086974, 3494.6155922848484, 3526.8589256429746, 3547.9467807982883, 5289.629725919187, 5951.851203719909, 6011.098335249704, 6096.194094249977, 6186.969065154668, 6001.87996240075, 6098.756049758015, 6111.755529778803, 6131.325554189047, 6137.324894261627, 5243.292155558998, 5258.44786297439, 5277.525022747952, 5282.498162674559, 5404.675719456825, 5376.78492860287, 5382.434844341346, 5389.919151212715, 5392.352917649888, 5394.244805727201, 5427.755750991215, 5434.2935418395555, 5476.452354764511, 5492.286002819628, 5494.120940649497, 5451.04606693829, 5457.590680698963, 5457.617966742329, 5460.836174914759, 5461.1262198048125, 5191.351081114861, 5392.946070539284, 5398.730063496849, 5408.567314614861, 5435.809746658848, 6086.269647642267, 6180.47465965389, 6193.2877719062435, 6198.101275315099, 6217.471514921237, 6549.345065493412, 6551.115599394068, 6553.4101930826455, 6555.082288479617, 6557.213134423852, 6187.876242475125, 6393.041043843415, 6608.504362172808, 6642.368974947372, 6655.035019922084, 6176.660283684396, 6179.351168127372, 6233.252009758858, 6247.0, 6279.434850863444, 6837.418819400406, 6840.726370945206, 6841.452683785285, 6849.1438570178725, 6862.348076932683, 6479.935200647933, 6505.674716264168, 6526.086347911296, 6526.412622863965, 6545.181852268466, 6312.368763123651, 6418.807435776934, 6423.74305027803, 6430.0, 6608.768693095719, 6317.4630156437215, 6371.23545174582, 6371.426571608577, 6374.649394283359, 6384.265809431882, 5822.592418530747, 6358.650274234961, 6459.612423254526, 6478.384553467413, 6561.704723287464, 5250.317458730341, 5257.974694934451, 5262.736863156827, 5274.7890084396195, 5302.734863256822, 4690.530946905282, 4709.905801884011, 4726.1492931272705, 4727.621790256771, 4744.572988431058, 6108.107033517593, 6207.286162091417, 6208.192934918432, 6259.123722678829, 6333.271673757485, 6582.111414959015, 6613.2394774601535, 6614.570052946543, 6628.933710662928, 6633.369829866155, 6325.209348831396, 6325.652089135142, 6333.619982801047, 6333.968330158412, 6342.651154186472, 5662.462066103713, 5749.482546570829, 5753.33836608787, 5777.682227477445, 5811.88376232473, 5525.585581081355, 6543.640099794557, 6560.343965603402, 6580.901286480803, 6592.241892182268, 6393.073004414427, 6395.776147834804, 6417.101605775289, 6419.2938776735455, 6522.543421960607, 6759.391654750899, 6865.588064716133, 6880.552764070319, 6892.793216203522, 6895.138107736533, 6523.67381630907, 6551.377619126175, 6556.0493728410065, 6562.409383155348, 6569.113169722026, 6368.044793280859, 6410.326915673787, 6653.567518111307, 6658.866822663423, 6678.332166783282, 5391.0, 5680.943190568041, 6322.36776322364, 6381.266154392119, 6424.614523128627, 6438.935610644021, 6464.935350646433, 6465.741370345134, 6469.385408386196, 6480.0, 6340.1440805490665, 6348.460380867678, 6366.267879193952, 6369.681515924278, 6387.712552935222, 6208.130861679459, 6267.905981410374, 6274.372562743689, 6359.904601431075, 6470.0, 6270.2475702915945, 6295.496360291258, 6306.46395056407, 6307.495400368051, 6321.051842223703], "value": 5999.644035378048, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8234023834282, 799.1568894815969, 816.5917041479258, 1137.7383201863577, 1159.7100724818795, 27856.0, 28098.719012809866, 28110.578341324846, 28141.57787633187, 28173.0, 37713.81143094288, 37827.86516404512, 37907.0, 38025.619743802556, 38196.23607527848, 8131.959340203305, 8583.484990900535, 8586.570671466432, 8605.31157507401, 8612.39713220075, 6004.039353703409, 6161.014237721965, 8418.0, 8589.09814469481, 8594.613242404075, 8381.497110173379, 8587.31301495882, 8587.742367728946, 8589.355798315151, 8604.268637165816, 8568.700095496659, 8605.741827745178, 8610.268127209194, 8623.13768623139, 8647.524386158759, 5640.2667653205235, 6058.333583305833, 7988.161243069452, 8348.165183481664, 8484.32125429964, 37283.4407483888, 37465.625343746484, 37518.43722344167, 37561.43657845134, 37590.62409375898, 2938.427006733688, 2941.4117176564773, 2984.582158497812, 2986.6266716660416, 3066.9386612267854, 27447.783598930226, 27461.86269068642, 27659.723402765914, 28138.015169469174, 28200.153995380173, 2763.226296636945, 2799.860006999642, 2813.127930341601, 2830.3490197254746, 2933.0467598030727, 315758.0, 316252.0, 317959.4102029475, 318956.40521797474, 319316.0, 50065.74967125214, 50066.499335006185, 50104.74947625311, 50433.0, 50518.24222636663, 51300.48699513032, 52043.47956520387, 52107.73946130321, 52164.47835521672, 52222.73888630533, 14325.92837035829, 14357.78463323051, 14409.567712968628, 14427.278636068364, 14433.391652086979, 11747.060235181165, 11756.58851940178, 11762.70593235176, 11764.235324703866, 11765.411729413496, 11029.503672334764, 11214.271072380268, 12024.977876880388, 12758.55345062937, 12950.611481655566, 5414.620976531605, 5431.53831924283, 5448.727563621803, 5474.124140137559, 5489.58828087895, 866.4151697604218, 954.3224310739453, 961.6441916490943, 976.6728146071003, 991.1674193677345, 22543.661845072336, 23691.881540592185, 23807.047718091082, 23849.523009539713, 23905.16331928374, 898.6764764684708, 1061.1510791366875, 1083.2525557365393, 1106.1869525898458, 1110.8333749937412, 9061.954690226507, 10532.052115309505, 11496.42517874103, 11850.170488065925, 12157.027437804954, 405518.0, 410933.0, 412316.0, 413135.0, 421816.0, 55002.724986374815, 55085.0, 55266.17100743412, 55287.447125529034, 55547.72226138844, 1434.8923830712738, 1464.3044553836842, 1475.0412232049255, 1487.174618086972, 1502.5417247739326, 27763.167104986882, 28121.296967575974, 28539.42921141607, 28708.0, 28742.568861467513, 37152.88541343764, 37228.0, 37270.25459490849, 37317.44023839699, 37340.813295933345, 384939.0, 386203.0, 387142.0642896767, 388119.05940470117, 388396.0, 31821.681783181873, 32225.35549289048, 32651.67348326486, 32655.673443266212, 32686.83656581702, 33971.15072123217, 41527.96180095522, 41683.583164169184, 41824.581754182065, 42310.51913183024, 27587.862060689567, 28205.57691634586, 28763.5685464714, 29440.969566065083, 29916.662083997264, 28807.56788648214, 28905.710942891143, 29338.826446941883, 29477.0, 29740.85129574338, 34036.659633403346, 34709.826450867586, 34820.0, 34831.12922176966, 34957.30085398227, 27957.720422796327, 28938.710612893603, 29567.55648665315, 29810.0, 30014.84992575023, 23376.883115584315, 23472.943717533093, 23477.17829875946, 23677.289681309587, 23805.880970595037], "value": 17128.277585924254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5594955674866, 411.88055463915464, 427.11800132725926, 428.33607907743, 440.8853698038509, 13571.932140339297, 15514.285000124975, 22254.221102261425, 22370.105195792188, 22809.0, 23144.3056708299, 23195.07219711214, 23610.173643922466, 23614.881925590347, 23765.336426450154, 5923.0, 6310.999999999977, 6334.429901308881, 6342.746290148389, 6347.555671103025, 6009.0, 6190.411910868483, 6219.315875253718, 6271.341509141543, 6328.493720502349, 6180.598261113036, 6199.194104766374, 6222.595531290452, 6232.563720539564, 6243.0, 5924.881502369972, 6102.542309326774, 6173.1048997895505, 6195.4424101831055, 6233.1273621693, 5363.9463605363835, 5495.862603434946, 5502.367227768817, 5511.807086751985, 5526.778928842841, 26790.732092679213, 27507.449851003068, 27595.724042759517, 27913.441731165465, 27946.441071178666, 2024.2004408258802, 2035.2571311471354, 2036.0634108310196, 2067.390119914629, 2068.855180137391, 16252.674946501122, 16829.91585042079, 16931.407400740914, 17126.14369281531, 17141.48575542736, 1857.7677790276216, 1878.7745470543487, 1882.5011371986434, 1886.6132442849182, 1896.1941175000707, 138323.0, 144315.27842360825, 145267.273663631, 145461.0, 146660.0, 11359.716007099889, 11668.474918628683, 12168.81746773799, 12179.08656850722, 12228.327441990776, 16239.350425983064, 16264.349426022827, 16274.674506509804, 16294.185290735415, 16315.51053468398, 7566.924330756732, 8521.744347669579, 8811.471311721318, 8884.466931984101, 8980.550972451481, 6860.656967151623, 8433.451825631315, 8461.703840365557, 8659.913400865911, 8677.479351238946, 6731.394174524316, 7612.8477430451085, 7783.688652453839, 7791.805204869924, 7813.960930195312, 2102.653062244743, 2110.504031552615, 2111.0500274876367, 2112.0812446585783, 2115.323096609101, 942.9811403771886, 963.8120566489467, 967.3373738988674, 977.0, 980.2403137568441, 19899.005049747455, 20033.59932801336, 21591.460213494473, 21684.89157554202, 21699.023543940562, 917.2391102780546, 978.3738407419257, 1005.3515482513884, 1008.4806324742764, 1023.4217667018111, 8366.991072626184, 10272.640457584099, 10935.28920620157, 10999.875046857429, 11014.724631884266, 699888.0, 701904.0, 702405.0, 705684.0, 711752.0, 120697.0, 152419.0, 153522.0, 156104.438955609, 168380.68764155183, 1032.9380237185792, 1217.8355921950601, 1262.1291308996763, 1267.518343029643, 1268.8731126887237, 17735.911320443833, 19716.90141549283, 20234.0, 21417.822019789062, 21481.322862250745, 59592.21223363306, 62572.687136564025, 63193.42016449625, 63569.682151588946, 64515.03227451686, 67591.66204169144, 71821.6408917952, 86686.0, 86863.0, 88379.55810221165, 8465.195806398382, 8493.830123397622, 8574.742757717278, 8815.823683526165, 9081.228095611947, 12136.089793265717, 12221.755564888475, 13721.588352349445, 14016.159030458206, 14376.424943002163, 11697.0, 11734.765304693688, 11887.583934562595, 12051.698707532381, 12102.0, 9240.122188392092, 10824.917508249113, 11095.611653592085, 11291.153163512605, 11447.599334023269, 9333.719988400358, 12099.455524501594, 12278.263304201777, 12350.011999040235, 12383.504659813507, 6942.826429339307, 8571.100034496289, 8607.741767746978, 8913.019567847401, 8917.687880924137, 10773.676789696321, 11404.82892756626, 11741.530338786353, 11771.47028383742, 12156.1490695654], "value": 10384.469888861597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.5598496511184, 1435.4975758484532, 1459.212025506226, 1467.3836988464843, 1469.5444412232202, 9133.634654613825, 10569.841452378221, 10979.0, 11040.171987100959, 11057.281276717007, 10620.78758424831, 10775.407352595605, 10827.67516974492, 10944.890551094486, 10947.56209751609, 2373.32360277321, 2445.0464318915638, 2445.327534927891, 2449.069353645612, 2453.5706251406023, 2048.426440596628, 2286.7141607299086, 2374.15717420315, 2377.5126099149634, 2422.9636555451684, 1781.991090044548, 2132.76539580646, 2359.8466099703464, 2435.0138194031356, 2445.0464318915638, 2405.0860672944254, 2415.5410472010262, 2417.504411595619, 2420.165043060141, 2425.4300239443714, 2038.0828627117708, 2370.6605767741344, 2412.589859723851, 2413.80689544836, 2421.4672771990136, 9320.533973301375, 10494.422806745626, 10781.02970732638, 10809.405482698448, 10830.891691083147, 6044.153818465418, 6266.561340706153, 6271.02799066141, 6275.09011193379, 6283.403076707751, 3976.562578116405, 3983.780892050936, 3992.820323085439, 4049.1699201663587, 4054.1891621675486, 1165.370699822095, 1176.7764124816342, 1197.5099710024442, 1215.4773447417606, 1231.975360492785, 14593.78109328361, 14902.254887255594, 14955.925220373938, 14956.925215373962, 14959.775603365959, 5542.944570554324, 5701.486866182064, 5769.163471296639, 5829.59192856496, 5872.354041055481, 12614.180078294881, 12632.115751897463, 12648.87351126477, 12651.177673451197, 12673.0, 6432.967835160888, 6433.839154021093, 6435.903461448082, 6441.355864413615, 6444.226692796894, 5260.868478288074, 5739.253896993364, 5829.708514574254, 5834.066549352084, 5834.15404766315, 4252.787360632018, 4406.471223453142, 4413.293872980308, 4469.061497085583, 4470.821167153343, 1358.0, 1403.4035534897628, 1408.1973275233224, 1426.4222989689192, 1430.8926830487756, 760.6878135216817, 761.9276168763959, 765.7900517182837, 789.2817536042289, 799.9760007199793, 5714.285714285715, 5854.941450585439, 5900.350961394243, 5955.0, 6032.969835150884, 570.7415149595133, 584.7953216374235, 593.092568370394, 601.2664549249909, 601.6811090122242, 3471.253680458663, 3745.0, 3990.86031988879, 4097.672186225154, 4159.480064991876, 10318.468165633385, 13096.869031309565, 13225.603231902865, 13379.866201338056, 13380.130291531019, 12713.0, 13047.412866421033, 13183.274919879499, 13272.668183295495, 13274.800877986838, 9782.902170978341, 9815.41107533536, 9848.852267215998, 9958.950205249072, 9966.80066398668, 6103.206583144163, 6258.468030217483, 6352.237731472253, 6359.109724638647, 6432.292447830641, 11741.17811753169, 11904.404779760804, 11934.462949167135, 12021.158518903592, 12141.15011949155, 12068.939655301667, 12146.514139434325, 12171.33057681836, 12318.630441086782, 12320.568780092653, 8514.148585141436, 8760.956195218983, 8772.736817895473, 8785.604647790737, 8794.780130496532, 9584.66453674118, 9655.662051828152, 9777.608895644094, 9930.304878658713, 10016.0, 8391.0, 8499.192576705203, 8540.060593334852, 8579.914200857911, 8742.737717868475, 7138.892916606359, 8247.793805154919, 8330.833383332421, 8440.577971101298, 8510.872336915076, 6237.313895471585, 7724.6910123594425, 7794.649240784065, 7822.5697586631, 7828.686852525835, 5832.737526811388, 5894.056950887837, 5939.732712027882, 6001.5798894077, 6019.4883434908525, 5926.881462370815, 5984.311804142405, 6042.516598672008, 6086.817395478142, 6118.5411094169], "value": 5059.129655324665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2564563215809, 390.9628585284397, 393.5002546765609, 398.79661372699917, 400.035913448589, 4704.576588107074, 5904.0, 5964.79123230687, 5969.492593129578, 6002.789902353418, 4611.19304121779, 4796.880077998052, 5762.135679648044, 5841.561882858781, 5916.0830071338905, 4502.302143167814, 4507.616852567536, 4536.637069034469, 4539.954600453986, 4543.568361005708, 4528.894064260118, 4529.660275479336, 4532.342810292505, 4535.70517916336, 4549.954500455003, 3882.854557905425, 4096.549379568245, 4283.7215580987295, 4406.766105490467, 4527.2530032544755, 4149.98725618075, 4446.288593825005, 4446.510883802779, 4457.818678050303, 4479.148961697283, 3753.0, 3991.1818077294083, 4007.2786898358286, 4019.658329042035, 4027.536833264183, 4376.365427013097, 5745.339285982123, 5747.971260143672, 5778.075507918713, 5820.9708951455395, 5210.97394513025, 5214.843554693365, 5219.765110569995, 5220.92168617471, 5225.137852254374, 6304.684765761694, 6359.745610175587, 6379.617222966637, 6390.968045159791, 6400.39196276353, 3564.554430696163, 4040.959590404117, 4226.436218599108, 4299.118680670486, 4300.61294483498, 6075.908861367083, 6115.92971230033, 6386.9680651596445, 6425.907595708741, 6582.440492558138, 3862.748921320105, 3869.1294458746556, 4089.6114869087387, 4153.460050193456, 4357.433533640607, 3715.5727091384297, 4387.648988080946, 4429.468463784367, 4442.888927776831, 4448.621867141329, 4741.716767360436, 4923.212286034217, 5064.49355064498, 5177.524405544402, 5198.9740051299505, 5398.24424580559, 6094.0, 6293.874122517615, 6368.617882927039, 6372.299047104815, 1289.7162624222656, 1410.7249086428048, 1425.600831767107, 1519.7720341948575, 1520.8022957015517, 985.5072463768116, 998.5556427389741, 1009.1472705563787, 1009.5608410341525, 1021.8978102189722, 5851.707414629252, 5933.910991335133, 5968.671723055187, 5997.7001149942325, 6023.849403764853, 5956.374580668968, 5963.135345374896, 6301.747930082745, 6444.355564443518, 6529.314421985718, 5713.714314284269, 5728.198052272685, 5924.7926322578505, 5941.940580594139, 5968.582199246098, 3386.407378708716, 3410.8914602754203, 3429.6913277805115, 3436.226848958964, 3439.8108104054018, 6597.439217666456, 6756.425703815133, 6774.729010839511, 6774.729010839511, 6781.932180678229, 5290.603204759658, 6690.0, 6695.598264104169, 6748.898766518506, 6765.661716914233, 6163.106349579376, 6250.406211409909, 6725.9663701681175, 6747.414357625954, 6749.291324410866, 4884.462709101925, 5234.031704134747, 6117.6846977898185, 6382.329855365306, 6510.967445162744, 5367.275417818544, 6385.93614063872, 6407.070974708734, 6419.683964787114, 6431.710573024318, 5967.46292833647, 6403.359664033559, 6461.19235095613, 6675.532712710064, 6836.0858959491425, 4321.178975994551, 4330.41539392178, 4338.739675619473, 4343.4136391586735, 4343.652507799432, 5550.361708403424, 6264.771279386487, 6541.364658835291, 6570.441512471493, 6600.867982640224, 5446.828931779686, 6080.847978800565, 6322.683865806599, 6322.968385158229, 6348.5238607105575, 5429.67421954684, 6208.379162083756, 6331.303556608677, 6368.115449575847, 6379.628379898344, 5380.488853558905, 6010.557466208166, 6124.385663483338, 6192.287886893065, 6213.9067913982235, 5291.682499050069, 5492.91760623583, 6311.990081586924, 6316.6841657916, 6355.14205582259, 5199.958024555526, 6111.477506644962, 6164.137020816999, 6185.226846644169, 6207.351310307598], "value": 4598.824984840252, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.6871236162822, 723.7032816545214, 727.6652739739719, 732.103173612325, 745.2696357569582, 15399.692006159885, 15896.205189740496, 16191.433299834509, 16264.75602865958, 16309.755353669674, 15202.467913623026, 15440.150791706452, 15453.30460129294, 15457.690846183097, 15522.30149643266, 954.4750387286999, 971.218169373654, 972.2173650211577, 974.4786539201529, 978.0806042320232, 976.7167521418816, 979.6865003198943, 984.3650845204838, 984.9606015759362, 986.2061040862103, 1008.5058321422487, 1049.5172220778452, 1050.8844027157006, 1054.088213695152, 1054.752133248686, 1037.222083437422, 1037.6005237983354, 1050.154625526451, 1051.0435503691604, 1052.0636633396207, 769.3114662377197, 769.3921801776589, 772.5364781131276, 773.6827900560743, 775.9030121234846, 16812.411565595146, 16816.32734690611, 16911.900726452743, 17009.829901701072, 17021.23404446803, 12007.699807504794, 14780.926095369561, 15031.699366012619, 15263.236838158047, 15758.448454304043, 11591.884081159165, 11748.236364636357, 11844.541022787915, 11926.344051077274, 11986.460609272604, 2985.402919416104, 3036.4686179918426, 3052.13014290926, 3064.55563943227, 3175.0157451189975, 120428.39785801103, 122466.82900163974, 124301.0, 125066.0, 127290.36354818166, 11499.597514086967, 11525.827112593317, 11646.70883227926, 11903.70240743971, 11904.464299106561, 25540.74459255421, 25577.104801332236, 25599.87200064025, 25604.871975640373, 25672.871635641703, 7878.448508604342, 7921.920780792118, 7951.403644726669, 8091.878621820678, 8134.59327033646, 4142.5857414258335, 4203.60138331274, 4237.978810105929, 4240.257954857888, 4251.80866860992, 4068.06434520062, 4102.200070986189, 4175.352820312856, 4177.561356057631, 4200.5169405518145, 778.4706399648294, 780.3523075847147, 798.5887268056955, 798.6765360029198, 806.4113197365956, 469.7017393954863, 512.0373697448772, 537.2263939926494, 549.3929208224934, 551.3081083240587, 9211.631534738535, 9698.951505242429, 10441.947790261, 10492.580296788195, 10500.947495262628, 523.3170712220513, 552.4422717698012, 561.2983770287141, 571.5399103721544, 592.4963780786297, 4221.261279276176, 4550.453945526558, 4822.083804077214, 4855.417349918032, 4902.28916807061, 105666.47166764116, 105913.47043264734, 106636.0, 107881.4605926981, 108204.0, 89629.0, 90197.0, 90988.54505727561, 93066.0, 94644.0, 58938.0, 62018.68990655018, 77920.0, 80205.19794801978, 81540.66134047964, 8254.752357429286, 9148.908510914805, 9652.131308182297, 9658.57794847506, 9682.661106861226, 35187.82406087953, 39761.80119099386, 40098.79950600228, 40167.0, 41895.7905210472, 44105.77947110372, 51033.489665102876, 53026.469735302155, 53029.46970530245, 53946.460535394144, 11682.415879205835, 11747.118966077407, 11863.0, 12195.451204695988, 12335.629931102081, 11655.708607284885, 12682.873171268538, 12761.361931903553, 12920.547780827626, 13002.739945201232, 10472.005159509834, 11667.6079224008, 11709.180357374902, 11919.284842909454, 12324.445399957203, 9887.4067555944, 11744.471498782746, 11935.224210426295, 12430.502779888704, 12689.4289756963, 11684.941575292069, 11806.586769463027, 11839.348835814113, 12091.093168012258, 12295.56965506203, 9104.726858194264, 9278.907210928075, 9283.62865485373, 9442.38624489406, 9488.383255088396, 8058.033036035713, 8971.461712297283, 9154.633814647339, 9654.903450965681, 10121.59513619447], "value": 7405.660027079833, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 123.0, 124.0, 123.0, 123.0, 124.0, 123.0, 123.0, 123.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 120.0, 121.0, 163.0, 124.0, 121.0, 119.0, 115.0, 142.0, 122.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 215.0, 213.0, 220.0, 209.0, 211.0, 210.0, 214.0, 212.0, 216.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 65.0, 62.0, 100.0, 65.0, 65.0, 64.0, 62.0, 82.0, 63.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 76.0, 98.0, 76.0, 74.0, 77.0, 92.0, 73.0, 76.0, 92.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 91.0, 91.0, 93.0, 91.0, 91.0, 92.0, 91.0, 93.0, 91.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 144.0, 101.0, 102.0, 100.0, 117.0, 157.0, 100.0, 100.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 100.0, 101.0, 100.0, 101.0, 103.0, 102.0, 102.0, 100.0, 101.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 51.0, 53.0, 54.0, 53.0, 53.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 75.0, 69.0, 67.0, 65.0, 65.0, 65.0, 65.0, 67.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 93.0, 91.0, 91.0, 90.0, 91.0, 90.0, 92.0, 90.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 170.0, 145.0, 158.0, 137.0, 171.0, 182.0, 199.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [236.0, 244.0, 221.0, 195.0, 230.0, 219.0, 243.0, 258.0, 215.0, 260.0], "value": 232.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 73.0, 73.0, 75.0, 71.0, 72.0, 78.0, 99.0], "value": 76.7, "unit": "score"}]}]} 09:58:26 INFO - Return code: 0 09:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:58:26 ERROR - # TBPL SUCCESS # 09:58:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:26 INFO - 2017-04-03 09:58:26.457 screenresolution[1651:9683] starting screenresolution argv=screenresolution get 09:58:26 INFO - 2017-04-03 09:58:26.461 screenresolution[1651:9683] Display 0: 1600x1200x32@60 09:58:26 INFO - 2017-04-03 09:58:26.467 screenresolution[1652:9686] starting screenresolution argv=screenresolution list 09:58:26 INFO - Available Modes on Display 0 09:58:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:26 INFO - Intel Iris: 09:58:26 INFO - Chipset Model: Intel Iris 09:58:26 INFO - Type: GPU 09:58:26 INFO - Bus: Built-In 09:58:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:26 INFO - Vendor: Intel (0x8086) 09:58:26 INFO - Device ID: 0x0a2e 09:58:26 INFO - Revision ID: 0x0009 09:58:26 INFO - Displays: 09:58:26 INFO - Display: 09:58:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:26 INFO - Display Serial Number: 1600x1200 60 09:58:26 INFO - Main Display: Yes 09:58:26 INFO - Mirror: Off 09:58:26 INFO - Online: Yes 09:58:26 INFO - Rotation: Supported 09:58:26 INFO - Return code: 0 09:58:26 INFO - Running post-action listener: _resource_record_post_action 09:58:26 INFO - [mozharness: 2017-04-03 16:58:26.708929Z] Finished run-tests step (success) 09:58:26 INFO - Running post-run listener: _resource_record_post_run 09:58:26 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 36848640; Write bytes: 511496192; Read time: 388; Write time: 1651 09:58:26 INFO - TinderboxPrint: CPU usage
53.4% 09:58:26 INFO - TinderboxPrint: I/O read bytes / time
36,848,640 / 388 09:58:26 INFO - TinderboxPrint: I/O write bytes / time
511,496,192 / 1,651 09:58:26 INFO - TinderboxPrint: CPU idle
2,244.9 (46.6%) 09:58:26 INFO - TinderboxPrint: CPU system
958.3 (19.9%) 09:58:26 INFO - TinderboxPrint: CPU user
1,614.3 (33.5%) 09:58:26 INFO - TinderboxPrint: Swap in / out
248,320,000 / 0 09:58:26 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204106240; Write bytes: 204204032; Read time: 15829; Write time: 391 09:58:26 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 35890176; Write bytes: 297261056; Read time: 372; Write time: 1223 09:58:27 INFO - Running post-run listener: _upload_blobber_files 09:58:27 INFO - Blob upload gear active. 09:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:58:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:28 INFO - (blobuploader) - INFO - Done attempting. 09:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:29 INFO - (blobuploader) - INFO - Done attempting. 09:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:30 INFO - (blobuploader) - INFO - Done attempting. 09:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:33 INFO - (blobuploader) - INFO - Done attempting. 09:58:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:33 INFO - Return code: 0 09:58:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c82e09c6c817857dcff085ea4aec683e42237607665021927512349183bd66acd7ea8e57edd8a6c938ee788796413df98e82fa9d6419072de0ef5f498b3c32d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef05bc3a8e873f18481109c581a7d7952afb1266e6d644164adb6ecf125ef1de8e969e43fd0456d32bd5deb4d2af41dcc834ede6b025244d343ac9e39ee53778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17f07cae5209415d81c4decac642f9fe8c5aff95d965191feaf96ff48988dc2d342fa0323344963f9faff6ddd3889f3f824017549eda4c4974ca6ff303f9dc8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a865cdde38788f3c10c22d265973da051a09d9eb29a559f302b6d1598a57571dfa6b406934694d339ea8c5b9de5b5a991937c0718eb43c72e4a8b080ae80d12"} 09:58:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:33 INFO - Contents: 09:58:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c82e09c6c817857dcff085ea4aec683e42237607665021927512349183bd66acd7ea8e57edd8a6c938ee788796413df98e82fa9d6419072de0ef5f498b3c32d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef05bc3a8e873f18481109c581a7d7952afb1266e6d644164adb6ecf125ef1de8e969e43fd0456d32bd5deb4d2af41dcc834ede6b025244d343ac9e39ee53778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17f07cae5209415d81c4decac642f9fe8c5aff95d965191feaf96ff48988dc2d342fa0323344963f9faff6ddd3889f3f824017549eda4c4974ca6ff303f9dc8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a865cdde38788f3c10c22d265973da051a09d9eb29a559f302b6d1598a57571dfa6b406934694d339ea8c5b9de5b5a991937c0718eb43c72e4a8b080ae80d12"} 09:58:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:33 INFO - Copying logs to upload dir... 09:58:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.770184 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-03 09:58:33.493963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:58:33.498539) ========= 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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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/8c82e09c6c817857dcff085ea4aec683e42237607665021927512349183bd66acd7ea8e57edd8a6c938ee788796413df98e82fa9d6419072de0ef5f498b3c32d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef05bc3a8e873f18481109c581a7d7952afb1266e6d644164adb6ecf125ef1de8e969e43fd0456d32bd5deb4d2af41dcc834ede6b025244d343ac9e39ee53778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17f07cae5209415d81c4decac642f9fe8c5aff95d965191feaf96ff48988dc2d342fa0323344963f9faff6ddd3889f3f824017549eda4c4974ca6ff303f9dc8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a865cdde38788f3c10c22d265973da051a09d9eb29a559f302b6d1598a57571dfa6b406934694d339ea8c5b9de5b5a991937c0718eb43c72e4a8b080ae80d12"} build_url:https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/TDZcPEoJRWKFmR1inj2LOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c82e09c6c817857dcff085ea4aec683e42237607665021927512349183bd66acd7ea8e57edd8a6c938ee788796413df98e82fa9d6419072de0ef5f498b3c32d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef05bc3a8e873f18481109c581a7d7952afb1266e6d644164adb6ecf125ef1de8e969e43fd0456d32bd5deb4d2af41dcc834ede6b025244d343ac9e39ee53778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17f07cae5209415d81c4decac642f9fe8c5aff95d965191feaf96ff48988dc2d342fa0323344963f9faff6ddd3889f3f824017549eda4c4974ca6ff303f9dc8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a865cdde38788f3c10c22d265973da051a09d9eb29a559f302b6d1598a57571dfa6b406934694d339ea8c5b9de5b5a991937c0718eb43c72e4a8b080ae80d12"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 09:58:33.538528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:58:33.538905) ========= 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.J3hc3KTjLH/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.gIAOVfodQ5/Listeners TMPDIR=/var/folders/3s/p289pc_x541gq_zzpzjxs8pm00000w/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.005150 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 09:58:33.590628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:58:33.591347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 09:58:33.592199) ========= ========= Total master_lag: 0.21 =========