builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0094 starttime: 1484250891.0 results: success (0) buildid: 20170112091316 builduid: 0b78e5e893094ac2b06f6f3da233ab5b revision: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.001681) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.002189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.002470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.029969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.030368) ========= 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.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-01-12 11:54:51-- 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% 23.9M=0s 2017-01-12 11:54:51 (23.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.199768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.200156) ========= 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.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.032633 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:51.255582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 11:54:51.255959) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0688f0bd4f534fd3f6d6cae3006c21966fd340bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0688f0bd4f534fd3f6d6cae3006c21966fd340bc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-01-12 11:54:51,351 truncating revision to first 12 chars 2017-01-12 11:54:51,352 Setting DEBUG logging. 2017-01-12 11:54:51,352 attempt 1/10 2017-01-12 11:54:51,352 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0688f0bd4f53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 11:54:52,471 unpacking tar archive at: mozilla-beta-0688f0bd4f53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.425099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 11:54:52.704567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:52.704970) ========= script_repo_revision: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:52.705394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:52.705690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:54:52.725969) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-12 11:54:52.726397) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:54:52 INFO - MultiFileLogger online at 20170112 11:54:52 in /builds/slave/test 11:54:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:54:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:52 INFO - {'append_to_log': False, 11:54:52 INFO - 'base_work_dir': '/builds/slave/test', 11:54:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:54:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:52 INFO - 'branch': 'Mozilla-Beta', 11:54:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:52 INFO - 'config_files': ('talos/mac_config.py',), 11:54:52 INFO - 'default_actions': ('clobber', 11:54:52 INFO - 'read-buildbot-config', 11:54:52 INFO - 'download-and-extract', 11:54:52 INFO - 'populate-webroot', 11:54:52 INFO - 'create-virtualenv', 11:54:52 INFO - 'install', 11:54:52 INFO - 'run-tests'), 11:54:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:52 INFO - 'download_minidump_stackwalk': True, 11:54:52 INFO - 'download_symbols': 'ondemand', 11:54:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:52 INFO - 'installer_path': 'installer.exe', 11:54:52 INFO - 'log_level': 'info', 11:54:52 INFO - 'log_name': 'talos', 11:54:52 INFO - 'log_to_console': True, 11:54:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:52 INFO - 'opt_config_files': (), 11:54:52 INFO - 'pip_index': False, 11:54:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:52 INFO - 'cmd': ('bash', 11:54:52 INFO - '-c', 11:54:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:52 INFO - 'enabled': True, 11:54:52 INFO - 'halt_on_failure': False, 11:54:52 INFO - 'name': 'check_screen_resolution'},), 11:54:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:52 INFO - 'cmd': ('bash', 11:54:52 INFO - '-c', 11:54:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:52 INFO - 'enabled': True, 11:54:52 INFO - 'halt_on_failure': False, 11:54:52 INFO - 'name': 'check_screen_resolution'},), 11:54:52 INFO - 'run_cmd_checks_enabled': True, 11:54:52 INFO - 'sps_profile': False, 11:54:52 INFO - 'sps_profile_interval': 0, 11:54:52 INFO - 'suite': 'dromaeojs', 11:54:52 INFO - 'system_bits': '32', 11:54:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:52 INFO - 'title': 't-yosemite-r7-0094', 11:54:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:52 INFO - 'use_talos_json': True, 11:54:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:52 INFO - 'work_dir': 'build'} 11:54:52 INFO - [mozharness: 2017-01-12 19:54:52.929690Z] Running clobber step. 11:54:52 INFO - Running pre-action listener: _resource_record_pre_action 11:54:52 INFO - Running main action method: clobber 11:54:52 INFO - rmtree: /builds/slave/test/build 11:54:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:55 INFO - Running post-action listener: _resource_record_post_action 11:54:55 INFO - [mozharness: 2017-01-12 19:54:55.182874Z] Finished clobber step (success) 11:54:55 INFO - [mozharness: 2017-01-12 19:54:55.183006Z] Running read-buildbot-config step. 11:54:55 INFO - Running pre-action listener: _resource_record_pre_action 11:54:55 INFO - Running main action method: read_buildbot_config 11:54:55 INFO - Using buildbot properties: 11:54:55 INFO - { 11:54:55 INFO - "project": "", 11:54:55 INFO - "product": "firefox", 11:54:55 INFO - "script_repo_revision": "production", 11:54:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:54:55 INFO - "repository": "", 11:54:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:54:55 INFO - "buildid": "20170112091316", 11:54:55 INFO - "pgo_build": "False", 11:54:55 INFO - "basedir": "/builds/slave/test", 11:54:55 INFO - "buildnumber": 17, 11:54:55 INFO - "slavename": "t-yosemite-r7-0094", 11:54:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:54:55 INFO - "platform": "yosemite_r7", 11:54:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:54:55 INFO - "branch": "mozilla-beta", 11:54:55 INFO - "repo_path": "releases/mozilla-beta", 11:54:55 INFO - "revision": "0688f0bd4f534fd3f6d6cae3006c21966fd340bc", 11:54:55 INFO - "stage_platform": "macosx64", 11:54:55 INFO - "builduid": "0b78e5e893094ac2b06f6f3da233ab5b", 11:54:55 INFO - "slavebuilddir": "test" 11:54:55 INFO - } 11:54:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:54:55 INFO - Running post-action listener: _resource_record_post_action 11:54:55 INFO - [mozharness: 2017-01-12 19:54:55.186283Z] Finished read-buildbot-config step (success) 11:54:55 INFO - [mozharness: 2017-01-12 19:54:55.186425Z] Running download-and-extract step. 11:54:55 INFO - Running pre-action listener: _resource_record_pre_action 11:54:55 INFO - Running main action method: download_and_extract 11:54:55 INFO - mkdir: /builds/slave/test/build/tests 11:54:55 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')]} 11:54:55 INFO - trying https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:54:55 INFO - Downloading https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 11:54:56 INFO - Downloaded 1165 bytes. 11:54:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:54:56 INFO - Using the following test package requirements: 11:54:56 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:54:56 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:54:56 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:54:56 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:54:56 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:54:56 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:54:56 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:54:56 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:54:56 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:54:56 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:54:56 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:54:56 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:54:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:54:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:54:56 INFO - Fetch https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:54:57 INFO - Expected file size: 16236061 11:55:04 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:55:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:55:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:55:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:55:04 INFO - Expected file size: 16236061 11:55:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:55:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:55:11 INFO - Fetch https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:55:11 INFO - Expected file size: 14414089 11:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:12 INFO - trying https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:55:12 INFO - Downloading https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 11:55:14 INFO - Downloaded 86143299 bytes. 11:55:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:55:14 INFO - mkdir: /builds/slave/test/properties 11:55:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:14 INFO - Contents: 11:55:14 INFO - build_url:https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:55:15 INFO - Running post-action listener: _resource_record_post_action 11:55:15 INFO - Running post-action listener: set_extra_try_arguments 11:55:15 INFO - [mozharness: 2017-01-12 19:55:15.368442Z] Finished download-and-extract step (success) 11:55:15 INFO - [mozharness: 2017-01-12 19:55:15.368566Z] Running populate-webroot step. 11:55:15 INFO - Running pre-action listener: _resource_record_pre_action 11:55:15 INFO - Running main action method: populate_webroot 11:55:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:15 INFO - '--tppagecycles', 11:55:15 INFO - '7'], 11:55:15 INFO - 'tests': ['tsvgm']}}, 11:55:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['damp', 'tps']}, 11:55:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'tests': ['damp', 'tps']}, 11:55:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['dromaeo_dom']}, 11:55:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['basic_compositor_video']}, 11:55:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['a11yr', 11:55:15 INFO - 'ts_paint', 11:55:15 INFO - 'tpaint', 11:55:15 INFO - 'sessionrestore', 11:55:15 INFO - 'sessionrestore_no_auto_restore', 11:55:15 INFO - 'tabpaint']}, 11:55:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['tsvgx', 11:55:15 INFO - 'tsvgr_opacity', 11:55:15 INFO - 'tart', 11:55:15 INFO - 'tscrollx', 11:55:15 INFO - 'cart']}, 11:55:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:15 INFO - 'tsvgr_opacity', 11:55:15 INFO - 'tart', 11:55:15 INFO - 'tscrollx', 11:55:15 INFO - 'cart']}, 11:55:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'talos_options': ['--disable-e10s'], 11:55:15 INFO - 'tests': ['tp5o']}, 11:55:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'tests': ['tp5o']}, 11:55:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'talos_options': ['--disable-e10s', 11:55:15 INFO - '--xperf_path', 11:55:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:15 INFO - 'tests': ['tp5n']}, 11:55:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:15 INFO - 'talos_options': ['--xperf_path', 11:55:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:15 INFO - 'tests': ['tp5n']}}, 11:55:15 INFO - 'talos.zip': {'path': '', 11:55:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:15 INFO - Running post-action listener: _resource_record_post_action 11:55:15 INFO - [mozharness: 2017-01-12 19:55:15.386973Z] Finished populate-webroot step (success) 11:55:15 INFO - [mozharness: 2017-01-12 19:55:15.387098Z] Running create-virtualenv step. 11:55:15 INFO - Running pre-action listener: _resource_record_pre_action 11:55:15 INFO - Running main action method: create_virtualenv 11:55:15 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:15 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 11:55:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:15 INFO - Using real prefix '/tools/python27' 11:55:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:19 INFO - Installing pip.................done. 11:55:19 INFO - Return code: 0 11:55:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:19 INFO - 'HOME': '/Users/cltbld', 11:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PAGER': '/bin/cat', 11:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:19 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - 'XPC_FLAGS': '0x0', 11:55:19 INFO - 'XPC_SERVICE_NAME': '0', 11:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 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 11:55:19 INFO - Cleaning up... 11:55:19 INFO - Return code: 0 11:55:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:19 INFO - 'HOME': '/Users/cltbld', 11:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PAGER': '/bin/cat', 11:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:19 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - 'XPC_FLAGS': '0x0', 11:55:19 INFO - 'XPC_SERVICE_NAME': '0', 11:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 INFO - Downloading/unpacking psutil>=3.1.1 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:23 INFO - Installing collected packages: psutil 11:55:23 INFO - Running setup.py install for psutil 11:55:23 INFO - building 'psutil._psutil_osx' extension 11:55:23 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 11:55:23 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 11:55:23 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 11:55:23 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 11:55:23 INFO - building 'psutil._psutil_posix' extension 11:55:23 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 11:55:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:55:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:55:24 INFO - ^ 11:55:24 INFO - 1 warning generated. 11:55:24 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 11:55:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:24 INFO - Successfully installed psutil 11:55:24 INFO - Cleaning up... 11:55:24 INFO - Return code: 0 11:55:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:24 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')]} 11:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:24 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')]} 11:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:24 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:24 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 11:55:24 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 11:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:24 INFO - 'HOME': '/Users/cltbld', 11:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:24 INFO - 'LOGNAME': 'cltbld', 11:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:24 INFO - 'MOZ_NO_REMOTE': '1', 11:55:24 INFO - 'NO_EM_RESTART': '1', 11:55:24 INFO - 'PAGER': '/bin/cat', 11:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:24 INFO - 'PWD': '/builds/slave/test', 11:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:24 INFO - 'SHELL': '/bin/bash', 11:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:24 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:24 INFO - 'USER': 'cltbld', 11:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:24 INFO - 'XPC_FLAGS': '0x0', 11:55:24 INFO - 'XPC_SERVICE_NAME': '0', 11:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55:24 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 11:55:24 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 11:55:24 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 11:55:24 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 11:55:24 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 11:55:24 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 11:55:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:27 INFO - Installing collected packages: mozsystemmonitor 11:55:27 INFO - Running setup.py install for mozsystemmonitor 11:55:27 INFO - Successfully installed mozsystemmonitor 11:55:27 INFO - Cleaning up... 11:55:27 INFO - Return code: 0 11:55:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:27 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')]} 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 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')]} 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:27 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 11:55:27 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 11:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:27 INFO - 'HOME': '/Users/cltbld', 11:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:27 INFO - 'LOGNAME': 'cltbld', 11:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:27 INFO - 'MOZ_NO_REMOTE': '1', 11:55:27 INFO - 'NO_EM_RESTART': '1', 11:55:27 INFO - 'PAGER': '/bin/cat', 11:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:27 INFO - 'PWD': '/builds/slave/test', 11:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:27 INFO - 'SHELL': '/bin/bash', 11:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:27 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:27 INFO - 'USER': 'cltbld', 11:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:27 INFO - 'XPC_FLAGS': '0x0', 11:55:27 INFO - 'XPC_SERVICE_NAME': '0', 11:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:27 INFO - Downloading/unpacking jsonschema==2.5.1 11:55:27 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 11:55:27 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 11:55:27 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 11:55:27 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 11:55:27 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 11:55:27 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 11:55:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 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 11:55:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:30 INFO - warning: no files found matching '*.txt' 11:55:30 INFO - no previously-included directories found matching 'build' 11:55:30 INFO - no previously-included directories found matching 'dist' 11:55:30 INFO - no previously-included directories found matching '.git*' 11:55:30 INFO - Installing collected packages: jsonschema, functools32 11:55:31 INFO - Running setup.py install for functools32 11:55:31 INFO - warning: no files found matching '*.txt' 11:55:31 INFO - no previously-included directories found matching 'build' 11:55:31 INFO - no previously-included directories found matching 'dist' 11:55:31 INFO - no previously-included directories found matching '.git*' 11:55:31 INFO - Successfully installed jsonschema functools32 11:55:31 INFO - Cleaning up... 11:55:31 INFO - Return code: 0 11:55:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:31 INFO - 'HOME': '/Users/cltbld', 11:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:31 INFO - 'LOGNAME': 'cltbld', 11:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:31 INFO - 'MOZ_NO_REMOTE': '1', 11:55:31 INFO - 'NO_EM_RESTART': '1', 11:55:31 INFO - 'PAGER': '/bin/cat', 11:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:31 INFO - 'PWD': '/builds/slave/test', 11:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:31 INFO - 'SHELL': '/bin/bash', 11:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:31 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:31 INFO - 'USER': 'cltbld', 11:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:31 INFO - 'XPC_FLAGS': '0x0', 11:55:31 INFO - 'XPC_SERVICE_NAME': '0', 11:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:31 INFO - Cleaning up... 11:55:31 INFO - Return code: 0 11:55:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:31 INFO - 'HOME': '/Users/cltbld', 11:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:31 INFO - 'LOGNAME': 'cltbld', 11:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:31 INFO - 'MOZ_NO_REMOTE': '1', 11:55:31 INFO - 'NO_EM_RESTART': '1', 11:55:31 INFO - 'PAGER': '/bin/cat', 11:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:31 INFO - 'PWD': '/builds/slave/test', 11:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:31 INFO - 'SHELL': '/bin/bash', 11:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:31 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:31 INFO - 'USER': 'cltbld', 11:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:31 INFO - 'XPC_FLAGS': '0x0', 11:55:31 INFO - 'XPC_SERVICE_NAME': '0', 11:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:35 INFO - Downloading docopt-0.6.1.tar.gz 11:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:35 INFO - Running setup.py install for blobuploader 11:55:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:35 INFO - Running setup.py install for requests 11:55:36 INFO - Running setup.py install for docopt 11:55:36 INFO - Successfully installed blobuploader requests docopt 11:55:36 INFO - Cleaning up... 11:55:36 INFO - Return code: 0 11:55:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:36 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')]} 11:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:36 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')]} 11:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:36 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:36 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 11:55:36 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 11:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:36 INFO - 'HOME': '/Users/cltbld', 11:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:36 INFO - 'LOGNAME': 'cltbld', 11:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:36 INFO - 'MOZ_NO_REMOTE': '1', 11:55:36 INFO - 'NO_EM_RESTART': '1', 11:55:36 INFO - 'PAGER': '/bin/cat', 11:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:36 INFO - 'PWD': '/builds/slave/test', 11:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:36 INFO - 'SHELL': '/bin/bash', 11:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:36 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:36 INFO - 'USER': 'cltbld', 11:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:36 INFO - 'XPC_FLAGS': '0x0', 11:55:36 INFO - 'XPC_SERVICE_NAME': '0', 11:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:36 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-DubnP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vTCksF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-X6JxuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8dK4hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mTtopB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-VYuyxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-FM1EgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cOxU6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-EwkzSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-KsMVrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:37 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-xWR6bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-isYAyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-grfO0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-JTXwQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-I3RcL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-7K3Oeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:38 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-poXQwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:38 INFO - Running setup.py install for manifestparser 11:55:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:38 INFO - Running setup.py install for mozcrash 11:55:38 INFO - Running setup.py install for mozdebug 11:55:39 INFO - Running setup.py install for mozdevice 11:55:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Running setup.py install for mozfile 11:55:39 INFO - Running setup.py install for mozhttpd 11:55:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Running setup.py install for mozinfo 11:55:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Running setup.py install for mozInstall 11:55:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:39 INFO - Running setup.py install for mozleak 11:55:39 INFO - Running setup.py install for mozlog 11:55:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for moznetwork 11:55:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozprocess 11:55:40 INFO - Running setup.py install for mozprofile 11:55:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozrunner 11:55:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozscreenshot 11:55:40 INFO - Running setup.py install for moztest 11:55:41 INFO - Running setup.py install for mozversion 11:55:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:41 INFO - Cleaning up... 11:55:41 INFO - Return code: 0 11:55:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:41 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')]} 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 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')]} 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:41 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 11:55:41 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 11:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:41 INFO - 'HOME': '/Users/cltbld', 11:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:41 INFO - 'LOGNAME': 'cltbld', 11:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:41 INFO - 'MOZ_NO_REMOTE': '1', 11:55:41 INFO - 'NO_EM_RESTART': '1', 11:55:41 INFO - 'PAGER': '/bin/cat', 11:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:41 INFO - 'PWD': '/builds/slave/test', 11:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:41 INFO - 'SHELL': '/bin/bash', 11:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:41 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:41 INFO - 'USER': 'cltbld', 11:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:41 INFO - 'XPC_FLAGS': '0x0', 11:55:41 INFO - 'XPC_SERVICE_NAME': '0', 11:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:41 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vzHAp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:41 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)) 11:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:41 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-qICKGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:41 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Jq83Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:41 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)) 11:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:41 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-f4Rnbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:41 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-FYC2f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-xockw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-XT6tYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-xoY9aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fK5tzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-NhSL97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-CF_ovf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-xRTYrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-EbqBqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:42 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-a1IAEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-IXxnuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:43 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0W5aB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:43 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-rbhWdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:43 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)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:55:43 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)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:43 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 11:55:46 INFO - Downloading blessings-1.6.tar.gz 11:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:46 INFO - Installing collected packages: blessings 11:55:46 INFO - Running setup.py install for blessings 11:55:46 INFO - Successfully installed blessings 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:47 INFO - Reading from file tmpfile_stdout 11:55:47 INFO - Current package versions: 11:55:47 INFO - blessings == 1.6 11:55:47 INFO - blobuploader == 1.2.4 11:55:47 INFO - docopt == 0.6.1 11:55:47 INFO - functools32 == 3.2.3-2 11:55:47 INFO - jsonschema == 2.5.1 11:55:47 INFO - manifestparser == 1.1 11:55:47 INFO - mozInstall == 1.12 11:55:47 INFO - mozcrash == 0.17 11:55:47 INFO - mozdebug == 0.1 11:55:47 INFO - mozdevice == 0.48 11:55:47 INFO - mozfile == 1.2 11:55:47 INFO - mozhttpd == 0.7 11:55:47 INFO - mozinfo == 0.9 11:55:47 INFO - mozleak == 0.1 11:55:47 INFO - mozlog == 3.4 11:55:47 INFO - moznetwork == 0.27 11:55:47 INFO - mozprocess == 0.23 11:55:47 INFO - mozprofile == 0.28 11:55:47 INFO - mozrunner == 6.12 11:55:47 INFO - mozscreenshot == 0.1 11:55:47 INFO - mozsystemmonitor == 0.3 11:55:47 INFO - moztest == 0.7 11:55:47 INFO - mozversion == 1.4 11:55:47 INFO - psutil == 3.1.1 11:55:47 INFO - requests == 1.2.3 11:55:47 INFO - wsgiref == 0.1.2 11:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:47 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:47 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 11:55:47 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 11:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:47 INFO - 'HOME': '/Users/cltbld', 11:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:47 INFO - 'LOGNAME': 'cltbld', 11:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:47 INFO - 'MOZ_NO_REMOTE': '1', 11:55:47 INFO - 'NO_EM_RESTART': '1', 11:55:47 INFO - 'PAGER': '/bin/cat', 11:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:47 INFO - 'PWD': '/builds/slave/test', 11:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:47 INFO - 'SHELL': '/bin/bash', 11:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:47 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:47 INFO - 'USER': 'cltbld', 11:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:47 INFO - 'XPC_FLAGS': '0x0', 11:55:47 INFO - 'XPC_SERVICE_NAME': '0', 11:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 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)) 11:55:47 INFO - Cleaning up... 11:55:47 INFO - Return code: 0 11:55:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:47 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 0x105e79490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105def570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6894c8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, '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.YBUODni8kA/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.7OSBsmifnH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 11:55:47 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 11:55:47 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 11:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:47 INFO - 'HOME': '/Users/cltbld', 11:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:47 INFO - 'LOGNAME': 'cltbld', 11:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:47 INFO - 'MOZ_NO_REMOTE': '1', 11:55:47 INFO - 'NO_EM_RESTART': '1', 11:55:47 INFO - 'PAGER': '/bin/cat', 11:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:47 INFO - 'PWD': '/builds/slave/test', 11:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:47 INFO - 'SHELL': '/bin/bash', 11:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:55:47 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:47 INFO - 'USER': 'cltbld', 11:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:47 INFO - 'XPC_FLAGS': '0x0', 11:55:47 INFO - 'XPC_SERVICE_NAME': '0', 11:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:47 INFO - Cleaning up... 11:55:47 INFO - Return code: 0 11:55:47 INFO - Running post-action listener: _resource_record_post_action 11:55:47 INFO - Running post-action listener: _start_resource_monitoring 11:55:47 INFO - Starting resource monitoring. 11:55:48 INFO - [mozharness: 2017-01-12 19:55:47.999729Z] Finished create-virtualenv step (success) 11:55:48 INFO - [mozharness: 2017-01-12 19:55:48.000661Z] Running install step. 11:55:48 INFO - Running pre-action listener: _resource_record_pre_action 11:55:48 INFO - Running main action method: install 11:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:48 INFO - Reading from file tmpfile_stdout 11:55:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:48 INFO - Reading from file tmpfile_stdout 11:55:48 INFO - Output received: 11:55:48 INFO - Usage: mozinstall [options] installer 11:55:48 INFO - Options: 11:55:48 INFO - -h, --help show this help message and exit 11:55:48 INFO - -d DEST, --destination=DEST 11:55:48 INFO - Directory to install application into. [default: 11:55:48 INFO - "/builds/slave/test"] 11:55:48 INFO - --app=APP Application being installed. [default: firefox] 11:55:48 INFO - mkdir: /builds/slave/test/build/application 11:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:56:10 INFO - Reading from file tmpfile_stdout 11:56:10 INFO - Output received: 11:56:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:56:10 INFO - Running post-action listener: _resource_record_post_action 11:56:10 INFO - [mozharness: 2017-01-12 19:56:10.273830Z] Finished install step (success) 11:56:10 INFO - [mozharness: 2017-01-12 19:56:10.273985Z] Running run-tests step. 11:56:10 INFO - Running pre-action listener: _resource_record_pre_action 11:56:10 INFO - Running main action method: run_tests 11:56:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:10 INFO - 2017-01-12 11:56:10.288 screenresolution[1621:7357] starting screenresolution argv=screenresolution get 11:56:10 INFO - 2017-01-12 11:56:10.291 screenresolution[1621:7357] Display 0: 1600x1200x32@60 11:56:10 INFO - 2017-01-12 11:56:10.297 screenresolution[1622:7359] starting screenresolution argv=screenresolution list 11:56:10 INFO - Available Modes on Display 0 11:56:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:10 INFO - Intel Iris: 11:56:10 INFO - Chipset Model: Intel Iris 11:56:10 INFO - Type: GPU 11:56:10 INFO - Bus: Built-In 11:56:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:10 INFO - Vendor: Intel (0x8086) 11:56:10 INFO - Device ID: 0x0a2e 11:56:10 INFO - Revision ID: 0x0009 11:56:10 INFO - Displays: 11:56:10 INFO - Display: 11:56:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:10 INFO - Display Serial Number: 1600x1200 60 11:56:10 INFO - Main Display: Yes 11:56:10 INFO - Mirror: Off 11:56:10 INFO - Online: Yes 11:56:10 INFO - Rotation: Supported 11:56:10 INFO - Return code: 0 11:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:10 INFO - Python 2.7.3 11:56:10 INFO - Return code: 0 11:56:10 INFO - grabbing minidump binary from tooltool 11:56: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')]} 11:56:10 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 0x105c8dd30>, '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 0x105af3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c85b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:10 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 11:56:10 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 11:56:10 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 11:56:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:10 INFO - Return code: 0 11:56:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:56:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:56:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 11:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 11:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YBUODni8kA/Render', 11:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:10 INFO - 'HOME': '/Users/cltbld', 11:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:10 INFO - 'LOGNAME': 'cltbld', 11:56:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:10 INFO - 'MOZ_NO_REMOTE': '1', 11:56:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:10 INFO - 'NO_EM_RESTART': '1', 11:56:10 INFO - 'PAGER': '/bin/cat', 11:56:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:10 INFO - 'PWD': '/builds/slave/test', 11:56:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:10 INFO - 'SHELL': '/bin/bash', 11:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7OSBsmifnH/Listeners', 11:56:10 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:10 INFO - 'USER': 'cltbld', 11:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:10 INFO - 'XPC_FLAGS': '0x0', 11:56:10 INFO - 'XPC_SERVICE_NAME': '0', 11:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 11:56:10 INFO - mozversion application_buildid: 20170112091316 11:56:10 INFO - mozversion application_changeset: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc 11:56:10 INFO - mozversion application_display_name: Firefox 11:56:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:10 INFO - mozversion application_name: Firefox 11:56:10 INFO - mozversion application_remotingname: firefox 11:56:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:56:10 INFO - mozversion application_vendor: Mozilla 11:56:10 INFO - mozversion application_version: 51.0 11:56:10 INFO - mozversion platform_buildid: 20170112091316 11:56:10 INFO - mozversion platform_changeset: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc 11:56:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:56:10 INFO - mozversion platform_version: 51.0 11:56:10 INFO - using testdate: 1484250970 11:56:10 INFO - actual date: 1484250970 11:56:10 INFO - starting webserver on 'localhost:49240' 11:56:10 INFO - SUITE-START | Running 2 tests 11:56:10 INFO - TEST-START | dromaeo_css 11:56:10 INFO - operating with platform_type : mac_ 11:56:10 INFO - Initialising browser for dromaeo_css test... 11:56:10 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpbanHQM/profile http://localhost:49240/getInfo.html) 11:56:13 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 11:56:13 INFO - PROCESS | 1632 | colorDepth:24 11:56:13 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 11:56:13 INFO - PROCESS | 1632 | __metrics 11:56:13 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:56:13 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:13 INFO - TEST-INFO | 1632: exit 0 11:56:13 INFO - Browser initialized. 11:56:13 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:13 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpbanHQM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:25 INFO - PROCESS | 1636 | RSS: Main: 168816640 11:56:25 INFO - PROCESS | 1636 | 11:57:17 INFO - PROCESS | 1636 | 1484251037309 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:59:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 11:59:28 INFO - PROCESS | 1636 | RSS: Main: 310616064 11:59:28 INFO - PROCESS | 1636 | 12:02:31 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 12:02:32 INFO - PROCESS | 1636 | RSS: Main: 303837184 12:02:32 INFO - PROCESS | 1636 | 12:05:34 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 12:05:35 INFO - PROCESS | 1636 | RSS: Main: 275480576 12:05:35 INFO - PROCESS | 1636 | 12:08:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 12:08:38 INFO - PROCESS | 1636 | RSS: Main: 261025792 12:08:38 INFO - PROCESS | 1636 | 12:11:41 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 12:11:41 INFO - PROCESS | 1636 | RSS: Main: 263008256 12:11:41 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 12:14:44 INFO - PROCESS | 1636 | RSS: Main: 309248000 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | __start_tp_report 12:14:44 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 12:14:44 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 12:14:44 INFO - PROCESS | 1636 | |i|pagename|runs| 12:14:44 INFO - PROCESS | 1636 | |0;dojo.html;3456.982715086425;3466.376052310583;3478.2521757822065;3478.6173520912694;3521.7534772565914;5450.454954504553;5672.489475947164;5744.080947048473;5754.108113242449;5755.280589926259;5637.436256374361;5738.6556806591525;5757.654540727549;5757.856053598652;5761.4814666679995;5225.085610018251;5239.292695486099;5243.082460569394;5277.577793776508;5293.338332708411;5207.531322181003;5230.581553475732;5240.68555886648;5324;5328.934213157365;5265.736713164346;5272.156454967206;5276.261323414725;5282.867928301785;5309.654872433299;5270.894582108374;5292.973535132338;5324.866878328034;5329.520343169133;5332.520073193393;5127.641065125443;5167.276581278624;5261.105612045962;5270.998510283072;5278.366596008465;5617.522510586605;5648.604597678164;5663.8584035399035;5722.170285308607;5731.656100633975;6186.907196392058;6242.997913689478;6245.063240513914;6254.8123556293385;6288.182536270256;6296.0555916612875;6311.116443697886;6311.684415779238;6312.305646378894;6333.334999824998;5675.460831221028;5756.222909907193;5760.2511673482595;5811.186433899257;5830.154627579062;6238.937610623926;6259.374062593704;6270.404311590391;6287.2140982377205;6295.024271237966;6149.477294430024;6151.323354431099;6156.476699480594;6168.259808822881;6182.752689892354;5035.295058691786;5069.442361340323;6109.2528441424865;6228.813135605939;6277.811665650038;6128.937268230797;6143.631382116998;6154.76904619078;6219.626822390671;6238.906416403757;6227;6261.78083767066;6280.152179455807;6288.088227207029;6323.336049714806;4951.529604687549;4952.5542701157065;4964.255361695775;4979.178435558092;4983.700977941263;4394.670399720034;4421.579949904753;4426.601605855424;4437.445319335083;4505.5719706627815;5774.335951365647;5824.912626310609;5826.592138550261;5844.094165404369;5869.8239052828485;6249.6562689052535;6274.6548939808745;6275.215598050244;6277.340879207709;6283.59156654816;4885.780139893714;5620.381758006616;5676.375598684224;5720.370759216483;5825.679587622722;5380;5409.648372855751;5415.6479828811;5422.701751403711;5432;6294.8426289342215;6305;6336.841578960563;6356.459700925473;6361.045843123568;6273.62358258506;6309.211348581427;6312.147860038836;6319.52603554726;6323.936760632335;6209.906851397142;6231.657258850625;6289.056641503811;6290.2766181889665;6343.238811342669;6220.502359811295;6246.063090536456;6256.562040657111;6273.121762953281;6283.49732021428;6045.244344456943;6306.400891915261;6320.051992201023;6321.589096708699;6339.873202536016;5998.0103282957825;6035.426634469718;6103.542234332532;6189.81430557084;6210.689465526615;6084.726187321493;6102.694865256631;6107.704691583656;6115.453310713017;6127.9837278401355;6004.969975150097;6018.36807135262;6027.126066720389;6032.306284777307;6037.426444487766;6011.939880601138;6101.328853826164;6154.9384506154365;6155.876882462415;6156.384361563808;4963.602911766978;5869.970650146722;5908.3500814911185;5914.172015917689;5971.522278217819 12:14:44 INFO - PROCESS | 1636 | |1;ext.html;512.4542362384061;540.3461811208437;544.643258665574;548.9258950041743;562.8930503204393;31927.36145277096;32738.345233095322;33892.98321050369;33921.15197120067;33925.151871203234;35298.8235058825;35940.46089308656;36003.639963600355;36015.459768103436;44949;9705.17506011988;10021.34861234021;10028.799424011551;10043.74890627733;10050.54772535234;9802.215822734164;9907.851382229272;9918.553665085052;9924.900750992507;9926.106650401462;9191.770205744842;9405.153536181742;9913.256505762061;9964.352317099401;9968.152707019875;12418.7581241876;12716;12736.80894786579;12737;12750.553730619476;10556.838747737742;12343;12355.135140540166;12458.937705311506;12474.438650260669;42690;42835.57164428378;42846.14307713859;42970.14059718819;43231.35152972708;3393.6267010628812;3430.828458577061;3649.1424515238896;3819.961800382016;4353.804078816461;31290.530642040387;31333;31393.8430307847;32031.83984080088;33953.660463395296;3394.6944774970125;3426.3832510148163;3433.9828300858585;3452.395830729612;3501.7373696972827;498792;499622;499788.501057496;500603;500724;35191;35966.741164059655;64294.678526607066;64519;64683.353166467736;37368.62631373652;37537.43693844594;37538.249235015144;37610;37614.81192594074;15732.60668483297;15876.60308492297;15890.602734931488;15893.284802183929;15915.363385464452;13280.203187808762;13365;13371.933140334237;13413.926885849109;13418.127821691558;6943.375096241261;8114.837703245902;8172.141925097898;8274.089850116483;8319.376046796515;3201.519772034167;3290.1116698491273;3373.4265174920324;3399.5070714746716;3452.9309413811584;878.2315473960285;972.4602845420859;990.6780296403554;1001.3040936549029;1117.279354816139;26816.731832681424;26916.46167076687;31557.368852622818;32051.13503218402;32110.518342224885;1087.6247694545368;1092.857928469294;1103.0789290941993;1110.4447776111945;1222.095649219589;16061.839381606269;16540.007599543824;16545.751813722563;16596.419125330554;16875.493735187963;674022;678296;680373;680884;682242.5887870529;53836.92326153533;54439;60248.69875650681;60875.69562152161;60907.6954615233;1254.9309787961568;1264.7027948432294;1265.6645988812973;1432.3339647063956;1454.040333379964;30883.84558077195;32998.83500582482;33008;33261;33599;47164.58506244818;54166;54245.18632220599;54362.45637543574;54383.18425223546;444483;559595;563390;620534;636625;24150;27295;27660.723392765816;27995.0201742938;28065.71934280631;48060.7596962013;48405.54783356505;48752.5124748748;48879.511204887494;49246;32510.286008529103;39223.41164882472;39700.20599587934;39726.60273397229;41023.7948810254;36563.72026979043;39811.2037759249;40533.39199912063;41175;41623.7918810404;34781.65218347784;39016.6098339013;39884.401733973435;40318.39522407108;40448;34042.489362660075;34826.651733483355;35281;35367.46948795822;35378.64621353857;25790.355241119123;25960.870195648902;26209;26261;26578.7342126584 12:14:44 INFO - PROCESS | 1636 | |2;jquery.html;322.54521125213444;387.40726688167103;387.69759587521725;398.77867783380213;416.61879380366963;19505.51236219095;20996.790032099674;21246.787532124676;21389.465263368424;21425.142994280228;20496.077676504556;20778.792212077875;21263.68104478434;21358.786412135873;21518.784812151913;5964.165016897616;5989.161517387569;6138.355472675372;6213.689315534228;6220.813375598739;4413.161499315136;4488.887777805565;4496.303073023687;6086.908696369558;6212.8446788830415;5910.793122240722;6557.901631475532;6835.829104272408;6883.4149097326535;6970.780113480146;6678.2987786282465;6875.278095799919;6930.44556435484;6930.792076237721;6935.410490108322;5797.391273916262;5954.46409823118;6018.187544681499;6027.638341699469;6029.427204415573;22435.551288974293;26165.476690466276;26313.605295920577;26413.471730565474;26594.468110637874;2456.459578892641;2485.1674688979215;2808.873600687974;2904.4771941050603;3080.1375614827884;15189.924050379788;15394.15332156731;15513.379464821393;15793.60515987098;16286.022838629602;1865.8462518792826;1892.4606487151234;1955.452473307462;2024.817766401031;2070.8354852806724;91265.63101553482;109984;113914.99999999917;114618.70762584785;115054;10482.109020733324;10675;10704.411257380918;11001.834972475419;11180.664580062612;13753.243571603658;13756.724865502634;13760.724785504433;13770.104943178661;13772.173669579857;8359.247667709813;8593.828123437495;8617.095205003385;8707.692461497709;8707.956460217658;8938.016818149998;8950.731478055539;8960.32797540174;9139.040400757958;9204.217641500414;6476.35236476358;6636.30318816527;6638;6639.800805975829;6650.434713049348;1726.8704847136514;1787.16896643059;1830.569816093217;1861.1252711225973;1907.5612609099985;867.9237745195911;875.9386842920934;906.6871929184421;921.2399770189486;975.9121679048919;21444;22289.774062426397;22312.21907233239;22546.774532254796;22687.092516299163;897.3270047464401;979.5249304087512;1001.5993602558889;1014.3052009373603;1030.7526193713604;10074.395536267848;10757.354558726502;11993.820092698617;12066.276023438622;12123.09076819242;568067;574991;577707;602129;615591;99486;105528;105628;106670.46664766627;111316;1018.760591261053;1034.3535290443472;1036.7511797168777;1061.490484567412;1063.622414043019;15852;19291.903540482206;20284.391468255977;21263.68104478465;21267;43978.12043759171;47737.80655483641;50682.705624134316;51162.74418628032;51250.48749512457;48360;64441.67779161074;65333.67333163494;65481;66222;7086.893696594452;7893.921060789318;7960.601969901598;8061.39539534549;8150.604236365752;7275.599842008741;12440.937795311327;12467.93766031164;13245.933770331472;13682.863171368159;9243.676471323472;10033.548490317808;11101.666949991513;11211;12055.939720301343;10193.337433066827;10773.946130269613;11255.493502792231;11642.24325418845;11958.282503049844;11670.416479175838;11728.589499367481;11791.410429478663;11920.582779603019;12001.699957501132;7980.92019079825;8034.799130021796;8160.551169685724;8197.71308004217;8227.095019547965;10465.790684186426;10510.264281500222;11436;11563.942180289045;11926.344051077274 12:14:44 INFO - PROCESS | 1636 | |3;mootools.html;1528.5185166672497;1558.5324402679196;1808.5207420033694;1920.1359388275262;1972.280117757019;8511.829763404736;9115.40480415927;9117.544122793866;9125.178733913946;9127.315451341152;7999.440039197259;8179.304759095469;8197.508149511019;8626.65493380264;8903.866442003358;2352.2120089769905;2417.6736140621056;2418.4800267942387;2423.757624237571;2429.6841410616594;2157.374361435182;2214.6490640709153;2418.9516209675794;2424.4302588891596;2433.4038160650666;2352;2368.1829768729763;2389.5101504191684;2391.3065211088765;2422.7819496245334;2375.251795684354;2387.0809738250723;2387.8328517003815;2394.0663141374876;2406.747291534381;2366.479374537599;2387.2599494156866;2388.8566685998894;2391.5934291170543;2395.101836811196;8823.11768823119;9037.457752534869;9039.231665308456;9046.140616641409;9064.954675226647;5298.258243845865;5475.288212532345;5475.835724928259;5475.945240547623;5476.096444086721;3519.5248641433336;3551.058969373118;3574.428091505347;3607.0441333046765;3616.764910280823;1106.8450416941555;1108.2131686502594;1114.6433141394675;1125.8142406502918;1133.6939026462892;11682.357470339128;11780.587679431179;11803.23278986863;11812.645620631394;11816.054715622815;4619.676622636451;4670.579647831712;4872.4883887192045;4884.535969082932;4889.217725163957;10159.746006349753;10172.796544069077;10173.796524069478;10183.287169898183;10216.540255688511;5460.126379779216;5465.7155568441385;5471.23402723619;5474.7810087596845;5481.2874326338115;4482.5069242383315;4606.147862645421;4623.745693986796;4938.283948827472;5011.997600479918;3892.4355968384994;3999.460072890123;4001.5998400160333;4128.8348466061625;4133.111381053088;1150.6605551362202;1286.7233544787728;1292.405493472994;1304.276126749663;1310.0567591334225;845.2308399356556;897.9865302020474;907.4101833807946;910.922571581423;926.6988228825659;5389.892202155935;5593.916091258634;5970.76116955317;6024.216851809237;6064.514838812885;811.2982270336116;843.8059246373368;938.3150300280834;938.558877327655;947.6162154327509;3430.5025771263527;3941.4087886817206;3964.8215830287704;3976.76139431635;4080.897977550585;10556.47217639115;11030.06244469213;11043.39261340634;11047;11054.22620416563;10964.835527467094;11001.284916480403;11003.22977391575;11011.504482298156;11017.504212310465;8070.959645201737;8349.373796965252;8408.663653453794;8509.74470765878;8557.315414766803;5938.465538101592;6111.938880611137;6119.632822030692;6139.8465038372615;6189.597676151036;9110.498922559324;10479.056884880398;10484.108850747467;10495.16038716916;10524.105451036441;10197.84703229467;10321.380717156995;10383.169346452416;10451.425171615634;10611.681649550526;7066;7287.744928927462;7583.127940286717;7585.772426827204;7852.450328476952;8559.828803424021;8776.16626420489;8784;8790.736277911672;8791.472511649321;7693.038370203724;7759.068911730628;7762.340201082971;7929.444938854225;7984.441089123706;7554.395648348009;7655.1962043986805;7679.116901556393;7742;7743.186965368781;7125.608091555015;7214.96392518034;7219.60292183935;7224.2053374129855;7237.674304656198;4845.709257444564;4958.330625365674;4976.104301225814;5091.821786237464;5239.973800130975;4988.850334489971;5033.521815427529;5044.571211447068;5104.770285337095;5232.790688372575 12:14:44 INFO - PROCESS | 1636 | |4;prototype.html;265.8843403119643;297.3829304193797;309.0912716613157;314.57689407746574;319.1271871431634;4993.400791904976;5151.356080489939;5164.509371609701;5220.712860792655;5250.868728281795;3878.4182372644045;4191.748495090289;4776.570108690217;5072.615870540849;5089.949100508994;3276.853660852146;3937.822797974098;3948.598247622096;3977.3238549446664;4009.6792256619474;3864.9227015459815;3917.74632117721;3985.5416627087966;3987.3221552336026;4000.9199816003807;3140.4818204996263;3484.878029268976;3497.3529896969144;3952.3281042222893;3957.1294315250598;3843.9237013636225;3928.2339943710986;3941.073847645801;3964.8810535683974;3965.145095531213;3039.300960779011;3332.3677191860747;3333.3666603345287;3348.196432856097;3486.808225547594;3758.684460438852;4734.976325118387;5005.896344266578;5008.273800298973;5054.014467178865;4035.2938235808615;4447.866564003085;4531.048479819209;4539.116266749295;4570.5602735138655;4984.725840078794;5105.540501354896;5214.296070030573;5281.917206972561;5490.176473528963;3528.6647768461953;3835.3096442640312;3864.8260828262796;3870;3874.2832575973534;4260.467441569804;4791.377120974286;5210.609204309692;5734.046965812609;5822.417758224186;3336.2660214752714;3989.1024519482885;3995.961050126988;4011.939820902689;4018.33697439925;3119.8440077996465;4078.3678529827926;4085.673146148301;4087;4098.6516146127315;4056.8377264909072;4064.004318941819;4613.708161714725;4633.837815676503;4640.605548528345;5474.206240095164;5475.09660905954;5490.505854473116;5500.58745594082;5524.502794748492;1193.8806119388166;1226.5526678519432;1291.380137533989;1356.586241196425;1365.603974847283;851.7947104846696;862.2153840005565;886.6497733395273;911.813078318943;952.5570609666538;4698.765061746899;4863.683860549053;4999.950010497836;5062.974685126551;5209.765560549784;4583.977080114645;5568.6101972862325;5583.637063590853;5594.832155035356;5603.439656034446;4853.563179313808;5214.426413094557;5236.816711415158;5283.471652834686;5298.6290959633225;2940.4266168097442;2974.6133002709944;3000.189948713835;3008.9247768805517;3018.2907016851022;4946.975265123723;5039.924401133986;5340.465953404706;5855.443732845373;5943.494802941798;5141.460146684619;5174.09453345663;5622.156676498476;5725.656460612377;5830.096335068071;4784.641151913551;5522.3649280333275;5873.471387575139;5883.558733094949;5893.909626718985;4824.6863953842885;5406.891862162656;5505.816249506375;5765.85760760395;5797.826065218051;4865.489123641966;5229.470107677226;5517.393086760533;5627.480580243229;5634.492895639412;5366.490183432567;5437.32033495813;5516.317523155476;5869.4717475427415;5968.492678122235;3386.6782655647676;3839.212961342862;3859.343911535102;3884.611538846206;3902.4731661226506;5011.649184557192;5728.828135155952;5749.223854779551;5753.971230143822;5758.798442054508;4483.036147228361;4669.855885308121;4694.873230424741;5248.455679872951;5605.103183490622;5104.9489505104475;5287.788488460573;5495.581943944651;5497.780088796403;5501.779928802963;5152.793888244578;5194.7922083116255;5359.534614077412;5388.225064091917;5424.484673955968;5507.669539827623;5528.281323427928;5554.666719996813;5585.1901474286815;5607.719614019201;5133.486651334837;5199.76601052946;5422.457754224546;5453.15476101205;5548.528375088002 12:14:44 INFO - PROCESS | 1636 | |5;yui.html;637.3371693438824;769.1539306762562;795.9557912474601;823.6622984576321;874.9650013999441;15339.769903451443;16451.341946322133;16452.58868528286;16519.421820236294;17994.280228790867;16690;17306.307747690076;17310.653786924253;17322.04728739919;17329.393471228508;740.3447948565531;751.0611735330837;829.6432534010373;888.5823662878437;909.0182602788972;898.7124120281512;918.3342076994193;919.2186641354862;919.7700574856286;921.9677311294106;979.1432496565506;979.304693667497;981.715302562256;981.8919918808925;984.2470510059774;916.5692124701413;969.9030096990315;970.0978090375947;972.5526257921365;974.9463779492161;721.5273995532934;722.1911459165716;722.5014739829501;724.4928550014957;724.8369116948697;16251.83748162515;16429.507114786575;16574.585635359093;16574.585635359213;16619.91690041542;14372.065815721944;14460.783088253685;14502.782458263135;14864.331105100297;14897.404103835834;11838.644840654793;11977.520899164023;11997.520099196021;12197.939010304892;12437.502499899992;3838.673712734421;4000.3599424092004;4003.4395184674167;4017.055991841944;4138.234426631053;97515;127793.36103319516;130910.3454482731;131055;131253;11153.944230278797;11492.310461372344;11510.942445287887;11646;11766.823497647541;22882.65676014861;22899.656505152438;22907.19824806124;23070.077196911934;23094.42263943415;8120.796980075427;8236.670533178725;8241.546714930617;8244.134365891616;8607.139286071342;4547.136044151601;4613.377194078824;4690.530946905282;4786.0667169901535;4920.901581968341;3620.1311685195365;3806.333891568964;3806.7715937043868;3813.122981714221;3814.1608846053823;675.6216518749516;686.6360828760764;689.8930665746817;694.3785312145601;698.4063545985871;627.6579264300967;637.8309747916805;692.6571347183177;695.3081683724727;696.7561353526226;8971.461712297283;9549.809003819884;9807.558659860324;9900.841945652584;9954.601815927283;582.3316199089578;602.1329285828393;613.8158552434342;614.6680792372158;619.1517620859452;4608.815647374135;4710.609089232359;4719.315699223594;4739.549742774431;4758.42898852133;124834.37582812028;134392.32803836113;137777.31111344378;138872;171335;125500.74499255074;128785;132653;135560.32219839035;136209.95685064732;79704;96149;99780;115236.99999999833;120114.19257748219;9447.858282125637;10325.535350909377;10331.483425828528;10372.792544149226;10394.58421663125;64670;65781.67109164424;66286;66598.33401666115;68310.3168968304;85821.14178858382;87618;87719;89251;91655;12952.740945181233;13025.08824382322;13139.737205256033;13628.93185534066;13734.725305494034;15068.246587670354;15189.240537973279;15235.771463427836;15564.14397208119;15586.454474093352;13779.242141682304;14181;14768.704625907636;14862.777058343918;15176.951111599792;14305.928470357581;14475.348609312396;14515.709685806436;14523.709525809636;14746.483873064391;14167.504137355143;14264.786028209794;14528.927355363156;14558.4904528341;14745.483908063166;11455;11597.420128993685;11647.6505704829;11729.296242225493;12103.394830258276;11345.149113816331;11445.187205851615;11597.420128993685;11785.941070294937;11793.054146065802 12:14:44 INFO - PROCESS | 1636 | __end_tp_report 12:14:44 INFO - PROCESS | 1636 | __start_cc_report 12:14:44 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1234 12:14:44 INFO - PROCESS | 1636 | __end_cc_report 12:14:44 INFO - PROCESS | 1636 | __startTimestamp1484252084903__endTimestamp 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | ------- Summary: start ------- 12:14:44 INFO - PROCESS | 1636 | Number of tests: 6 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5752.30 Median:5998.01 stddev:632.48 (10.5%) stddev-sans-first:608.24 12:14:44 INFO - PROCESS | 1636 | Values: 3457.0 3466.4 3478.3 3478.6 3521.8 5450.5 5672.5 5744.1 5754.1 5755.3 5637.4 5738.7 5757.7 5757.9 5761.5 5225.1 5239.3 5243.1 5277.6 5293.3 5207.5 5230.6 5240.7 5324.0 5328.9 5265.7 5272.2 5276.3 5282.9 5309.7 5270.9 5293.0 5324.9 5329.5 5332.5 5127.6 5167.3 5261.1 5271.0 5278.4 5617.5 5648.6 5663.9 5722.2 5731.7 6186.9 6243.0 6245.1 6254.8 6288.2 6296.1 6311.1 6311.7 6312.3 6333.3 5675.5 5756.2 5760.3 5811.2 5830.2 6238.9 6259.4 6270.4 6287.2 6295.0 6149.5 6151.3 6156.5 6168.3 6182.8 5035.3 5069.4 6109.3 6228.8 6277.8 6128.9 6143.6 6154.8 6219.6 6238.9 6227.0 6261.8 6280.2 6288.1 6323.3 4951.5 4952.6 4964.3 4979.2 4983.7 4394.7 4421.6 4426.6 4437.4 4505.6 5774.3 5824.9 5826.6 5844.1 5869.8 6249.7 6274.7 6275.2 6277.3 6283.6 4885.8 5620.4 5676.4 5720.4 5825.7 5380.0 5409.6 5415.6 5422.7 5432.0 6294.8 6305.0 6336.8 6356.5 6361.0 6273.6 6309.2 6312.1 6319.5 6323.9 6209.9 6231.7 6289.1 6290.3 6343.2 6220.5 6246.1 6256.6 6273.1 6283.5 6045.2 6306.4 6320.1 6321.6 6339.9 5998.0 6035.4 6103.5 6189.8 6210.7 6084.7 6102.7 6107.7 6115.5 6128.0 6005.0 6018.4 6027.1 6032.3 6037.4 6011.9 6101.3 6154.9 6155.9 6156.4 4963.6 5870.0 5908.4 5914.2 5971.5 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:70290.65 Median:35373.06 stddev:157316.57 (444.7%) stddev-sans-first:157670.65 12:14:44 INFO - PROCESS | 1636 | Values: 512.5 540.3 544.6 548.9 562.9 31927.4 32738.3 33893.0 33921.2 33925.2 35298.8 35940.5 36003.6 36015.5 44949.0 9705.2 10021.3 10028.8 10043.7 10050.5 9802.2 9907.9 9918.6 9924.9 9926.1 9191.8 9405.2 9913.3 9964.4 9968.2 12418.8 12716.0 12736.8 12737.0 12750.6 10556.8 12343.0 12355.1 12458.9 12474.4 42690.0 42835.6 42846.1 42970.1 43231.4 3393.6 3430.8 3649.1 3820.0 4353.8 31290.5 31333.0 31393.8 32031.8 33953.7 3394.7 3426.4 3434.0 3452.4 3501.7 498792.0 499622.0 499788.5 500603.0 500724.0 35191.0 35966.7 64294.7 64519.0 64683.4 37368.6 37537.4 37538.2 37610.0 37614.8 15732.6 15876.6 15890.6 15893.3 15915.4 13280.2 13365.0 13371.9 13413.9 13418.1 6943.4 8114.8 8172.1 8274.1 8319.4 3201.5 3290.1 3373.4 3399.5 3452.9 878.2 972.5 990.7 1001.3 1117.3 26816.7 26916.5 31557.4 32051.1 32110.5 1087.6 1092.9 1103.1 1110.4 1222.1 16061.8 16540.0 16545.8 16596.4 16875.5 674022.0 678296.0 680373.0 680884.0 682242.6 53836.9 54439.0 60248.7 60875.7 60907.7 1254.9 1264.7 1265.7 1432.3 1454.0 30883.8 32998.8 33008.0 33261.0 33599.0 47164.6 54166.0 54245.2 54362.5 54383.2 444483.0 559595.0 563390.0 620534.0 636625.0 24150.0 27295.0 27660.7 27995.0 28065.7 48060.8 48405.5 48752.5 48879.5 49246.0 32510.3 39223.4 39700.2 39726.6 41023.8 36563.7 39811.2 40533.4 41175.0 41623.8 34781.7 39016.6 39884.4 40318.4 40448.0 34042.5 34826.7 35281.0 35367.5 35378.6 25790.4 25960.9 26209.0 26261.0 26578.7 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:33662.11 Median:2470.81 stddev:97260.33 (3936.4%) stddev-sans-first:97500.96 12:14:44 INFO - PROCESS | 1636 | Values: 322.5 387.4 387.7 398.8 416.6 19505.5 20996.8 21246.8 21389.5 21425.1 20496.1 20778.8 21263.7 21358.8 21518.8 5964.2 5989.2 6138.4 6213.7 6220.8 4413.2 4488.9 4496.3 6086.9 6212.8 5910.8 6557.9 6835.8 6883.4 6970.8 6678.3 6875.3 6930.4 6930.8 6935.4 5797.4 5954.5 6018.2 6027.6 6029.4 22435.6 26165.5 26313.6 26413.5 26594.5 2456.5 2485.2 2808.9 2904.5 3080.1 15189.9 15394.2 15513.4 15793.6 16286.0 1865.8 1892.5 1955.5 2024.8 2070.8 91265.6 109984.0 113915.0 114618.7 115054.0 10482.1 10675.0 10704.4 11001.8 11180.7 13753.2 13756.7 13760.7 13770.1 13772.2 8359.2 8593.8 8617.1 8707.7 8708.0 8938.0 8950.7 8960.3 9139.0 9204.2 6476.4 6636.3 6638.0 6639.8 6650.4 1726.9 1787.2 1830.6 1861.1 1907.6 867.9 875.9 906.7 921.2 975.9 21444.0 22289.8 22312.2 22546.8 22687.1 897.3 979.5 1001.6 1014.3 1030.8 10074.4 10757.4 11993.8 12066.3 12123.1 568067.0 574991.0 577707.0 602129.0 615591.0 99486.0 105528.0 105628.0 106670.5 111316.0 1018.8 1034.4 1036.8 1061.5 1063.6 15852.0 19291.9 20284.4 21263.7 21267.0 43978.1 47737.8 50682.7 51162.7 51250.5 48360.0 64441.7 65333.7 65481.0 66222.0 7086.9 7893.9 7960.6 8061.4 8150.6 7275.6 12440.9 12467.9 13245.9 13682.9 9243.7 10033.5 11101.7 11211.0 12055.9 10193.3 10773.9 11255.5 11642.2 11958.3 11670.4 11728.6 11791.4 11920.6 12001.7 7980.9 8034.8 8160.6 8197.7 8227.1 10465.8 10510.3 11436.0 11563.9 11926.3 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5832.32 Median:4878.51 stddev:3281.98 (67.3%) stddev-sans-first:3275.25 12:14:44 INFO - PROCESS | 1636 | Values: 1528.5 1558.5 1808.5 1920.1 1972.3 8511.8 9115.4 9117.5 9125.2 9127.3 7999.4 8179.3 8197.5 8626.7 8903.9 2352.2 2417.7 2418.5 2423.8 2429.7 2157.4 2214.6 2419.0 2424.4 2433.4 2352.0 2368.2 2389.5 2391.3 2422.8 2375.3 2387.1 2387.8 2394.1 2406.7 2366.5 2387.3 2388.9 2391.6 2395.1 8823.1 9037.5 9039.2 9046.1 9065.0 5298.3 5475.3 5475.8 5475.9 5476.1 3519.5 3551.1 3574.4 3607.0 3616.8 1106.8 1108.2 1114.6 1125.8 1133.7 11682.4 11780.6 11803.2 11812.6 11816.1 4619.7 4670.6 4872.5 4884.5 4889.2 10159.7 10172.8 10173.8 10183.3 10216.5 5460.1 5465.7 5471.2 5474.8 5481.3 4482.5 4606.1 4623.7 4938.3 5012.0 3892.4 3999.5 4001.6 4128.8 4133.1 1150.7 1286.7 1292.4 1304.3 1310.1 845.2 898.0 907.4 910.9 926.7 5389.9 5593.9 5970.8 6024.2 6064.5 811.3 843.8 938.3 938.6 947.6 3430.5 3941.4 3964.8 3976.8 4080.9 10556.5 11030.1 11043.4 11047.0 11054.2 10964.8 11001.3 11003.2 11011.5 11017.5 8071.0 8349.4 8408.7 8509.7 8557.3 5938.5 6111.9 6119.6 6139.8 6189.6 9110.5 10479.1 10484.1 10495.2 10524.1 10197.8 10321.4 10383.2 10451.4 10611.7 7066.0 7287.7 7583.1 7585.8 7852.5 8559.8 8776.2 8784.0 8790.7 8791.5 7693.0 7759.1 7762.3 7929.4 7984.4 7554.4 7655.2 7679.1 7742.0 7743.2 7125.6 7215.0 7219.6 7224.2 7237.7 4845.7 4958.3 4976.1 5091.8 5240.0 4988.9 5033.5 5044.6 5104.8 5232.8 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4423.34 Median:5002.92 stddev:1351.65 (27.0%) stddev-sans-first:1318.93 12:14:44 INFO - PROCESS | 1636 | Values: 265.9 297.4 309.1 314.6 319.1 4993.4 5151.4 5164.5 5220.7 5250.9 3878.4 4191.7 4776.6 5072.6 5089.9 3276.9 3937.8 3948.6 3977.3 4009.7 3864.9 3917.7 3985.5 3987.3 4000.9 3140.5 3484.9 3497.4 3952.3 3957.1 3843.9 3928.2 3941.1 3964.9 3965.1 3039.3 3332.4 3333.4 3348.2 3486.8 3758.7 4735.0 5005.9 5008.3 5054.0 4035.3 4447.9 4531.0 4539.1 4570.6 4984.7 5105.5 5214.3 5281.9 5490.2 3528.7 3835.3 3864.8 3870.0 3874.3 4260.5 4791.4 5210.6 5734.0 5822.4 3336.3 3989.1 3996.0 4011.9 4018.3 3119.8 4078.4 4085.7 4087.0 4098.7 4056.8 4064.0 4613.7 4633.8 4640.6 5474.2 5475.1 5490.5 5500.6 5524.5 1193.9 1226.6 1291.4 1356.6 1365.6 851.8 862.2 886.6 911.8 952.6 4698.8 4863.7 5000.0 5063.0 5209.8 4584.0 5568.6 5583.6 5594.8 5603.4 4853.6 5214.4 5236.8 5283.5 5298.6 2940.4 2974.6 3000.2 3008.9 3018.3 4947.0 5039.9 5340.5 5855.4 5943.5 5141.5 5174.1 5622.2 5725.7 5830.1 4784.6 5522.4 5873.5 5883.6 5893.9 4824.7 5406.9 5505.8 5765.9 5797.8 4865.5 5229.5 5517.4 5627.5 5634.5 5366.5 5437.3 5516.3 5869.5 5968.5 3386.7 3839.2 3859.3 3884.6 3902.5 5011.6 5728.8 5749.2 5754.0 5758.8 4483.0 4669.9 4694.9 5248.5 5605.1 5104.9 5287.8 5495.6 5497.8 5501.8 5152.8 5194.8 5359.5 5388.2 5424.5 5507.7 5528.3 5554.7 5585.2 5607.7 5133.5 5199.8 5422.5 5453.2 5548.5 12:14:44 INFO - PROCESS | 1636 | 12:14:44 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:25365.08 Median:3713.23 stddev:39669.57 (1068.3%) stddev-sans-first:39737.40 12:14:44 INFO - PROCESS | 1636 | Values: 637.3 769.2 796.0 823.7 875.0 15339.8 16451.3 16452.6 16519.4 17994.3 16690.0 17306.3 17310.7 17322.0 17329.4 740.3 751.1 829.6 888.6 909.0 898.7 918.3 919.2 919.8 922.0 979.1 979.3 981.7 981.9 984.2 916.6 969.9 970.1 972.6 974.9 721.5 722.2 722.5 724.5 724.8 16251.8 16429.5 16574.6 16574.6 16619.9 14372.1 14460.8 14502.8 14864.3 14897.4 11838.6 11977.5 11997.5 12197.9 12437.5 3838.7 4000.4 4003.4 4017.1 4138.2 97515.0 127793.4 130910.3 131055.0 131253.0 11153.9 11492.3 11510.9 11646.0 11766.8 22882.7 22899.7 22907.2 23070.1 23094.4 8120.8 8236.7 8241.5 8244.1 8607.1 4547.1 4613.4 4690.5 4786.1 4920.9 3620.1 3806.3 3806.8 3813.1 3814.2 675.6 686.6 689.9 694.4 698.4 627.7 637.8 692.7 695.3 696.8 8971.5 9549.8 9807.6 9900.8 9954.6 582.3 602.1 613.8 614.7 619.2 4608.8 4710.6 4719.3 4739.5 4758.4 124834.4 134392.3 137777.3 138872.0 171335.0 125500.7 128785.0 132653.0 135560.3 136210.0 79704.0 96149.0 99780.0 115237.0 120114.2 9447.9 10325.5 10331.5 10372.8 10394.6 64670.0 65781.7 66286.0 66598.3 68310.3 85821.1 87618.0 87719.0 89251.0 91655.0 12952.7 13025.1 13139.7 13628.9 13734.7 15068.2 15189.2 15235.8 15564.1 15586.5 13779.2 14181.0 14768.7 14862.8 15177.0 14305.9 14475.3 14515.7 14523.7 14746.5 14167.5 14264.8 14528.9 14558.5 14745.5 11455.0 11597.4 11647.7 11729.3 12103.4 11345.1 11445.2 11597.4 11785.9 11793.1 12:14:44 INFO - PROCESS | 1636 | -------- Summary: end -------- 12:14:44 INFO - PROCESS | 1636 | 12:14:45 INFO - TEST-INFO | 1636: exit 0 12:14:45 INFO - TEST-OK | dromaeo_css | took 1114597ms 12:14:45 INFO - TEST-START | kraken 12:14:45 INFO - operating with platform_type : mac_ 12:14:45 INFO - Initialising browser for kraken test... 12:14:45 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplbnsO0/profile http://localhost:49240/getInfo.html) 12:14:47 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 12:14:47 INFO - PROCESS | 1646 | colorDepth:24 12:14:47 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 12:14:47 INFO - PROCESS | 1646 | __metrics 12:14:47 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:14:47 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:48 INFO - TEST-INFO | 1646: exit 0 12:14:48 INFO - Browser initialized. 12:14:48 INFO - Running cycle 1/1 for kraken test... 12:14:48 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplbnsO0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:00 INFO - PROCESS | 1648 | RSS: Main: 164470784 12:15:00 INFO - PROCESS | 1648 | 12:15:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:03 INFO - PROCESS | 1648 | RSS: Main: 216154112 12:15:03 INFO - PROCESS | 1648 | 12:15:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 12:15:06 INFO - PROCESS | 1648 | RSS: Main: 227856384 12:15:06 INFO - PROCESS | 1648 | 12:15:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 12:15:10 INFO - PROCESS | 1648 | RSS: Main: 325287936 12:15:10 INFO - PROCESS | 1648 | 12:15:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 12:15:13 INFO - PROCESS | 1648 | RSS: Main: 227262464 12:15:13 INFO - PROCESS | 1648 | 12:15:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:15 INFO - PROCESS | 1648 | RSS: Main: 228913152 12:15:15 INFO - PROCESS | 1648 | 12:15:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:18 INFO - PROCESS | 1648 | RSS: Main: 266452992 12:15:18 INFO - PROCESS | 1648 | 12:15:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:22 INFO - PROCESS | 1648 | RSS: Main: 265961472 12:15:22 INFO - PROCESS | 1648 | 12:15:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 12:15:25 INFO - PROCESS | 1648 | RSS: Main: 263254016 12:15:25 INFO - PROCESS | 1648 | 12:15:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:27 INFO - PROCESS | 1648 | RSS: Main: 240168960 12:15:27 INFO - PROCESS | 1648 | 12:15:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:30 INFO - PROCESS | 1648 | RSS: Main: 245051392 12:15:30 INFO - PROCESS | 1648 | 12:15:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:33 INFO - PROCESS | 1648 | RSS: Main: 248713216 12:15:33 INFO - PROCESS | 1648 | 12:15:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:36 INFO - PROCESS | 1648 | RSS: Main: 265535488 12:15:36 INFO - PROCESS | 1648 | 12:15:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:40 INFO - PROCESS | 1648 | RSS: Main: 258056192 12:15:40 INFO - PROCESS | 1648 | 12:15:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 12:15:42 INFO - PROCESS | 1648 | RSS: Main: 301985792 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | __start_tp_report 12:15:42 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 12:15:42 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 12:15:42 INFO - PROCESS | 1648 | |i|pagename|runs| 12:15:42 INFO - PROCESS | 1648 | |0;ai-astar;103;112;112;112;113;112;112;112;112;114 12:15:42 INFO - PROCESS | 1648 | |1;audio-beat-detection;141;108;109;140;109;111;134;136;171;107 12:15:42 INFO - PROCESS | 1648 | |2;audio-dft;186;182;183;181;181;182;177;184;182;181 12:15:42 INFO - PROCESS | 1648 | |3;audio-fft;80;61;59;89;60;60;59;59;79;57 12:15:42 INFO - PROCESS | 1648 | |4;audio-oscillator;89;71;93;68;68;70;90;67;68;89 12:15:42 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;85;88;84;88;85;121;85;87;84 12:15:42 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;93;93;93;102;143;93;94;93;93 12:15:42 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;84;85;85;86;85;85;85;87;101 12:15:42 INFO - PROCESS | 1648 | |8;json-parse-financial;56;52;53;51;56;58;55;56;56;56 12:15:42 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;62;74;64;75;70;67;69;69;69;70 12:15:42 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;83;91;99;100;75;79;81;84;85 12:15:42 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;140;139;141;151;127;145;143;151;189;137 12:15:42 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;163;159;159;159;159;161;157;159;154;159 12:15:42 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;67;68;79;82;82;55;68;79;65 12:15:42 INFO - PROCESS | 1648 | __end_tp_report 12:15:42 INFO - PROCESS | 1648 | __start_cc_report 12:15:42 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1896 12:15:42 INFO - PROCESS | 1648 | __end_cc_report 12:15:42 INFO - PROCESS | 1648 | __startTimestamp1484252142194__endTimestamp 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | ------- Summary: start ------- 12:15:42 INFO - PROCESS | 1648 | Number of tests: 14 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:0.71 12:15:42 INFO - PROCESS | 1648 | Values: 103.0 112.0 112.0 112.0 113.0 112.0 112.0 112.0 112.0 114.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:135.00 stddev:21.33 (15.8%) stddev-sans-first:21.98 12:15:42 INFO - PROCESS | 1648 | Values: 141.0 108.0 109.0 140.0 109.0 111.0 134.0 136.0 171.0 107.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.00 stddev:2.33 (1.3%) stddev-sans-first:1.94 12:15:42 INFO - PROCESS | 1648 | Values: 186.0 182.0 183.0 181.0 181.0 182.0 177.0 184.0 182.0 181.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:11.63 (19.2%) stddev-sans-first:11.23 12:15:42 INFO - PROCESS | 1648 | Values: 80.0 61.0 59.0 89.0 60.0 60.0 59.0 59.0 79.0 57.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:80.00 stddev:11.26 (14.1%) stddev-sans-first:11.11 12:15:42 INFO - PROCESS | 1648 | Values: 89.0 71.0 93.0 68.0 68.0 70.0 90.0 67.0 68.0 89.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:86.00 stddev:11.19 (13.0%) stddev-sans-first:11.85 12:15:42 INFO - PROCESS | 1648 | Values: 88.0 85.0 88.0 84.0 88.0 85.0 121.0 85.0 87.0 84.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:93.00 stddev:15.71 (16.9%) stddev-sans-first:16.52 12:15:42 INFO - PROCESS | 1648 | Values: 93.0 93.0 93.0 93.0 102.0 143.0 93.0 94.0 93.0 93.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:85.00 stddev:5.05 (5.9%) stddev-sans-first:5.32 12:15:42 INFO - PROCESS | 1648 | Values: 85.0 84.0 85.0 85.0 86.0 85.0 85.0 85.0 87.0 101.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.28 12:15:42 INFO - PROCESS | 1648 | Values: 56.0 52.0 53.0 51.0 56.0 58.0 55.0 56.0 56.0 56.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.50 stddev:3.96 (5.7%) stddev-sans-first:3.32 12:15:42 INFO - PROCESS | 1648 | Values: 62.0 74.0 64.0 75.0 70.0 67.0 69.0 69.0 69.0 70.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:84.50 stddev:8.16 (9.7%) stddev-sans-first:8.65 12:15:42 INFO - PROCESS | 1648 | Values: 85.0 83.0 91.0 99.0 100.0 75.0 79.0 81.0 84.0 85.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:144.00 stddev:16.53 (11.5%) stddev-sans-first:17.38 12:15:42 INFO - PROCESS | 1648 | Values: 140.0 139.0 141.0 151.0 127.0 145.0 143.0 151.0 189.0 137.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.33 (1.5%) stddev-sans-first:1.94 12:15:42 INFO - PROCESS | 1648 | Values: 163.0 159.0 159.0 159.0 159.0 161.0 157.0 159.0 154.0 159.0 12:15:42 INFO - PROCESS | 1648 | 12:15:42 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:73.50 stddev:9.02 (12.3%) stddev-sans-first:9.30 12:15:42 INFO - PROCESS | 1648 | Values: 65.0 67.0 68.0 79.0 82.0 82.0 55.0 68.0 79.0 65.0 12:15:42 INFO - PROCESS | 1648 | -------- Summary: end -------- 12:15:42 INFO - PROCESS | 1648 | 12:15:43 INFO - TEST-INFO | 1648: exit 0 12:15:43 INFO - TEST-OK | kraken | took 57607ms 12:15:43 INFO - SUITE-END | took 1172s 12:15:43 INFO - Completed test suite (00:19:32) 12:15:43 INFO - javascript benchmark 12:15:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3456.982715086425, 3466.376052310583, 3478.2521757822065, 3478.6173520912694, 3521.7534772565914, 5450.454954504553, 5672.489475947164, 5744.080947048473, 5754.108113242449, 5755.280589926259, 5637.436256374361, 5738.6556806591525, 5757.654540727549, 5757.856053598652, 5761.4814666679995, 5225.085610018251, 5239.292695486099, 5243.082460569394, 5277.577793776508, 5293.338332708411, 5207.531322181003, 5230.581553475732, 5240.68555886648, 5324.0, 5328.934213157365, 5265.736713164346, 5272.156454967206, 5276.261323414725, 5282.867928301785, 5309.654872433299, 5270.894582108374, 5292.973535132338, 5324.866878328034, 5329.520343169133, 5332.520073193393, 5127.641065125443, 5167.276581278624, 5261.105612045962, 5270.998510283072, 5278.366596008465, 5617.522510586605, 5648.604597678164, 5663.8584035399035, 5722.170285308607, 5731.656100633975, 6186.907196392058, 6242.997913689478, 6245.063240513914, 6254.8123556293385, 6288.182536270256, 6296.0555916612875, 6311.116443697886, 6311.684415779238, 6312.305646378894, 6333.334999824998, 5675.460831221028, 5756.222909907193, 5760.2511673482595, 5811.186433899257, 5830.154627579062, 6238.937610623926, 6259.374062593704, 6270.404311590391, 6287.2140982377205, 6295.024271237966, 6149.477294430024, 6151.323354431099, 6156.476699480594, 6168.259808822881, 6182.752689892354, 5035.295058691786, 5069.442361340323, 6109.2528441424865, 6228.813135605939, 6277.811665650038, 6128.937268230797, 6143.631382116998, 6154.76904619078, 6219.626822390671, 6238.906416403757, 6227.0, 6261.78083767066, 6280.152179455807, 6288.088227207029, 6323.336049714806, 4951.529604687549, 4952.5542701157065, 4964.255361695775, 4979.178435558092, 4983.700977941263, 4394.670399720034, 4421.579949904753, 4426.601605855424, 4437.445319335083, 4505.5719706627815, 5774.335951365647, 5824.912626310609, 5826.592138550261, 5844.094165404369, 5869.8239052828485, 6249.6562689052535, 6274.6548939808745, 6275.215598050244, 6277.340879207709, 6283.59156654816, 4885.780139893714, 5620.381758006616, 5676.375598684224, 5720.370759216483, 5825.679587622722, 5380.0, 5409.648372855751, 5415.6479828811, 5422.701751403711, 5432.0, 6294.8426289342215, 6305.0, 6336.841578960563, 6356.459700925473, 6361.045843123568, 6273.62358258506, 6309.211348581427, 6312.147860038836, 6319.52603554726, 6323.936760632335, 6209.906851397142, 6231.657258850625, 6289.056641503811, 6290.2766181889665, 6343.238811342669, 6220.502359811295, 6246.063090536456, 6256.562040657111, 6273.121762953281, 6283.49732021428, 6045.244344456943, 6306.400891915261, 6320.051992201023, 6321.589096708699, 6339.873202536016, 5998.0103282957825, 6035.426634469718, 6103.542234332532, 6189.81430557084, 6210.689465526615, 6084.726187321493, 6102.694865256631, 6107.704691583656, 6115.453310713017, 6127.9837278401355, 6004.969975150097, 6018.36807135262, 6027.126066720389, 6032.306284777307, 6037.426444487766, 6011.939880601138, 6101.328853826164, 6154.9384506154365, 6155.876882462415, 6156.384361563808, 4963.602911766978, 5869.970650146722, 5908.3500814911185, 5914.172015917689, 5971.522278217819], "value": 5713.73952273644, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.4542362384061, 540.3461811208437, 544.643258665574, 548.9258950041743, 562.8930503204393, 31927.36145277096, 32738.345233095322, 33892.98321050369, 33921.15197120067, 33925.151871203234, 35298.8235058825, 35940.46089308656, 36003.639963600355, 36015.459768103436, 44949.0, 9705.17506011988, 10021.34861234021, 10028.799424011551, 10043.74890627733, 10050.54772535234, 9802.215822734164, 9907.851382229272, 9918.553665085052, 9924.900750992507, 9926.106650401462, 9191.770205744842, 9405.153536181742, 9913.256505762061, 9964.352317099401, 9968.152707019875, 12418.7581241876, 12716.0, 12736.80894786579, 12737.0, 12750.553730619476, 10556.838747737742, 12343.0, 12355.135140540166, 12458.937705311506, 12474.438650260669, 42690.0, 42835.57164428378, 42846.14307713859, 42970.14059718819, 43231.35152972708, 3393.6267010628812, 3430.828458577061, 3649.1424515238896, 3819.961800382016, 4353.804078816461, 31290.530642040387, 31333.0, 31393.8430307847, 32031.83984080088, 33953.660463395296, 3394.6944774970125, 3426.3832510148163, 3433.9828300858585, 3452.395830729612, 3501.7373696972827, 498792.0, 499622.0, 499788.501057496, 500603.0, 500724.0, 35191.0, 35966.741164059655, 64294.678526607066, 64519.0, 64683.353166467736, 37368.62631373652, 37537.43693844594, 37538.249235015144, 37610.0, 37614.81192594074, 15732.60668483297, 15876.60308492297, 15890.602734931488, 15893.284802183929, 15915.363385464452, 13280.203187808762, 13365.0, 13371.933140334237, 13413.926885849109, 13418.127821691558, 6943.375096241261, 8114.837703245902, 8172.141925097898, 8274.089850116483, 8319.376046796515, 3201.519772034167, 3290.1116698491273, 3373.4265174920324, 3399.5070714746716, 3452.9309413811584, 878.2315473960285, 972.4602845420859, 990.6780296403554, 1001.3040936549029, 1117.279354816139, 26816.731832681424, 26916.46167076687, 31557.368852622818, 32051.13503218402, 32110.518342224885, 1087.6247694545368, 1092.857928469294, 1103.0789290941993, 1110.4447776111945, 1222.095649219589, 16061.839381606269, 16540.007599543824, 16545.751813722563, 16596.419125330554, 16875.493735187963, 674022.0, 678296.0, 680373.0, 680884.0, 682242.5887870529, 53836.92326153533, 54439.0, 60248.69875650681, 60875.69562152161, 60907.6954615233, 1254.9309787961568, 1264.7027948432294, 1265.6645988812973, 1432.3339647063956, 1454.040333379964, 30883.84558077195, 32998.83500582482, 33008.0, 33261.0, 33599.0, 47164.58506244818, 54166.0, 54245.18632220599, 54362.45637543574, 54383.18425223546, 444483.0, 559595.0, 563390.0, 620534.0, 636625.0, 24150.0, 27295.0, 27660.723392765816, 27995.0201742938, 28065.71934280631, 48060.7596962013, 48405.54783356505, 48752.5124748748, 48879.511204887494, 49246.0, 32510.286008529103, 39223.41164882472, 39700.20599587934, 39726.60273397229, 41023.7948810254, 36563.72026979043, 39811.2037759249, 40533.39199912063, 41175.0, 41623.7918810404, 34781.65218347784, 39016.6098339013, 39884.401733973435, 40318.39522407108, 40448.0, 34042.489362660075, 34826.651733483355, 35281.0, 35367.46948795822, 35378.64621353857, 25790.355241119123, 25960.870195648902, 26209.0, 26261.0, 26578.7342126584], "value": 19326.33221354116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.54521125213444, 387.40726688167103, 387.69759587521725, 398.77867783380213, 416.61879380366963, 19505.51236219095, 20996.790032099674, 21246.787532124676, 21389.465263368424, 21425.142994280228, 20496.077676504556, 20778.792212077875, 21263.68104478434, 21358.786412135873, 21518.784812151913, 5964.165016897616, 5989.161517387569, 6138.355472675372, 6213.689315534228, 6220.813375598739, 4413.161499315136, 4488.887777805565, 4496.303073023687, 6086.908696369558, 6212.8446788830415, 5910.793122240722, 6557.901631475532, 6835.829104272408, 6883.4149097326535, 6970.780113480146, 6678.2987786282465, 6875.278095799919, 6930.44556435484, 6930.792076237721, 6935.410490108322, 5797.391273916262, 5954.46409823118, 6018.187544681499, 6027.638341699469, 6029.427204415573, 22435.551288974293, 26165.476690466276, 26313.605295920577, 26413.471730565474, 26594.468110637874, 2456.459578892641, 2485.1674688979215, 2808.873600687974, 2904.4771941050603, 3080.1375614827884, 15189.924050379788, 15394.15332156731, 15513.379464821393, 15793.60515987098, 16286.022838629602, 1865.8462518792826, 1892.4606487151234, 1955.452473307462, 2024.817766401031, 2070.8354852806724, 91265.63101553482, 109984.0, 113914.99999999917, 114618.70762584785, 115054.0, 10482.109020733324, 10675.0, 10704.411257380918, 11001.834972475419, 11180.664580062612, 13753.243571603658, 13756.724865502634, 13760.724785504433, 13770.104943178661, 13772.173669579857, 8359.247667709813, 8593.828123437495, 8617.095205003385, 8707.692461497709, 8707.956460217658, 8938.016818149998, 8950.731478055539, 8960.32797540174, 9139.040400757958, 9204.217641500414, 6476.35236476358, 6636.30318816527, 6638.0, 6639.800805975829, 6650.434713049348, 1726.8704847136514, 1787.16896643059, 1830.569816093217, 1861.1252711225973, 1907.5612609099985, 867.9237745195911, 875.9386842920934, 906.6871929184421, 921.2399770189486, 975.9121679048919, 21444.0, 22289.774062426397, 22312.21907233239, 22546.774532254796, 22687.092516299163, 897.3270047464401, 979.5249304087512, 1001.5993602558889, 1014.3052009373603, 1030.7526193713604, 10074.395536267848, 10757.354558726502, 11993.820092698617, 12066.276023438622, 12123.09076819242, 568067.0, 574991.0, 577707.0, 602129.0, 615591.0, 99486.0, 105528.0, 105628.0, 106670.46664766627, 111316.0, 1018.760591261053, 1034.3535290443472, 1036.7511797168777, 1061.490484567412, 1063.622414043019, 15852.0, 19291.903540482206, 20284.391468255977, 21263.68104478465, 21267.0, 43978.12043759171, 47737.80655483641, 50682.705624134316, 51162.74418628032, 51250.48749512457, 48360.0, 64441.67779161074, 65333.67333163494, 65481.0, 66222.0, 7086.893696594452, 7893.921060789318, 7960.601969901598, 8061.39539534549, 8150.604236365752, 7275.599842008741, 12440.937795311327, 12467.93766031164, 13245.933770331472, 13682.863171368159, 9243.676471323472, 10033.548490317808, 11101.666949991513, 11211.0, 12055.939720301343, 10193.337433066827, 10773.946130269613, 11255.493502792231, 11642.24325418845, 11958.282503049844, 11670.416479175838, 11728.589499367481, 11791.410429478663, 11920.582779603019, 12001.699957501132, 7980.92019079825, 8034.799130021796, 8160.551169685724, 8197.71308004217, 8227.095019547965, 10465.790684186426, 10510.264281500222, 11436.0, 11563.942180289045, 11926.344051077274], "value": 9805.650003282295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.5185166672497, 1558.5324402679196, 1808.5207420033694, 1920.1359388275262, 1972.280117757019, 8511.829763404736, 9115.40480415927, 9117.544122793866, 9125.178733913946, 9127.315451341152, 7999.440039197259, 8179.304759095469, 8197.508149511019, 8626.65493380264, 8903.866442003358, 2352.2120089769905, 2417.6736140621056, 2418.4800267942387, 2423.757624237571, 2429.6841410616594, 2157.374361435182, 2214.6490640709153, 2418.9516209675794, 2424.4302588891596, 2433.4038160650666, 2352.0, 2368.1829768729763, 2389.5101504191684, 2391.3065211088765, 2422.7819496245334, 2375.251795684354, 2387.0809738250723, 2387.8328517003815, 2394.0663141374876, 2406.747291534381, 2366.479374537599, 2387.2599494156866, 2388.8566685998894, 2391.5934291170543, 2395.101836811196, 8823.11768823119, 9037.457752534869, 9039.231665308456, 9046.140616641409, 9064.954675226647, 5298.258243845865, 5475.288212532345, 5475.835724928259, 5475.945240547623, 5476.096444086721, 3519.5248641433336, 3551.058969373118, 3574.428091505347, 3607.0441333046765, 3616.764910280823, 1106.8450416941555, 1108.2131686502594, 1114.6433141394675, 1125.8142406502918, 1133.6939026462892, 11682.357470339128, 11780.587679431179, 11803.23278986863, 11812.645620631394, 11816.054715622815, 4619.676622636451, 4670.579647831712, 4872.4883887192045, 4884.535969082932, 4889.217725163957, 10159.746006349753, 10172.796544069077, 10173.796524069478, 10183.287169898183, 10216.540255688511, 5460.126379779216, 5465.7155568441385, 5471.23402723619, 5474.7810087596845, 5481.2874326338115, 4482.5069242383315, 4606.147862645421, 4623.745693986796, 4938.283948827472, 5011.997600479918, 3892.4355968384994, 3999.460072890123, 4001.5998400160333, 4128.8348466061625, 4133.111381053088, 1150.6605551362202, 1286.7233544787728, 1292.405493472994, 1304.276126749663, 1310.0567591334225, 845.2308399356556, 897.9865302020474, 907.4101833807946, 910.922571581423, 926.6988228825659, 5389.892202155935, 5593.916091258634, 5970.76116955317, 6024.216851809237, 6064.514838812885, 811.2982270336116, 843.8059246373368, 938.3150300280834, 938.558877327655, 947.6162154327509, 3430.5025771263527, 3941.4087886817206, 3964.8215830287704, 3976.76139431635, 4080.897977550585, 10556.47217639115, 11030.06244469213, 11043.39261340634, 11047.0, 11054.22620416563, 10964.835527467094, 11001.284916480403, 11003.22977391575, 11011.504482298156, 11017.504212310465, 8070.959645201737, 8349.373796965252, 8408.663653453794, 8509.74470765878, 8557.315414766803, 5938.465538101592, 6111.938880611137, 6119.632822030692, 6139.8465038372615, 6189.597676151036, 9110.498922559324, 10479.056884880398, 10484.108850747467, 10495.16038716916, 10524.105451036441, 10197.84703229467, 10321.380717156995, 10383.169346452416, 10451.425171615634, 10611.681649550526, 7066.0, 7287.744928927462, 7583.127940286717, 7585.772426827204, 7852.450328476952, 8559.828803424021, 8776.16626420489, 8784.0, 8790.736277911672, 8791.472511649321, 7693.038370203724, 7759.068911730628, 7762.340201082971, 7929.444938854225, 7984.441089123706, 7554.395648348009, 7655.1962043986805, 7679.116901556393, 7742.0, 7743.186965368781, 7125.608091555015, 7214.96392518034, 7219.60292183935, 7224.2053374129855, 7237.674304656198, 4845.709257444564, 4958.330625365674, 4976.104301225814, 5091.821786237464, 5239.973800130975, 4988.850334489971, 5033.521815427529, 5044.571211447068, 5104.770285337095, 5232.790688372575], "value": 4674.455757792228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.8843403119643, 297.3829304193797, 309.0912716613157, 314.57689407746574, 319.1271871431634, 4993.400791904976, 5151.356080489939, 5164.509371609701, 5220.712860792655, 5250.868728281795, 3878.4182372644045, 4191.748495090289, 4776.570108690217, 5072.615870540849, 5089.949100508994, 3276.853660852146, 3937.822797974098, 3948.598247622096, 3977.3238549446664, 4009.6792256619474, 3864.9227015459815, 3917.74632117721, 3985.5416627087966, 3987.3221552336026, 4000.9199816003807, 3140.4818204996263, 3484.878029268976, 3497.3529896969144, 3952.3281042222893, 3957.1294315250598, 3843.9237013636225, 3928.2339943710986, 3941.073847645801, 3964.8810535683974, 3965.145095531213, 3039.300960779011, 3332.3677191860747, 3333.3666603345287, 3348.196432856097, 3486.808225547594, 3758.684460438852, 4734.976325118387, 5005.896344266578, 5008.273800298973, 5054.014467178865, 4035.2938235808615, 4447.866564003085, 4531.048479819209, 4539.116266749295, 4570.5602735138655, 4984.725840078794, 5105.540501354896, 5214.296070030573, 5281.917206972561, 5490.176473528963, 3528.6647768461953, 3835.3096442640312, 3864.8260828262796, 3870.0, 3874.2832575973534, 4260.467441569804, 4791.377120974286, 5210.609204309692, 5734.046965812609, 5822.417758224186, 3336.2660214752714, 3989.1024519482885, 3995.961050126988, 4011.939820902689, 4018.33697439925, 3119.8440077996465, 4078.3678529827926, 4085.673146148301, 4087.0, 4098.6516146127315, 4056.8377264909072, 4064.004318941819, 4613.708161714725, 4633.837815676503, 4640.605548528345, 5474.206240095164, 5475.09660905954, 5490.505854473116, 5500.58745594082, 5524.502794748492, 1193.8806119388166, 1226.5526678519432, 1291.380137533989, 1356.586241196425, 1365.603974847283, 851.7947104846696, 862.2153840005565, 886.6497733395273, 911.813078318943, 952.5570609666538, 4698.765061746899, 4863.683860549053, 4999.950010497836, 5062.974685126551, 5209.765560549784, 4583.977080114645, 5568.6101972862325, 5583.637063590853, 5594.832155035356, 5603.439656034446, 4853.563179313808, 5214.426413094557, 5236.816711415158, 5283.471652834686, 5298.6290959633225, 2940.4266168097442, 2974.6133002709944, 3000.189948713835, 3008.9247768805517, 3018.2907016851022, 4946.975265123723, 5039.924401133986, 5340.465953404706, 5855.443732845373, 5943.494802941798, 5141.460146684619, 5174.09453345663, 5622.156676498476, 5725.656460612377, 5830.096335068071, 4784.641151913551, 5522.3649280333275, 5873.471387575139, 5883.558733094949, 5893.909626718985, 4824.6863953842885, 5406.891862162656, 5505.816249506375, 5765.85760760395, 5797.826065218051, 4865.489123641966, 5229.470107677226, 5517.393086760533, 5627.480580243229, 5634.492895639412, 5366.490183432567, 5437.32033495813, 5516.317523155476, 5869.4717475427415, 5968.492678122235, 3386.6782655647676, 3839.212961342862, 3859.343911535102, 3884.611538846206, 3902.4731661226506, 5011.649184557192, 5728.828135155952, 5749.223854779551, 5753.971230143822, 5758.798442054508, 4483.036147228361, 4669.855885308121, 4694.873230424741, 5248.455679872951, 5605.103183490622, 5104.9489505104475, 5287.788488460573, 5495.581943944651, 5497.780088796403, 5501.779928802963, 5152.793888244578, 5194.7922083116255, 5359.534614077412, 5388.225064091917, 5424.484673955968, 5507.669539827623, 5528.281323427928, 5554.666719996813, 5585.1901474286815, 5607.719614019201, 5133.486651334837, 5199.76601052946, 5422.457754224546, 5453.15476101205, 5548.528375088002], "value": 3996.800049565533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.3371693438824, 769.1539306762562, 795.9557912474601, 823.6622984576321, 874.9650013999441, 15339.769903451443, 16451.341946322133, 16452.58868528286, 16519.421820236294, 17994.280228790867, 16690.0, 17306.307747690076, 17310.653786924253, 17322.04728739919, 17329.393471228508, 740.3447948565531, 751.0611735330837, 829.6432534010373, 888.5823662878437, 909.0182602788972, 898.7124120281512, 918.3342076994193, 919.2186641354862, 919.7700574856286, 921.9677311294106, 979.1432496565506, 979.304693667497, 981.715302562256, 981.8919918808925, 984.2470510059774, 916.5692124701413, 969.9030096990315, 970.0978090375947, 972.5526257921365, 974.9463779492161, 721.5273995532934, 722.1911459165716, 722.5014739829501, 724.4928550014957, 724.8369116948697, 16251.83748162515, 16429.507114786575, 16574.585635359093, 16574.585635359213, 16619.91690041542, 14372.065815721944, 14460.783088253685, 14502.782458263135, 14864.331105100297, 14897.404103835834, 11838.644840654793, 11977.520899164023, 11997.520099196021, 12197.939010304892, 12437.502499899992, 3838.673712734421, 4000.3599424092004, 4003.4395184674167, 4017.055991841944, 4138.234426631053, 97515.0, 127793.36103319516, 130910.3454482731, 131055.0, 131253.0, 11153.944230278797, 11492.310461372344, 11510.942445287887, 11646.0, 11766.823497647541, 22882.65676014861, 22899.656505152438, 22907.19824806124, 23070.077196911934, 23094.42263943415, 8120.796980075427, 8236.670533178725, 8241.546714930617, 8244.134365891616, 8607.139286071342, 4547.136044151601, 4613.377194078824, 4690.530946905282, 4786.0667169901535, 4920.901581968341, 3620.1311685195365, 3806.333891568964, 3806.7715937043868, 3813.122981714221, 3814.1608846053823, 675.6216518749516, 686.6360828760764, 689.8930665746817, 694.3785312145601, 698.4063545985871, 627.6579264300967, 637.8309747916805, 692.6571347183177, 695.3081683724727, 696.7561353526226, 8971.461712297283, 9549.809003819884, 9807.558659860324, 9900.841945652584, 9954.601815927283, 582.3316199089578, 602.1329285828393, 613.8158552434342, 614.6680792372158, 619.1517620859452, 4608.815647374135, 4710.609089232359, 4719.315699223594, 4739.549742774431, 4758.42898852133, 124834.37582812028, 134392.32803836113, 137777.31111344378, 138872.0, 171335.0, 125500.74499255074, 128785.0, 132653.0, 135560.32219839035, 136209.95685064732, 79704.0, 96149.0, 99780.0, 115236.99999999833, 120114.19257748219, 9447.858282125637, 10325.535350909377, 10331.483425828528, 10372.792544149226, 10394.58421663125, 64670.0, 65781.67109164424, 66286.0, 66598.33401666115, 68310.3168968304, 85821.14178858382, 87618.0, 87719.0, 89251.0, 91655.0, 12952.740945181233, 13025.08824382322, 13139.737205256033, 13628.93185534066, 13734.725305494034, 15068.246587670354, 15189.240537973279, 15235.771463427836, 15564.14397208119, 15586.454474093352, 13779.242141682304, 14181.0, 14768.704625907636, 14862.777058343918, 15176.951111599792, 14305.928470357581, 14475.348609312396, 14515.709685806436, 14523.709525809636, 14746.483873064391, 14167.504137355143, 14264.786028209794, 14528.927355363156, 14558.4904528341, 14745.483908063166, 11455.0, 11597.420128993685, 11647.6505704829, 11729.296242225493, 12103.394830258276, 11345.149113816331, 11445.187205851615, 11597.420128993685, 11785.941070294937, 11793.054146065802], "value": 8199.92739183871, "unit": "score"}], "name": "dromaeo_css", "value": 7412.662919295354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 109.0, 140.0, 109.0, 111.0, 134.0, 136.0, 171.0, 107.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 181.0, 181.0, 182.0, 177.0, 184.0, 182.0, 181.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 59.0, 89.0, 60.0, 60.0, 59.0, 59.0, 79.0, 57.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 93.0, 68.0, 68.0, 70.0, 90.0, 67.0, 68.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 88.0, 85.0, 121.0, 85.0, 87.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 102.0, 143.0, 93.0, 94.0, 93.0, 93.0], "value": 99.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 87.0, 101.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 51.0, 56.0, 58.0, 55.0, 56.0, 56.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 74.0, 64.0, 75.0, 70.0, 67.0, 69.0, 69.0, 69.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 91.0, 99.0, 100.0, 75.0, 79.0, 81.0, 84.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 141.0, 151.0, 127.0, 145.0, 143.0, 151.0, 189.0, 137.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 159.0, 159.0, 159.0, 161.0, 157.0, 159.0, 154.0, 159.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 79.0, 82.0, 82.0, 55.0, 68.0, 79.0, 65.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1425.0, "alertThreshold": 2.0}]} 12:15:43 INFO - Return code: 0 12:15:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:43 INFO - # TBPL SUCCESS # 12:15:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:43 INFO - 2017-01-12 12:15:43.503 screenresolution[1652:9784] starting screenresolution argv=screenresolution get 12:15:43 INFO - 2017-01-12 12:15:43.506 screenresolution[1652:9784] Display 0: 1600x1200x32@60 12:15:43 INFO - 2017-01-12 12:15:43.512 screenresolution[1653:9788] starting screenresolution argv=screenresolution list 12:15:43 INFO - Available Modes on Display 0 12:15:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:43 INFO - Intel Iris: 12:15:43 INFO - Chipset Model: Intel Iris 12:15:43 INFO - Type: GPU 12:15:43 INFO - Bus: Built-In 12:15:43 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:43 INFO - Vendor: Intel (0x8086) 12:15:43 INFO - Device ID: 0x0a2e 12:15:43 INFO - Revision ID: 0x0009 12:15:43 INFO - Displays: 12:15:43 INFO - Display: 12:15:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:43 INFO - Display Serial Number: 1600x1200 60 12:15:43 INFO - Main Display: Yes 12:15:43 INFO - Mirror: Off 12:15:43 INFO - Online: Yes 12:15:43 INFO - Rotation: Supported 12:15:43 INFO - Return code: 0 12:15:43 INFO - Running post-action listener: _resource_record_post_action 12:15:43 INFO - [mozharness: 2017-01-12 20:15:43.749025Z] Finished run-tests step (success) 12:15:43 INFO - Running post-run listener: _resource_record_post_run 12:15:43 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 39117824; Write bytes: 495478272; Read time: 391; Write time: 1627 12:15:43 INFO - TinderboxPrint: CPU usage
53.1% 12:15:43 INFO - TinderboxPrint: I/O read bytes / time
39,117,824 / 391 12:15:43 INFO - TinderboxPrint: I/O write bytes / time
495,478,272 / 1,627 12:15:43 INFO - TinderboxPrint: CPU idle
2,242.4 (46.9%) 12:15:43 INFO - TinderboxPrint: CPU system
955.4 (20.0%) 12:15:43 INFO - TinderboxPrint: CPU user
1,583.8 (33.1%) 12:15:43 INFO - TinderboxPrint: Swap in / out
234,024,960 / 0 12:15:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194888192; Write bytes: 189978624; Read time: 17790; Write time: 464 12:15:43 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 36946944; Write bytes: 295226880; Read time: 360; Write time: 1123 12:15:44 INFO - Running post-run listener: _upload_blobber_files 12:15:44 INFO - Blob upload gear active. 12:15:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:44 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 12:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:15:44 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:45 INFO - (blobuploader) - INFO - Done attempting. 12:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:46 INFO - (blobuploader) - INFO - Done attempting. 12:15:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:49 INFO - (blobuploader) - INFO - Done attempting. 12:15:49 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:49 INFO - Return code: 0 12:15:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed8dcca732ebb9706bd2bd8a691ce84851924bced378b9f8630fe85f4c697ef9f9b0041cbe8012adc21c4a906b6cfbd3a1ce9fc619dbcebeedd2dcc076c61dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3444bf679c8dfa5730092caf65371d95713f1f4caefad11908393583c8a69e049c7b8dd3e7a6999c1c499ca68ca92df7054302bcebdf82e5a63ec4627cdd29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404a208babb8aae6cb158d721a2b7ca98ff1346e287530458e1a09c2f9135eca7d14830d3f8ec46980401a25b80a52877e7928cb4164a698aa12cb58c59b240d"} 12:15:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:49 INFO - Contents: 12:15:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed8dcca732ebb9706bd2bd8a691ce84851924bced378b9f8630fe85f4c697ef9f9b0041cbe8012adc21c4a906b6cfbd3a1ce9fc619dbcebeedd2dcc076c61dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3444bf679c8dfa5730092caf65371d95713f1f4caefad11908393583c8a69e049c7b8dd3e7a6999c1c499ca68ca92df7054302bcebdf82e5a63ec4627cdd29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404a208babb8aae6cb158d721a2b7ca98ff1346e287530458e1a09c2f9135eca7d14830d3f8ec46980401a25b80a52877e7928cb4164a698aa12cb58c59b240d"} 12:15:49 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:49 INFO - Copying logs to upload dir... 12:15:49 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.647377 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-12 12:15:49.424274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:15:49.428578) ========= 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.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/Mozilla-Beta/sha512/ed8dcca732ebb9706bd2bd8a691ce84851924bced378b9f8630fe85f4c697ef9f9b0041cbe8012adc21c4a906b6cfbd3a1ce9fc619dbcebeedd2dcc076c61dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3444bf679c8dfa5730092caf65371d95713f1f4caefad11908393583c8a69e049c7b8dd3e7a6999c1c499ca68ca92df7054302bcebdf82e5a63ec4627cdd29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404a208babb8aae6cb158d721a2b7ca98ff1346e287530458e1a09c2f9135eca7d14830d3f8ec46980401a25b80a52877e7928cb4164a698aa12cb58c59b240d"} build_url:https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/DrU_fy5QQxGuubXuzbUkYg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed8dcca732ebb9706bd2bd8a691ce84851924bced378b9f8630fe85f4c697ef9f9b0041cbe8012adc21c4a906b6cfbd3a1ce9fc619dbcebeedd2dcc076c61dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3444bf679c8dfa5730092caf65371d95713f1f4caefad11908393583c8a69e049c7b8dd3e7a6999c1c499ca68ca92df7054302bcebdf82e5a63ec4627cdd29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404a208babb8aae6cb158d721a2b7ca98ff1346e287530458e1a09c2f9135eca7d14830d3f8ec46980401a25b80a52877e7928cb4164a698aa12cb58c59b240d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:15:49.469956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:15:49.470566) ========= 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.YBUODni8kA/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.7OSBsmifnH/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.004606 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:15:49.520060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:15:49.520429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:15:49.520867) ========= ========= Total master_lag: 0.20 =========