builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1477735972.72 results: success (0) buildid: 20161029004015 builduid: 9320a8fe4036463a9b063e86b23cff0f revision: 0c44c99f7b57f8827429eb3634c406bfea2115a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:52.721479) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:52.722347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:52.722626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:53.034626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:53.034893) ========= 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.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 --2016-10-29 03:12:53-- 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% 16.2M=0.001s 2016-10-29 03:12:53 (16.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.613201 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:53.695136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:53.695439) ========= 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.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.026916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:53.754040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 03:12:53.754371) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0c44c99f7b57f8827429eb3634c406bfea2115a9 --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-aurora --rev 0c44c99f7b57f8827429eb3634c406bfea2115a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 2016-10-29 03:12:53,831 truncating revision to first 12 chars 2016-10-29 03:12:53,832 Setting DEBUG logging. 2016-10-29 03:12:53,832 attempt 1/10 2016-10-29 03:12:53,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0c44c99f7b57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 03:12:54,827 unpacking tar archive at: mozilla-aurora-0c44c99f7b57/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 03:12:55.052932) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:55.053265) ========= script_repo_revision: 0c44c99f7b57f8827429eb3634c406bfea2115a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:55.053679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:55.054018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 03:12:55.073550) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-29 03:12:55.073852) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:12:55 INFO - MultiFileLogger online at 20161029 03:12:55 in /builds/slave/test 03:12:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:12:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:55 INFO - {'append_to_log': False, 03:12:55 INFO - 'base_work_dir': '/builds/slave/test', 03:12:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:12:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:55 INFO - 'branch': 'Mozilla-Aurora', 03:12:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:55 INFO - 'config_files': ('talos/mac_config.py',), 03:12:55 INFO - 'default_actions': ('clobber', 03:12:55 INFO - 'read-buildbot-config', 03:12:55 INFO - 'download-and-extract', 03:12:55 INFO - 'populate-webroot', 03:12:55 INFO - 'create-virtualenv', 03:12:55 INFO - 'install', 03:12:55 INFO - 'run-tests'), 03:12:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:55 INFO - 'download_minidump_stackwalk': True, 03:12:55 INFO - 'download_symbols': 'ondemand', 03:12:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:55 INFO - 'installer_path': 'installer.exe', 03:12:55 INFO - 'log_level': 'info', 03:12:55 INFO - 'log_name': 'talos', 03:12:55 INFO - 'log_to_console': True, 03:12:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:12:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:12:55 INFO - 'opt_config_files': (), 03:12:55 INFO - 'pip_index': False, 03:12:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:55 INFO - 'cmd': ('bash', 03:12:55 INFO - '-c', 03:12:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:55 INFO - 'enabled': True, 03:12:55 INFO - 'halt_on_failure': False, 03:12:55 INFO - 'name': 'check_screen_resolution'},), 03:12:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:55 INFO - 'cmd': ('bash', 03:12:55 INFO - '-c', 03:12:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:55 INFO - 'enabled': True, 03:12:55 INFO - 'halt_on_failure': False, 03:12:55 INFO - 'name': 'check_screen_resolution'},), 03:12:55 INFO - 'run_cmd_checks_enabled': True, 03:12:55 INFO - 'sps_profile': False, 03:12:55 INFO - 'sps_profile_interval': 0, 03:12:55 INFO - 'suite': 'dromaeojs', 03:12:55 INFO - 'system_bits': '32', 03:12:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:55 INFO - 'title': 't-yosemite-r7-0146', 03:12:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:55 INFO - 'use_talos_json': True, 03:12:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:55 INFO - 'work_dir': 'build'} 03:12:55 INFO - [mozharness: 2016-10-29 10:12:55.285157Z] Running clobber step. 03:12:55 INFO - Running pre-action listener: _resource_record_pre_action 03:12:55 INFO - Running main action method: clobber 03:12:55 INFO - rmtree: /builds/slave/test/build 03:12:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:57 INFO - Running post-action listener: _resource_record_post_action 03:12:57 INFO - [mozharness: 2016-10-29 10:12:57.594228Z] Finished clobber step (success) 03:12:57 INFO - [mozharness: 2016-10-29 10:12:57.594356Z] Running read-buildbot-config step. 03:12:57 INFO - Running pre-action listener: _resource_record_pre_action 03:12:57 INFO - Running main action method: read_buildbot_config 03:12:57 INFO - Using buildbot properties: 03:12:57 INFO - { 03:12:57 INFO - "project": "", 03:12:57 INFO - "product": "firefox", 03:12:57 INFO - "script_repo_revision": "production", 03:12:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:12:57 INFO - "repository": "", 03:12:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:12:57 INFO - "buildid": "20161029004015", 03:12:57 INFO - "stage_platform": "macosx64", 03:12:57 INFO - "basedir": "/builds/slave/test", 03:12:57 INFO - "nightly_build": "True", 03:12:57 INFO - "buildnumber": 78, 03:12:57 INFO - "slavename": "t-yosemite-r7-0146", 03:12:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:12:57 INFO - "platform": "yosemite_r7", 03:12:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:12:57 INFO - "branch": "mozilla-aurora", 03:12:57 INFO - "repo_path": "releases/mozilla-aurora", 03:12:57 INFO - "revision": "0c44c99f7b57f8827429eb3634c406bfea2115a9", 03:12:57 INFO - "pgo_build": "False", 03:12:57 INFO - "builduid": "9320a8fe4036463a9b063e86b23cff0f", 03:12:57 INFO - "slavebuilddir": "test" 03:12:57 INFO - } 03:12:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:12:57 INFO - Running post-action listener: _resource_record_post_action 03:12:57 INFO - [mozharness: 2016-10-29 10:12:57.597794Z] Finished read-buildbot-config step (success) 03:12:57 INFO - [mozharness: 2016-10-29 10:12:57.597907Z] Running download-and-extract step. 03:12:57 INFO - Running pre-action listener: _resource_record_pre_action 03:12:57 INFO - Running main action method: download_and_extract 03:12:57 INFO - mkdir: /builds/slave/test/build/tests 03:12:57 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')]} 03:12:57 INFO - trying https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:12:57 INFO - Downloading https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:12:58 INFO - Downloaded 1199 bytes. 03:12:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:12:58 INFO - Using the following test package requirements: 03:12:58 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:12:58 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:12:58 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:12:58 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'jsshell-mac.zip'], 03:12:58 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:12:58 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:12:58 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:12:58 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:12:58 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:12:58 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:12:58 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:12:58 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:12:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:12:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:12:58 INFO - Fetch https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:12:59 INFO - Expected file size: 16421126 03:13:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:13:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:13:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:13:06 INFO - Fetch https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:13:06 INFO - Expected file size: 16421126 03:13:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:13:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:13:13 INFO - Fetch https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:13:13 INFO - Expected file size: 14414081 03:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:15 INFO - trying https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:13:15 INFO - Downloading https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:13:18 INFO - Downloaded 115540845 bytes. 03:13:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:13:18 INFO - mkdir: /builds/slave/test/properties 03:13:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:13:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:13:18 INFO - Contents: 03:13:18 INFO - build_url:https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:13:19 INFO - Running post-action listener: _resource_record_post_action 03:13:19 INFO - Running post-action listener: set_extra_try_arguments 03:13:19 INFO - [mozharness: 2016-10-29 10:13:19.355625Z] Finished download-and-extract step (success) 03:13:19 INFO - [mozharness: 2016-10-29 10:13:19.355743Z] Running populate-webroot step. 03:13:19 INFO - Running pre-action listener: _resource_record_pre_action 03:13:19 INFO - Running main action method: populate_webroot 03:13:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:13:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:13:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:13:19 INFO - '--tppagecycles', 03:13:19 INFO - '7'], 03:13:19 INFO - 'tests': ['tsvgm']}}, 03:13:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:13:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:13:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:13:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:13:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['damp', 'tps']}, 03:13:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'tests': ['damp', 'tps']}, 03:13:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['dromaeo_dom']}, 03:13:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['basic_compositor_video']}, 03:13:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:13:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'other-e10s': {'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['a11yr', 03:13:19 INFO - 'ts_paint', 03:13:19 INFO - 'tpaint', 03:13:19 INFO - 'sessionrestore', 03:13:19 INFO - 'sessionrestore_no_auto_restore', 03:13:19 INFO - 'tabpaint']}, 03:13:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['tsvgx', 03:13:19 INFO - 'tsvgr_opacity', 03:13:19 INFO - 'tart', 03:13:19 INFO - 'tscrollx', 03:13:19 INFO - 'cart']}, 03:13:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:13:19 INFO - 'tsvgr_opacity', 03:13:19 INFO - 'tart', 03:13:19 INFO - 'tscrollx', 03:13:19 INFO - 'cart']}, 03:13:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'talos_options': ['--disable-e10s'], 03:13:19 INFO - 'tests': ['tp5o']}, 03:13:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'tests': ['tp5o']}, 03:13:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'talos_options': ['--disable-e10s', 03:13:19 INFO - '--xperf_path', 03:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:19 INFO - 'tests': ['tp5n']}, 03:13:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:19 INFO - 'talos_options': ['--xperf_path', 03:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:19 INFO - 'tests': ['tp5n']}}, 03:13:19 INFO - 'talos.zip': {'path': '', 03:13:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:13:19 INFO - Running post-action listener: _resource_record_post_action 03:13:19 INFO - [mozharness: 2016-10-29 10:13:19.374532Z] Finished populate-webroot step (success) 03:13:19 INFO - [mozharness: 2016-10-29 10:13:19.374639Z] Running create-virtualenv step. 03:13:19 INFO - Running pre-action listener: _resource_record_pre_action 03:13:19 INFO - Running main action method: create_virtualenv 03:13:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:13:19 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 03:13:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:13:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:19 INFO - Using real prefix '/tools/python27' 03:13:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:13:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:23 INFO - Installing pip.................done. 03:13:23 INFO - Return code: 0 03:13:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:23 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 03:13:23 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 03:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:23 INFO - 'HOME': '/Users/cltbld', 03:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:23 INFO - 'LOGNAME': 'cltbld', 03:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:23 INFO - 'MOZ_NO_REMOTE': '1', 03:13:23 INFO - 'NO_EM_RESTART': '1', 03:13:23 INFO - 'PAGER': '/bin/cat', 03:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:23 INFO - 'PWD': '/builds/slave/test', 03:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:23 INFO - 'SHELL': '/bin/bash', 03:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:23 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:23 INFO - 'USER': 'cltbld', 03:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:23 INFO - 'XPC_FLAGS': '0x0', 03:13:23 INFO - 'XPC_SERVICE_NAME': '0', 03:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:23 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 03:13:23 INFO - Cleaning up... 03:13:23 INFO - Return code: 0 03:13:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:23 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 03:13:23 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 03:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:23 INFO - 'HOME': '/Users/cltbld', 03:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:23 INFO - 'LOGNAME': 'cltbld', 03:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:23 INFO - 'MOZ_NO_REMOTE': '1', 03:13:23 INFO - 'NO_EM_RESTART': '1', 03:13:23 INFO - 'PAGER': '/bin/cat', 03:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:23 INFO - 'PWD': '/builds/slave/test', 03:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:23 INFO - 'SHELL': '/bin/bash', 03:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:23 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:23 INFO - 'USER': 'cltbld', 03:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:23 INFO - 'XPC_FLAGS': '0x0', 03:13:23 INFO - 'XPC_SERVICE_NAME': '0', 03:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:23 INFO - Downloading/unpacking psutil>=3.1.1 03:13:23 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 03:13:23 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 03:13:23 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 03:13:23 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 03:13:23 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 03:13:23 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 03:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:27 INFO - Installing collected packages: psutil 03:13:27 INFO - Running setup.py install for psutil 03:13:27 INFO - building 'psutil._psutil_osx' extension 03:13:27 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 03:13:28 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 03:13:28 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 03:13:28 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 03:13:28 INFO - building 'psutil._psutil_posix' extension 03:13:28 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 03:13:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:13:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:13:28 INFO - ^ 03:13:28 INFO - 1 warning generated. 03:13:28 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 03:13:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:28 INFO - Successfully installed psutil 03:13:28 INFO - Cleaning up... 03:13:28 INFO - Return code: 0 03:13:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:13:28 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')]} 03:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:28 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')]} 03:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:28 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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:28 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 03:13:28 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 03:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:28 INFO - 'HOME': '/Users/cltbld', 03:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:28 INFO - 'LOGNAME': 'cltbld', 03:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:28 INFO - 'MOZ_NO_REMOTE': '1', 03:13:28 INFO - 'NO_EM_RESTART': '1', 03:13:28 INFO - 'PAGER': '/bin/cat', 03:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:28 INFO - 'PWD': '/builds/slave/test', 03:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:28 INFO - 'SHELL': '/bin/bash', 03:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:28 INFO - 'USER': 'cltbld', 03:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:28 INFO - 'XPC_FLAGS': '0x0', 03:13:28 INFO - 'XPC_SERVICE_NAME': '0', 03:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:13:29 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 03:13:29 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 03:13:29 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 03:13:29 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 03:13:29 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 03:13:29 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 03:13:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:13:31 INFO - Installing collected packages: mozsystemmonitor 03:13:31 INFO - Running setup.py install for mozsystemmonitor 03:13:31 INFO - Successfully installed mozsystemmonitor 03:13:31 INFO - Cleaning up... 03:13:31 INFO - Return code: 0 03:13:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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', '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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:13: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 jsonschema==2.5.1 03:13:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:31 INFO - 'HOME': '/Users/cltbld', 03:13:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:31 INFO - 'LOGNAME': 'cltbld', 03:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:31 INFO - 'MOZ_NO_REMOTE': '1', 03:13:31 INFO - 'NO_EM_RESTART': '1', 03:13:31 INFO - 'PAGER': '/bin/cat', 03:13:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:31 INFO - 'PWD': '/builds/slave/test', 03:13:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:31 INFO - 'SHELL': '/bin/bash', 03:13:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:31 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:31 INFO - 'USER': 'cltbld', 03:13:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:31 INFO - 'XPC_FLAGS': '0x0', 03:13:31 INFO - 'XPC_SERVICE_NAME': '0', 03:13:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:13:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:13:35 INFO - warning: no files found matching '*.txt' 03:13:35 INFO - no previously-included directories found matching 'build' 03:13:35 INFO - no previously-included directories found matching 'dist' 03:13:35 INFO - no previously-included directories found matching '.git*' 03:13:35 INFO - Installing collected packages: jsonschema, functools32 03:13:35 INFO - Running setup.py install for functools32 03:13:35 INFO - warning: no files found matching '*.txt' 03:13:35 INFO - no previously-included directories found matching 'build' 03:13:35 INFO - no previously-included directories found matching 'dist' 03:13:35 INFO - no previously-included directories found matching '.git*' 03:13:35 INFO - Successfully installed jsonschema functools32 03:13:35 INFO - Cleaning up... 03:13:35 INFO - Return code: 0 03:13:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:35 INFO - 'HOME': '/Users/cltbld', 03:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:35 INFO - 'LOGNAME': 'cltbld', 03:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:35 INFO - 'MOZ_NO_REMOTE': '1', 03:13:35 INFO - 'NO_EM_RESTART': '1', 03:13:35 INFO - 'PAGER': '/bin/cat', 03:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:35 INFO - 'PWD': '/builds/slave/test', 03:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:35 INFO - 'SHELL': '/bin/bash', 03:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:35 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:35 INFO - 'USER': 'cltbld', 03:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:35 INFO - 'XPC_FLAGS': '0x0', 03:13:35 INFO - 'XPC_SERVICE_NAME': '0', 03:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:13:35 INFO - Cleaning up... 03:13:35 INFO - Return code: 0 03:13:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:35 INFO - 'HOME': '/Users/cltbld', 03:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:35 INFO - 'LOGNAME': 'cltbld', 03:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:35 INFO - 'MOZ_NO_REMOTE': '1', 03:13:35 INFO - 'NO_EM_RESTART': '1', 03:13:35 INFO - 'PAGER': '/bin/cat', 03:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:35 INFO - 'PWD': '/builds/slave/test', 03:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:35 INFO - 'SHELL': '/bin/bash', 03:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:35 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:35 INFO - 'USER': 'cltbld', 03:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:35 INFO - 'XPC_FLAGS': '0x0', 03:13:35 INFO - 'XPC_SERVICE_NAME': '0', 03:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13:38 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 03:13:38 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 03:13:38 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 03:13:38 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 03:13:38 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 03:13:38 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 03:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:39 INFO - Downloading docopt-0.6.1.tar.gz 03:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:39 INFO - Running setup.py install for blobuploader 03:13:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:39 INFO - Running setup.py install for requests 03:13:40 INFO - Running setup.py install for docopt 03:13:40 INFO - Successfully installed blobuploader requests docopt 03:13:40 INFO - Cleaning up... 03:13:40 INFO - Return code: 0 03:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:40 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')]} 03:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:40 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')]} 03:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:40 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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:40 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 03:13:40 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 03:13:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:40 INFO - 'HOME': '/Users/cltbld', 03:13:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:40 INFO - 'LOGNAME': 'cltbld', 03:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:40 INFO - 'MOZ_NO_REMOTE': '1', 03:13:40 INFO - 'NO_EM_RESTART': '1', 03:13:40 INFO - 'PAGER': '/bin/cat', 03:13:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:40 INFO - 'PWD': '/builds/slave/test', 03:13:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:40 INFO - 'SHELL': '/bin/bash', 03:13:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:40 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:40 INFO - 'USER': 'cltbld', 03:13:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:40 INFO - 'XPC_FLAGS': '0x0', 03:13:40 INFO - 'XPC_SERVICE_NAME': '0', 03:13:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:40 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-TXMyVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ONp2UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-IGq7qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NAJqoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-rPPuZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qJSrRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-JgS8gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-EXjwL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-fdReii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NOneny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:41 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-7mqfvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NyRdLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-tNo6q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-rjLCwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5Ygu7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-IrGZ_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:42 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-uLukrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:42 INFO - Running setup.py install for manifestparser 03:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:42 INFO - Running setup.py install for mozcrash 03:13:43 INFO - Running setup.py install for mozdebug 03:13:43 INFO - Running setup.py install for mozdevice 03:13:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Running setup.py install for mozfile 03:13:43 INFO - Running setup.py install for mozhttpd 03:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Running setup.py install for mozinfo 03:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Running setup.py install for mozInstall 03:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:43 INFO - Running setup.py install for mozleak 03:13:44 INFO - Running setup.py install for mozlog 03:13:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Running setup.py install for moznetwork 03:13:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Running setup.py install for mozprocess 03:13:44 INFO - Running setup.py install for mozprofile 03:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Running setup.py install for mozrunner 03:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:44 INFO - Running setup.py install for mozscreenshot 03:13:45 INFO - Running setup.py install for moztest 03:13:45 INFO - Running setup.py install for mozversion 03:13:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:45 INFO - Cleaning up... 03:13:45 INFO - Return code: 0 03:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:45 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')]} 03:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:45 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')]} 03:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:45 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 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:45 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 03:13:45 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 03:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:45 INFO - 'HOME': '/Users/cltbld', 03:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:45 INFO - 'LOGNAME': 'cltbld', 03:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:45 INFO - 'MOZ_NO_REMOTE': '1', 03:13:45 INFO - 'NO_EM_RESTART': '1', 03:13:45 INFO - 'PAGER': '/bin/cat', 03:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:45 INFO - 'PWD': '/builds/slave/test', 03:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:45 INFO - 'SHELL': '/bin/bash', 03:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:45 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:45 INFO - 'USER': 'cltbld', 03:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:45 INFO - 'XPC_FLAGS': '0x0', 03:13:45 INFO - 'XPC_SERVICE_NAME': '0', 03:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ILReOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:45 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)) 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-bzuoQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:45 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)) 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-RcVBsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:45 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)) 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:45 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-v73AmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wxwJyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-sPw2NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-QSRGwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-eOJlsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-hiBC4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-zSDbBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-vdwzEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wIEK43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:46 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)) 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wufBQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:46 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)) 03:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-HOtlf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:47 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)) 03:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-6HDWFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-_hqjVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:47 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)) 03:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-FCLbzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:47 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)) 03:13:47 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)) 03:13:47 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)) 03:13:47 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)) 03:13:47 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)) 03:13:47 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)) 03:13:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:47 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 03:13:47 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 03:13:47 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 03:13:47 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 03:13:47 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 03:13:47 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 03:13:49 INFO - Downloading blessings-1.6.tar.gz 03:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:50 INFO - Installing collected packages: blessings 03:13:50 INFO - Running setup.py install for blessings 03:13:50 INFO - Successfully installed blessings 03:13:50 INFO - Cleaning up... 03:13:50 INFO - Return code: 0 03:13:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:50 INFO - Reading from file tmpfile_stdout 03:13:50 INFO - Current package versions: 03:13:50 INFO - blessings == 1.6 03:13:50 INFO - blobuploader == 1.2.4 03:13:50 INFO - docopt == 0.6.1 03:13:50 INFO - functools32 == 3.2.3-2 03:13:50 INFO - jsonschema == 2.5.1 03:13:50 INFO - manifestparser == 1.1 03:13:50 INFO - mozInstall == 1.12 03:13:50 INFO - mozcrash == 0.17 03:13:50 INFO - mozdebug == 0.1 03:13:50 INFO - mozdevice == 0.48 03:13:50 INFO - mozfile == 1.2 03:13:50 INFO - mozhttpd == 0.7 03:13:50 INFO - mozinfo == 0.9 03:13:50 INFO - mozleak == 0.1 03:13:50 INFO - mozlog == 3.4 03:13:50 INFO - moznetwork == 0.27 03:13:50 INFO - mozprocess == 0.23 03:13:50 INFO - mozprofile == 0.28 03:13:50 INFO - mozrunner == 6.12 03:13:50 INFO - mozscreenshot == 0.1 03:13:50 INFO - mozsystemmonitor == 0.3 03:13:50 INFO - moztest == 0.7 03:13:50 INFO - mozversion == 1.4 03:13:50 INFO - psutil == 3.1.1 03:13:50 INFO - requests == 1.2.3 03:13:50 INFO - wsgiref == 0.1.2 03:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:50 INFO - 'HOME': '/Users/cltbld', 03:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:50 INFO - 'LOGNAME': 'cltbld', 03:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:50 INFO - 'MOZ_NO_REMOTE': '1', 03:13:50 INFO - 'NO_EM_RESTART': '1', 03:13:50 INFO - 'PAGER': '/bin/cat', 03:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:50 INFO - 'PWD': '/builds/slave/test', 03:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:50 INFO - 'SHELL': '/bin/bash', 03:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:50 INFO - 'USER': 'cltbld', 03:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:50 INFO - 'XPC_FLAGS': '0x0', 03:13:50 INFO - 'XPC_SERVICE_NAME': '0', 03:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:50 INFO - Cleaning up... 03:13:50 INFO - Return code: 0 03:13:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e3e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e357570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe48d9d190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, '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.GXEoWt6LVw/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.hanZympsAy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:50 INFO - 'HOME': '/Users/cltbld', 03:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:50 INFO - 'LOGNAME': 'cltbld', 03:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:50 INFO - 'MOZ_NO_REMOTE': '1', 03:13:50 INFO - 'NO_EM_RESTART': '1', 03:13:50 INFO - 'PAGER': '/bin/cat', 03:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:50 INFO - 'PWD': '/builds/slave/test', 03:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:50 INFO - 'SHELL': '/bin/bash', 03:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:13:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:50 INFO - 'USER': 'cltbld', 03:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:50 INFO - 'XPC_FLAGS': '0x0', 03:13:50 INFO - 'XPC_SERVICE_NAME': '0', 03:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:51 INFO - Cleaning up... 03:13:51 INFO - Return code: 0 03:13:51 INFO - Running post-action listener: _resource_record_post_action 03:13:51 INFO - Running post-action listener: _start_resource_monitoring 03:13:51 INFO - Starting resource monitoring. 03:13:51 INFO - [mozharness: 2016-10-29 10:13:51.161102Z] Finished create-virtualenv step (success) 03:13:51 INFO - [mozharness: 2016-10-29 10:13:51.162126Z] Running install step. 03:13:51 INFO - Running pre-action listener: _resource_record_pre_action 03:13:51 INFO - Running main action method: install 03:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:51 INFO - Reading from file tmpfile_stdout 03:13:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:51 INFO - Reading from file tmpfile_stdout 03:13:51 INFO - Output received: 03:13:51 INFO - Usage: mozinstall [options] installer 03:13:51 INFO - Options: 03:13:51 INFO - -h, --help show this help message and exit 03:13:51 INFO - -d DEST, --destination=DEST 03:13:51 INFO - Directory to install application into. [default: 03:13:51 INFO - "/builds/slave/test"] 03:13:51 INFO - --app=APP Application being installed. [default: firefox] 03:13:51 INFO - mkdir: /builds/slave/test/build/application 03:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:14:23 INFO - Reading from file tmpfile_stdout 03:14:23 INFO - Output received: 03:14:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:14:23 INFO - Running post-action listener: _resource_record_post_action 03:14:23 INFO - [mozharness: 2016-10-29 10:14:23.965607Z] Finished install step (success) 03:14:23 INFO - [mozharness: 2016-10-29 10:14:23.965751Z] Running run-tests step. 03:14:23 INFO - Running pre-action listener: _resource_record_pre_action 03:14:23 INFO - Running main action method: run_tests 03:14:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:14:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:14:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:14:23 INFO - 2016-10-29 03:14:23.979 screenresolution[1648:9324] starting screenresolution argv=screenresolution get 03:14:23 INFO - 2016-10-29 03:14:23.981 screenresolution[1648:9324] Display 0: 1600x1200x32@60 03:14:23 INFO - 2016-10-29 03:14:23.987 screenresolution[1649:9326] starting screenresolution argv=screenresolution list 03:14:23 INFO - Available Modes on Display 0 03:14:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:14:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:14:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:14:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:14:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:14:24 INFO - Intel Iris: 03:14:24 INFO - Chipset Model: Intel Iris 03:14:24 INFO - Type: GPU 03:14:24 INFO - Bus: Built-In 03:14:24 INFO - VRAM (Dynamic, Max): 1536 MB 03:14:24 INFO - Vendor: Intel (0x8086) 03:14:24 INFO - Device ID: 0x0a2e 03:14:24 INFO - Revision ID: 0x0009 03:14:24 INFO - Displays: 03:14:24 INFO - Display: 03:14:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:14:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:14:24 INFO - Display Serial Number: 1600x1200 60 03:14:24 INFO - Main Display: Yes 03:14:24 INFO - Mirror: Off 03:14:24 INFO - Online: Yes 03:14:24 INFO - Rotation: Supported 03:14:24 INFO - Return code: 0 03:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:14:24 INFO - Python 2.7.3 03:14:24 INFO - Return code: 0 03:14:24 INFO - grabbing minidump binary from tooltool 03:14: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')]} 03:14:24 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 0x10e1f5d30>, '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 0x10e05bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:14:24 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 03:14:24 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 03:14:24 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 03:14:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:14:24 INFO - Return code: 0 03:14:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:14:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:14:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:14:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:14:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 03:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 03:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GXEoWt6LVw/Render', 03:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:24 INFO - 'HOME': '/Users/cltbld', 03:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:24 INFO - 'LOGNAME': 'cltbld', 03:14:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:14:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:24 INFO - 'MOZ_NO_REMOTE': '1', 03:14:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:14:24 INFO - 'NO_EM_RESTART': '1', 03:14:24 INFO - 'PAGER': '/bin/cat', 03:14:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:24 INFO - 'PWD': '/builds/slave/test', 03:14:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:24 INFO - 'SHELL': '/bin/bash', 03:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hanZympsAy/Listeners', 03:14:24 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:24 INFO - 'USER': 'cltbld', 03:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:24 INFO - 'XPC_FLAGS': '0x0', 03:14:24 INFO - 'XPC_SERVICE_NAME': '0', 03:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 03:14:24 INFO - mozversion application_buildid: 20161029004015 03:14:24 INFO - mozversion application_changeset: 0c44c99f7b57f8827429eb3634c406bfea2115a9 03:14:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:14:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:14:24 INFO - mozversion application_name: Firefox 03:14:24 INFO - mozversion application_remotingname: firefox-dev 03:14:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:24 INFO - mozversion application_vendor: Mozilla 03:14:24 INFO - mozversion application_version: 51.0a2 03:14:24 INFO - mozversion platform_buildid: 20161029004015 03:14:24 INFO - mozversion platform_changeset: 0c44c99f7b57f8827429eb3634c406bfea2115a9 03:14:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:14:24 INFO - mozversion platform_version: 51.0a2 03:14:24 INFO - using testdate: 1477736064 03:14:24 INFO - actual date: 1477736064 03:14:24 INFO - starting webserver on 'localhost:49279' 03:14:24 INFO - SUITE-START | Running 2 tests 03:14:24 INFO - TEST-START | dromaeo_css 03:14:24 INFO - operating with platform_type : mac_ 03:14:24 INFO - Initialising browser for dromaeo_css test... 03:14:24 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpLIVXll/profile http://localhost:49279/getInfo.html) 03:14:27 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:14:27 INFO - PROCESS | 1659 | colorDepth:24 03:14:27 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:14:27 INFO - PROCESS | 1659 | __metrics 03:14:27 INFO - PROCESS | 1659 | 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" 03:14:27 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:14:28 INFO - TEST-INFO | 1659: exit 0 03:14:28 INFO - Browser initialized. 03:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:14:28 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpLIVXll/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:40 INFO - PROCESS | 1663 | RSS: Main: 220147712 03:14:40 INFO - PROCESS | 1663 | 03:15:31 INFO - PROCESS | 1663 | 1477736131214 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] 03:17:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 03:17:44 INFO - PROCESS | 1663 | RSS: Main: 377397248 03:17:44 INFO - PROCESS | 1663 | 03:20:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:20:48 INFO - PROCESS | 1663 | RSS: Main: 350982144 03:20:48 INFO - PROCESS | 1663 | 03:23:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:23:51 INFO - PROCESS | 1663 | RSS: Main: 340365312 03:23:51 INFO - PROCESS | 1663 | 03:26:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:26:54 INFO - PROCESS | 1663 | RSS: Main: 313786368 03:26:54 INFO - PROCESS | 1663 | 03:29:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:29:58 INFO - PROCESS | 1663 | RSS: Main: 310910976 03:29:58 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:33:01 INFO - PROCESS | 1663 | RSS: Main: 505876480 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | __start_tp_report 03:33:01 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 03:33:01 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 03:33:01 INFO - PROCESS | 1663 | |i|pagename|runs| 03:33:01 INFO - PROCESS | 1663 | |0;dojo.html;3283.2120291130127;3300.3234336960927;3309.1892486340844;3317.9216754554777;3360.680735330143;4683.2975053741875;5637.041702910505;5728.42715728427;5728.541716662668;5742.28221472316;5592.720363981805;5684.829455116343;5690.5447564194765;5703.629264097841;5728.742206600703;5130.9994551062555;5167.4574169712205;5171.327727395434;5218.112920803454;5220.843374698765;4456.108778244348;5129.384473863123;5241.475852414766;5279.128943724281;5303.018941495836;5018.723970181639;5173.637845350808;5178.430372659023;5232.2674825524455;5243.318368612094;5220.582353411737;5247.895042099175;5248.107821670325;5293.86765330866;5296.496832800878;4324.935125973113;5138.820141295074;5211.400688920785;5220.660657057279;5273.604479664003;5500.22996780451;5509.531689806371;5547.195656629807;5554.222408862763;5621.213030175779;6163.691815409212;6173.47525460332;6180.227471566054;6220.782272620482;6231.065340198961;6208.844778880519;6246.05584182621;6267.62394256346;6282.717277722513;6292.276388215368;5636.971815140898;5678.5741069419955;5695.373508914057;5710.8001219957105;5742.569307301969;6245.75016999324;6267.874642507216;6282.968585157137;6283.403076707706;6292.937070629327;5936.990711579042;6128.846778830565;6137.1101190328045;6139.662318572432;6147.938520614826;6117.571769976059;6124.289394097934;6156.938430615726;6174.043023331391;6203.069539569011;6151.569390142647;6165.198524191826;6177.598456100339;6179.969100154471;6186.690665466709;6125.724342404603;6195.783147589813;6203.16257305267;6205.720742566596;6209.410106039919;4826.638002149853;4856.73287969158;4867.902641947141;4877.878053048631;4890.24201248807;4384.276594361894;4384.714993525411;4401.471823381151;4465.0400163964905;4465.866024019285;5719.828405147852;5728.828135155952;5730.598858079978;5731.799387021434;5770.88458230833;6062.090686397076;6166.938330616636;6282.277538083179;6283.931731605638;6285.59143655661;5592.2730045094695;5646.2942132233475;5663.433656634304;5668.348139963957;5735.77056917727;5358.062339090644;5370.543503802142;5392.649477783932;5398.298221231294;5410;6236.03341482071;6260.248770147611;6263.467605253604;6264.561480696308;6275.623462592259;5968;6136.2943261523715;6143.293521245114;6188.44304012623;6255.874882502416;6196;6278.529110316836;6281.497480201481;6284.528660350584;6291;5915.053591425351;5919.348871624204;5921.3782552831335;5924.002010160328;5961.254843144607;5965.403459654;6095.359987201457;6098.481629061402;6117.724702388314;6142.836439233709;6031.396860314109;6056.878862422815;6110.266767987692;6144.910730351702;6149.200603921461;6052.303985041601;6056.454919057306;6067.393260673897;6082;6094.2077529920825;4972.5276098770555;5761.193432919478;5866.413358664099;5882.088276317178;5927.081302398135;5982.641041537521;5998.34018258;6060.606060606046;6086.482648974709;6120.081455037999;5900.763969441346;5902.793402231073;5909.970450147894;5935.9703201485445;5941.673207973603 03:33:01 INFO - PROCESS | 1663 | |1;ext.html;467.6329081670888;491.5575981616545;501.6388200495643;502.10875695640254;527.0065925730003;29675.851620741894;30180.54729179061;30205.24486887829;30284.394312113745;31488.84255578719;41156.76529704106;42560.787196064055;42570.78714606431;45278;45340;9663.613455461791;9824.852627210597;9833.01669833018;9836.557354919047;9867.950660246688;8792.648294068262;9747;9853.556589953434;9862.30963832532;9879.110880020797;8735.301175905945;10910.5090270938;12022.819657705142;12075.939620301886;12443.942264907493;12090.51637934486;12159.939200303941;12160;12166.087543434278;12178.26930384171;8674.956625216833;8919.643214271486;11913;12013.759724805543;12025.037996960222;38915.221695566215;39238;39279.25045246834;41865.95335116616;42020.57979420197;3110.5178697301953;3275.4759238521724;3525.5416795816636;3697.9445308320396;3935.9016024599327;29972.8501357494;30246.24384390386;30332.8483357584;31815.681843181505;32092.03723888287;2646.4045589742345;3162.57305263791;3270.656581058978;3303.636599974001;3335.483000134983;504088.91822163353;508522.9999999963;509101.54492275236;509209;509505;52160.73919630377;52681.83908965474;56143;59887;60694.393056069755;63522.364776352566;63793;63840.68079659665;63938.6803065991;64009.35990640034;15918.9204053979;16113.033218006956;16131.354745810271;16132.354705811871;16158.353665853469;12253.081018923616;12342.938285308515;12381.071419643562;12382.442790074469;12543.623691289276;15845;16100.838991609933;16145.273462694207;18428.355007574937;18747.90626046861;6648.368405001517;7798.22017798227;7878.085108509774;7972.720954766555;7984.720534781255;878.3500209844669;938.1369140390857;959.6593209410698;1014.9441780702132;1051.9263651544472;29376.559351609743;29957;30030.399392012037;30101.645425955885;30287.545686814716;1040.2614143957874;1079.4279032112993;1085.148158695436;1085.9294145880492;1143.2054721968152;14654.780178297335;15500.30248638814;15538.912276140787;15577.221138943007;15684.529464116094;699595;708534;709002;709059;710174;56950.14574781382;57473;57559.71220143873;57636;57813.71093144507;1337.7190789934027;1355.335885416139;1379.6895698467765;1385.591250581081;1388.0977364712815;29090.12729618115;29462.705372945995;29814.254643633216;30377;30602.387952241275;48541.75729121332;54284.728576358444;55836.72081639566;56070;59230;612472;616905;616934;618433;618989;42825.14349712926;42889;43143.56856431521;43404;43475.130497390506;45948;47506;47719;47773.76113119412;47875.52124478711;38240.2351952965;38601.80699096486;39321.60678393294;40606.593934061464;40813;38062.61937380591;39089.609103908595;39193.2161356777;39899.800500997306;40410.79794601008;38003.239935201695;38008.04979875525;39011.634592789116;39205.41191882067;40601.59398405978;31924.6807531931;34687.47968780521;34769;35256.471152932216;35278.82360588283;25695.843687033754;25740.742592573835;25773.871130644977;26207;26289.342766430993 03:33:01 INFO - PROCESS | 1663 | |2;jquery.html;354.5851353915918;368.08897977505677;376.89635350278655;386.7447484660124;403.70932928291637;14980;15553.300101495432;16885.49343519695;20376.083076261566;21083.57832843342;11541.596044138458;14866.776998345034;19759.70360444591;20356.083976221067;20594.691079633816;4917.557419832206;5617.297837770278;5618.5786066045;5621.915671264914;5627.352854421753;5497.285352904117;5694.6867922264255;6153.969230153843;6207.720652570622;6226.968865155691;6178.227721534809;6183.752649893999;6184.319724830265;6197.442230199281;6198.535109866755;5900.409959004087;6109.725062372204;6168.0439531872635;6177.1969643945995;6180.690965451732;5212.192110222922;5326.387465441485;5443.455654434564;5455.618106732531;5464.23500709901;24994.625080623806;25751.484970300677;25844.870775646188;25991.480170396677;26128.86935565329;2181.1711549611205;2236.4185311818883;2259.9209027684115;2265.3770213191337;2410.7830295273334;9833.655822046194;10295.073443390056;10454.163666906628;10518.737031574195;10570.52432640533;1850.9814901850943;1938.079412279156;1940.3790786948182;1968.2734947767378;2013.3758534854242;84245;90175;110543;126289;134580;11556.364399957914;11667.066634669207;11669.76660466803;11792.115591330685;11809.704757381134;11751.529938802523;12290;14854.554363369116;14926.850731492763;15060.698786024219;7915.722949696733;8072.233137851895;8165.265126138676;8176.795580110426;8193.631286591999;8415.368847336475;8419.95790021046;8455.915440845512;8579.957100214458;8598.484090954438;3265.42855000374;3844.75009124406;3855.575886652466;3877.3990031545154;3996.6003399659803;1891.8581106417073;1962.1170473286793;1963.6661767499559;1972.5265936175215;1983.335582579823;838.5513750143766;892.0375174615871;902.386377263454;949.6913503111379;957.411192116857;20094.69857952132;20970.475738106365;21038;21140.78859211419;21178.046987885584;938.9953050234706;940.9388389754644;964.9758756031156;966.0532677975623;993.3692105513052;9991.550380232908;10326.173906087495;10362.844557331646;11047.005769480786;11084.612038578773;579032;579261;592065;592162;598113;107783;110212;131362;134167;137742;916.326500022483;916.3356566489375;953.6566835939057;954.88063992001;956.8803899512561;16821.495355139366;17196.31214751396;18432.447026589223;18772;18919.337823176123;54278.18582721183;54860.107874648624;54874.95577734825;55218;55419.3266113794;77759.61120194363;79942.80085798835;80637;82019.94950126295;83697.30421566383;7611.543307401574;7740.806479838049;7931.2068793120225;8103.529036565928;8144.674213031412;8958.776030599287;12056;12058.095642826647;12201;12458.252504849737;9449.724287221137;9679.564419600994;10577.206709496972;10591.83489816135;10922.399268040333;10383;10467.319624224401;10514.684559463229;10545.736356591147;10682.62610808618;9590;9685.6610018649;10644.89355106439;10659.4137322448;10694.304870183412;7018.368346848808;7203.279672032755;7302.525335853153;7494.70021199146;7612.885806713015;9102.225066112045;11200.063966097981;11358.318500889973;11392.772144557228;11493.48279327449 03:33:01 INFO - PROCESS | 1663 | |3;mootools.html;1358.5924222733177;1529.1283968138162;1692.2300353339233;1817.4275103342454;1875.7655293088355;7035.5075144739885;7663.271989161035;7901.249381308781;8246.051704054036;8267.958660206697;7844.843103137934;8120.593970301491;8292.460990035659;8305.086440491541;8563.571821408921;2371.5138396628695;2393.7845593896545;2402.3633737059695;2409.3976505873534;2413.3845869303304;2092.163134746106;2359.7286312074075;2380.1550449590404;2401.0995876546294;2401.6997875265592;2099.0449345547813;2300.7354154272307;2372.7508611595795;2379.7858192762646;2380.95238095238;1993.4119434766778;2343.6367363058753;2364.810815134785;2366.7751563601514;2374.6319320505263;2352.3295860679796;2359.3629719975684;2359.457324815302;2360.2565191964477;2367.2188177901253;8401.41190116692;8653.524056176908;8668.739937801876;8707.172818582225;8722.651093956234;5120.539151476348;5282.656627319212;5316.867078323035;5318.654287471302;5326.760295786699;3199.7760156789036;3552.6447355264527;3722.7021838252876;3741.1769410729594;3749.2126653402547;1073.5974009746344;1098.758273179899;1108.9112870970303;1125.3754166437625;1131.4286285425808;11196.496157672842;11224.551017959271;11290.774184516264;11306.886931130666;11510.827337589943;4476.597106260452;4568.70303430276;4732.952670473252;4765.285207218945;4797.688150270221;9589.664361747446;9746.025397460338;9766.853497197548;9795.314327997114;9804.950975245221;4664.836730714476;5265.894682106336;5285.709285989231;5291.126964050965;5291.470852914755;4607.216773148572;4799.368214806982;4808.783604737725;4837.2260438329695;4862.246351815404;3941.704372172041;3942.211557688474;3969.801509924492;3992.441058251847;4012.9398059029136;1105.3975583307117;1185.2532904270254;1277.3357853915911;1288.5876519513854;1306.9281189534477;763.9343611722902;889.3463304471209;895.1809094678426;924.1128516623982;951.3626958906235;5727.713614319267;5787.5080618147085;5808.593398462067;5814.883702325929;5876.47211724946;981.1071924548627;984.8083818579456;1003.247564326755;1007.3200589601989;1018.709667744704;3805.7335986481235;3877.9806100969313;3881.262560113569;3981.064449854282;4007.699422543321;10165.94917025425;10422.739431514272;10466.947665261625;10566.894331056745;10653.201009924287;10469.476526173661;10600.575976960836;10603.363798172135;10637.308574942605;10761.246712730033;7826.452148349561;7839.294463498312;7846.646900889474;8056.7180148694515;8115.513069215984;5530.557555395479;5633.8309850704545;5653.406392328746;5813.302403711582;5838.182654428469;9592.136707696342;9649.324547281623;9674.564644591152;9770.804583908424;9785.902140978498;9647.9035209647;9817.85273220888;9871.358361706467;9953;10029.348092373972;6933.064036355027;6951.339622735832;7013.719451222098;7029.894551581832;7093;6978.860422791618;7997.680092796223;8031.156728543652;8098.3116435103675;8111.351091912751;7079.292070793085;7250.528715633467;7283.417326613964;7333.376662983706;7424.96287518559;6228.906566401417;7117.857642847218;7162.46281528877;7204.9639751800905;7231.710731570678;6624.668766561749;6852.417544508772;6857.588544687334;6890.44876409896;6928.688209030706;4229.619334259932;4746.976265118652;4851.414871914546;4955.40535135786;5109.540141387293;4901.975490122527;4941.50584941503;4974.980129073459;5000.474950130184;5003.574696150868 03:33:01 INFO - PROCESS | 1663 | |4;prototype.html;301.1762828663605;304.6526959266437;309.24852608162155;314.4387268725324;317.43179708322106;5344.7974205803675;5370.892582148354;5398.6220964532495;5428.45715428457;5435.9728201358985;4403.295472724365;5251.921221181686;5344.946550534503;5362.705051222181;5406;3351.1066247570043;3851.1912498375373;3918.392649139388;3999.2001599680034;4102.097538541516;3379.239671074001;3907.628775266345;4083.1629515949157;4091.652209562191;4172.415861779354;3525.9598418466485;4063.6952228582827;4081.693857965452;4100.85647002355;4122.216778812016;3340.699337059652;3570.910872183983;3747.925041499182;4067.2882245607047;4144.896377590554;2827.473164491172;3035.9544606830914;3537.5224344713647;3548.970798468441;3562.5546806649168;3843.0200298923874;4702.905941881178;5181.5077567631015;5270.92093618596;5284.4187139414635;3706.9814650926573;4068.776217308047;4131.855385061538;4708.835190768306;4716.669833111683;4887.535684110004;5070.923936140961;5717.656940583578;5723.227364305807;5751.424857514257;3888.4361767543546;3893;3916.921661566753;3938.5864484229314;3943.605639436062;5039.44566097729;5742.100239379129;6040.305364883051;6058.121572372025;6079.908801367983;3882.417637354363;3911.882643520699;3919.7648141111627;3930.6855451563806;3964.3458829292845;3795.69634429245;3982.980085099556;4006.959930400659;4014.337634290368;4017.979910100431;4628.033085938463;4671.299305104261;4702.871310885363;4727.314539391838;4735.905281894343;5294.523492885659;5635.059508171544;5677.37548869624;5706.115552089433;5716.542676585863;1239.9690007749878;1283.6201083834915;1327.0180066750536;1358.9524366647317;1368.2144801034547;658.6673729766437;722.2163952111912;723.5875550935916;765.8894602825925;817.7342363731692;5087.364079490064;5271.156614941591;5295.920561191585;5297.708626025606;5413.891722165535;5224.399194092652;5524.889502209933;5942.286925568873;5950.345461999176;5972.701364931823;4711.3639658646325;5202.996846214159;5407.675539467645;5415.241866138744;5440.265564148868;2948.3513627002026;3043.9346228820177;3046.1470788179345;3052.2064263291704;3059.6634370219704;5125.948740512622;5974.970125149346;6005.849853753691;6048.45764330093;6079.896070152718;5122.871928201825;5461.290032295776;5616.382197958222;5996.183701809238;6067.332593414721;4595.425571803525;4969.428515720666;5189.455107213839;5219.295395121686;5677.37548869624;4977.377827771528;5605.579581531483;5931.703414829155;5949.405059494189;6041.6375017499095;4878.829240976549;5176;5897.174395584708;5930.911036334544;5934.643921364732;6154.261488621394;6163.476104531165;6172.475339596184;6216.564840461125;6256.7810126645345;3972.7219094663096;3995.7003224757677;4008.2882918104065;4035.1727895781883;4147.751134931914;5864.354920958605;5872.588918775645;5893.70531473416;5919.556033297606;5926.703664816828;4937.839607692117;5309.486796263047;5525.530329921841;5787.855303617275;5807.354116706533;4914.8771280718265;5659.9151012735665;5684.431556844283;5716.657000579979;5724.425782909733;4662.976685116552;5130.48695130484;5164.896702065863;5594.86012849682;5622.465865742748;4755.334253204624;4942.431620363561;5463.344398672185;5686.829395118153;5740.942590574041;4552.931706024346;5518.668879867221;5574.860628484158;5628.439060227504;5637.49262566371 03:33:01 INFO - PROCESS | 1663 | |5;yui.html;718.9718702255775;736.8121129112076;773.9303462688357;793.5794029164543;793.8412317536494;15174;16435;16457.50627481176;16458.259378327974;16464.75302870455;14755.114693118421;14954.027988180787;14968.850311496883;14969.176695281754;14976.700465990674;679.4937771360344;697.7906628011601;824.2458150792019;851.6210286422545;855.2217482091298;692.1279188222825;838.6184286149818;851.5954921412341;865.709987154304;868.6395146014396;914.0996118822954;914.8581969794692;915.5742579700438;917.0691747875911;919.2829592917535;712.5795780489484;914.9039350868129;915.354674954159;916.9358144929857;919.5678031325266;551.9365272993617;660.2572106380322;683.361057411322;688.5111570784749;690.2579726793666;12882.355882205946;15297.770533442008;15364.615884602974;15368.231588420535;15369.154696491689;13793;14154.646133846736;14196;14244.074135181283;14282.07166534172;12238.938805305916;12466.875331246662;12511.624651260387;13243.072984891061;13350.799738003938;4612.561806628365;4617.353570500132;4637.2116740153915;4683.378616901022;4798.448178459452;116500;116637.41681291624;119812.40093799563;121282;121309.78690213073;10701.571937122584;11149.665510034712;11245.775084498264;11280.605178818701;11293.15301352402;21932.671009934864;22215.000324985416;22249.44376390603;22354.105835766713;22376;8031;8064.354851611857;8095;8221.876671849926;8257.587120643944;4305.483341998917;4406.250937340596;4502.5047244803045;4531.071130418322;4552.817887284537;3470.0977745786277;3553.466979953028;3562.786232826039;3564.500969864221;3571.5535558055244;617.7251123250201;631.9842003949938;642.5583525160305;661.6691654172913;661.9569727967666;528.7197785173864;573.4809996952764;605.5488660947534;610.3164455809522;646.4279112985042;8680.696175633822;9091.136342047495;9200.723978280663;9212.447253164832;9296.581653825458;530.2973560032895;584.0919103270389;612.461034289831;617.274702224884;644.3910504573133;4491.573300536444;4506.412049059143;4506.977465112654;4528.117017181618;4532.456105267389;171302;171423.14288428478;171526;174089;180686.09656951632;96889.031109688;101909.49045254875;114362.42818785853;117781;134296;104601.95398046075;104618.47690761497;105026;108317.458412709;108635;9669.613215471303;9833.065858743408;9946.602135914773;10142.594296228068;10199.643012494527;63386.68306658437;64147.67926160526;65555.34444655683;65724.34275657182;67457.3254267451;97056;98811;99014;102473.48763256136;102721;12584.433700483683;12709.110362274552;12877.678058048623;13079.803802942773;13212.464928061867;14306.213158276394;14588.92705536508;14774.6306342338;14870.851291486946;14959.700805983603;9701.854472183064;10118.898811011795;13054;13553.661158471117;13998.650033749238;11924.701882453008;13194.406251718889;13485.595432137052;14066.624010237674;14339.996200265881;13462.798058028942;13591.728165436438;13678;13735.52651195118;13801.51694690681;10901.674989128393;10958.56165753361;11007.229493935347;11625.12811539121;12115.454804533994;11302.265352752045;11450.083993280685;11493.261562405689;11592.942035289769;11685.065194784567 03:33:01 INFO - PROCESS | 1663 | __end_tp_report 03:33:01 INFO - PROCESS | 1663 | __start_cc_report 03:33:01 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1602 03:33:01 INFO - PROCESS | 1663 | __end_cc_report 03:33:01 INFO - PROCESS | 1663 | __startTimestamp1477737181581__endTimestamp 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | ------- Summary: start ------- 03:33:01 INFO - PROCESS | 1663 | Number of tests: 6 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5684.44 Median:5915.05 stddev:648.88 (11.0%) stddev-sans-first:622.93 03:33:01 INFO - PROCESS | 1663 | Values: 3283.2 3300.3 3309.2 3317.9 3360.7 4683.3 5637.0 5728.4 5728.5 5742.3 5592.7 5684.8 5690.5 5703.6 5728.7 5131.0 5167.5 5171.3 5218.1 5220.8 4456.1 5129.4 5241.5 5279.1 5303.0 5018.7 5173.6 5178.4 5232.3 5243.3 5220.6 5247.9 5248.1 5293.9 5296.5 4324.9 5138.8 5211.4 5220.7 5273.6 5500.2 5509.5 5547.2 5554.2 5621.2 6163.7 6173.5 6180.2 6220.8 6231.1 6208.8 6246.1 6267.6 6282.7 6292.3 5637.0 5678.6 5695.4 5710.8 5742.6 6245.8 6267.9 6283.0 6283.4 6292.9 5937.0 6128.8 6137.1 6139.7 6147.9 6117.6 6124.3 6156.9 6174.0 6203.1 6151.6 6165.2 6177.6 6180.0 6186.7 6125.7 6195.8 6203.2 6205.7 6209.4 4826.6 4856.7 4867.9 4877.9 4890.2 4384.3 4384.7 4401.5 4465.0 4465.9 5719.8 5728.8 5730.6 5731.8 5770.9 6062.1 6166.9 6282.3 6283.9 6285.6 5592.3 5646.3 5663.4 5668.3 5735.8 5358.1 5370.5 5392.6 5398.3 5410.0 6236.0 6260.2 6263.5 6264.6 6275.6 5968.0 6136.3 6143.3 6188.4 6255.9 6196.0 6278.5 6281.5 6284.5 6291.0 5915.1 5919.3 5921.4 5924.0 5961.3 5965.4 6095.4 6098.5 6117.7 6142.8 6031.4 6056.9 6110.3 6144.9 6149.2 6052.3 6056.5 6067.4 6082.0 6094.2 4972.5 5761.2 5866.4 5882.1 5927.1 5982.6 5998.3 6060.6 6086.5 6120.1 5900.8 5902.8 5910.0 5936.0 5941.7 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:74182.51 Median:39141.41 stddev:164913.12 (421.3%) stddev-sans-first:165282.87 03:33:01 INFO - PROCESS | 1663 | Values: 467.6 491.6 501.6 502.1 527.0 29675.9 30180.5 30205.2 30284.4 31488.8 41156.8 42560.8 42570.8 45278.0 45340.0 9663.6 9824.9 9833.0 9836.6 9868.0 8792.6 9747.0 9853.6 9862.3 9879.1 8735.3 10910.5 12022.8 12075.9 12443.9 12090.5 12159.9 12160.0 12166.1 12178.3 8675.0 8919.6 11913.0 12013.8 12025.0 38915.2 39238.0 39279.3 41866.0 42020.6 3110.5 3275.5 3525.5 3697.9 3935.9 29972.9 30246.2 30332.8 31815.7 32092.0 2646.4 3162.6 3270.7 3303.6 3335.5 504088.9 508523.0 509101.5 509209.0 509505.0 52160.7 52681.8 56143.0 59887.0 60694.4 63522.4 63793.0 63840.7 63938.7 64009.4 15918.9 16113.0 16131.4 16132.4 16158.4 12253.1 12342.9 12381.1 12382.4 12543.6 15845.0 16100.8 16145.3 18428.4 18747.9 6648.4 7798.2 7878.1 7972.7 7984.7 878.4 938.1 959.7 1014.9 1051.9 29376.6 29957.0 30030.4 30101.6 30287.5 1040.3 1079.4 1085.1 1085.9 1143.2 14654.8 15500.3 15538.9 15577.2 15684.5 699595.0 708534.0 709002.0 709059.0 710174.0 56950.1 57473.0 57559.7 57636.0 57813.7 1337.7 1355.3 1379.7 1385.6 1388.1 29090.1 29462.7 29814.3 30377.0 30602.4 48541.8 54284.7 55836.7 56070.0 59230.0 612472.0 616905.0 616934.0 618433.0 618989.0 42825.1 42889.0 43143.6 43404.0 43475.1 45948.0 47506.0 47719.0 47773.8 47875.5 38240.2 38601.8 39321.6 40606.6 40813.0 38062.6 39089.6 39193.2 39899.8 40410.8 38003.2 38008.0 39011.6 39205.4 40601.6 31924.7 34687.5 34769.0 35256.5 35278.8 25695.8 25740.7 25773.9 26207.0 26289.3 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34195.95 Median:2121.16 stddev:98160.22 (4627.7%) stddev-sans-first:98402.69 03:33:01 INFO - PROCESS | 1663 | Values: 354.6 368.1 376.9 386.7 403.7 14980.0 15553.3 16885.5 20376.1 21083.6 11541.6 14866.8 19759.7 20356.1 20594.7 4917.6 5617.3 5618.6 5621.9 5627.4 5497.3 5694.7 6154.0 6207.7 6227.0 6178.2 6183.8 6184.3 6197.4 6198.5 5900.4 6109.7 6168.0 6177.2 6180.7 5212.2 5326.4 5443.5 5455.6 5464.2 24994.6 25751.5 25844.9 25991.5 26128.9 2181.2 2236.4 2259.9 2265.4 2410.8 9833.7 10295.1 10454.2 10518.7 10570.5 1851.0 1938.1 1940.4 1968.3 2013.4 84245.0 90175.0 110543.0 126289.0 134580.0 11556.4 11667.1 11669.8 11792.1 11809.7 11751.5 12290.0 14854.6 14926.9 15060.7 7915.7 8072.2 8165.3 8176.8 8193.6 8415.4 8420.0 8455.9 8580.0 8598.5 3265.4 3844.8 3855.6 3877.4 3996.6 1891.9 1962.1 1963.7 1972.5 1983.3 838.6 892.0 902.4 949.7 957.4 20094.7 20970.5 21038.0 21140.8 21178.0 939.0 940.9 965.0 966.1 993.4 9991.6 10326.2 10362.8 11047.0 11084.6 579032.0 579261.0 592065.0 592162.0 598113.0 107783.0 110212.0 131362.0 134167.0 137742.0 916.3 916.3 953.7 954.9 956.9 16821.5 17196.3 18432.4 18772.0 18919.3 54278.2 54860.1 54875.0 55218.0 55419.3 77759.6 79942.8 80637.0 82019.9 83697.3 7611.5 7740.8 7931.2 8103.5 8144.7 8958.8 12056.0 12058.1 12201.0 12458.3 9449.7 9679.6 10577.2 10591.8 10922.4 10383.0 10467.3 10514.7 10545.7 10682.6 9590.0 9685.7 10644.9 10659.4 10694.3 7018.4 7203.3 7302.5 7494.7 7612.9 9102.2 11200.1 11358.3 11392.8 11493.5 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5566.41 Median:4965.19 stddev:3073.24 (61.9%) stddev-sans-first:3065.59 03:33:01 INFO - PROCESS | 1663 | Values: 1358.6 1529.1 1692.2 1817.4 1875.8 7035.5 7663.3 7901.2 8246.1 8268.0 7844.8 8120.6 8292.5 8305.1 8563.6 2371.5 2393.8 2402.4 2409.4 2413.4 2092.2 2359.7 2380.2 2401.1 2401.7 2099.0 2300.7 2372.8 2379.8 2381.0 1993.4 2343.6 2364.8 2366.8 2374.6 2352.3 2359.4 2359.5 2360.3 2367.2 8401.4 8653.5 8668.7 8707.2 8722.7 5120.5 5282.7 5316.9 5318.7 5326.8 3199.8 3552.6 3722.7 3741.2 3749.2 1073.6 1098.8 1108.9 1125.4 1131.4 11196.5 11224.6 11290.8 11306.9 11510.8 4476.6 4568.7 4733.0 4765.3 4797.7 9589.7 9746.0 9766.9 9795.3 9805.0 4664.8 5265.9 5285.7 5291.1 5291.5 4607.2 4799.4 4808.8 4837.2 4862.2 3941.7 3942.2 3969.8 3992.4 4012.9 1105.4 1185.3 1277.3 1288.6 1306.9 763.9 889.3 895.2 924.1 951.4 5727.7 5787.5 5808.6 5814.9 5876.5 981.1 984.8 1003.2 1007.3 1018.7 3805.7 3878.0 3881.3 3981.1 4007.7 10165.9 10422.7 10466.9 10566.9 10653.2 10469.5 10600.6 10603.4 10637.3 10761.2 7826.5 7839.3 7846.6 8056.7 8115.5 5530.6 5633.8 5653.4 5813.3 5838.2 9592.1 9649.3 9674.6 9770.8 9785.9 9647.9 9817.9 9871.4 9953.0 10029.3 6933.1 6951.3 7013.7 7029.9 7093.0 6978.9 7997.7 8031.2 8098.3 8111.4 7079.3 7250.5 7283.4 7333.4 7425.0 6228.9 7117.9 7162.5 7205.0 7231.7 6624.7 6852.4 6857.6 6890.4 6928.7 4229.6 4747.0 4851.4 4955.4 5109.5 4902.0 4941.5 4975.0 5000.5 5003.6 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4566.95 Median:5147.69 stddev:1434.95 (27.9%) stddev-sans-first:1402.80 03:33:01 INFO - PROCESS | 1663 | Values: 301.2 304.7 309.2 314.4 317.4 5344.8 5370.9 5398.6 5428.5 5436.0 4403.3 5251.9 5344.9 5362.7 5406.0 3351.1 3851.2 3918.4 3999.2 4102.1 3379.2 3907.6 4083.2 4091.7 4172.4 3526.0 4063.7 4081.7 4100.9 4122.2 3340.7 3570.9 3747.9 4067.3 4144.9 2827.5 3036.0 3537.5 3549.0 3562.6 3843.0 4702.9 5181.5 5270.9 5284.4 3707.0 4068.8 4131.9 4708.8 4716.7 4887.5 5070.9 5717.7 5723.2 5751.4 3888.4 3893.0 3916.9 3938.6 3943.6 5039.4 5742.1 6040.3 6058.1 6079.9 3882.4 3911.9 3919.8 3930.7 3964.3 3795.7 3983.0 4007.0 4014.3 4018.0 4628.0 4671.3 4702.9 4727.3 4735.9 5294.5 5635.1 5677.4 5706.1 5716.5 1240.0 1283.6 1327.0 1359.0 1368.2 658.7 722.2 723.6 765.9 817.7 5087.4 5271.2 5295.9 5297.7 5413.9 5224.4 5524.9 5942.3 5950.3 5972.7 4711.4 5203.0 5407.7 5415.2 5440.3 2948.4 3043.9 3046.1 3052.2 3059.7 5125.9 5975.0 6005.8 6048.5 6079.9 5122.9 5461.3 5616.4 5996.2 6067.3 4595.4 4969.4 5189.5 5219.3 5677.4 4977.4 5605.6 5931.7 5949.4 6041.6 4878.8 5176.0 5897.2 5930.9 5934.6 6154.3 6163.5 6172.5 6216.6 6256.8 3972.7 3995.7 4008.3 4035.2 4147.8 5864.4 5872.6 5893.7 5919.6 5926.7 4937.8 5309.5 5525.5 5787.9 5807.4 4914.9 5659.9 5684.4 5716.7 5724.4 4663.0 5130.5 5164.9 5594.9 5622.5 4755.3 4942.4 5463.3 5686.8 5740.9 4552.9 5518.7 5574.9 5628.4 5637.5 03:33:01 INFO - PROCESS | 1663 | 03:33:01 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:25674.74 Median:22365.05 stddev:41738.40 (186.6%) stddev-sans-first:41813.43 03:33:01 INFO - PROCESS | 1663 | Values: 719.0 736.8 773.9 793.6 793.8 15174.0 16435.0 16457.5 16458.3 16464.8 14755.1 14954.0 14968.9 14969.2 14976.7 679.5 697.8 824.2 851.6 855.2 692.1 838.6 851.6 865.7 868.6 914.1 914.9 915.6 917.1 919.3 712.6 914.9 915.4 916.9 919.6 551.9 660.3 683.4 688.5 690.3 12882.4 15297.8 15364.6 15368.2 15369.2 13793.0 14154.6 14196.0 14244.1 14282.1 12238.9 12466.9 12511.6 13243.1 13350.8 4612.6 4617.4 4637.2 4683.4 4798.4 116500.0 116637.4 119812.4 121282.0 121309.8 10701.6 11149.7 11245.8 11280.6 11293.2 21932.7 22215.0 22249.4 22354.1 22376.0 8031.0 8064.4 8095.0 8221.9 8257.6 4305.5 4406.3 4502.5 4531.1 4552.8 3470.1 3553.5 3562.8 3564.5 3571.6 617.7 632.0 642.6 661.7 662.0 528.7 573.5 605.5 610.3 646.4 8680.7 9091.1 9200.7 9212.4 9296.6 530.3 584.1 612.5 617.3 644.4 4491.6 4506.4 4507.0 4528.1 4532.5 171302.0 171423.1 171526.0 174089.0 180686.1 96889.0 101909.5 114362.4 117781.0 134296.0 104602.0 104618.5 105026.0 108317.5 108635.0 9669.6 9833.1 9946.6 10142.6 10199.6 63386.7 64147.7 65555.3 65724.3 67457.3 97056.0 98811.0 99014.0 102473.5 102721.0 12584.4 12709.1 12877.7 13079.8 13212.5 14306.2 14588.9 14774.6 14870.9 14959.7 9701.9 10118.9 13054.0 13553.7 13998.7 11924.7 13194.4 13485.6 14066.6 14340.0 13462.8 13591.7 13678.0 13735.5 13801.5 10901.7 10958.6 11007.2 11625.1 12115.5 11302.3 11450.1 11493.3 11592.9 11685.1 03:33:01 INFO - PROCESS | 1663 | -------- Summary: end -------- 03:33:01 INFO - PROCESS | 1663 | 03:33:02 INFO - TEST-INFO | 1663: exit 0 03:33:02 INFO - TEST-OK | dromaeo_css | took 1117593ms 03:33:02 INFO - TEST-START | kraken 03:33:02 INFO - operating with platform_type : mac_ 03:33:02 INFO - Initialising browser for kraken test... 03:33:02 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpBfVQn0/profile http://localhost:49279/getInfo.html) 03:33:04 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 03:33:04 INFO - PROCESS | 1672 | colorDepth:24 03:33:04 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 03:33:04 INFO - PROCESS | 1672 | __metrics 03:33:04 INFO - PROCESS | 1672 | 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" 03:33:04 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:05 INFO - TEST-INFO | 1672: exit 0 03:33:05 INFO - Browser initialized. 03:33:05 INFO - Running cycle 1/1 for kraken test... 03:33:05 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpBfVQn0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:17 INFO - PROCESS | 1674 | RSS: Main: 219967488 03:33:17 INFO - PROCESS | 1674 | 03:33:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 03:33:20 INFO - PROCESS | 1674 | RSS: Main: 269885440 03:33:20 INFO - PROCESS | 1674 | 03:33:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 03:33:24 INFO - PROCESS | 1674 | RSS: Main: 280858624 03:33:24 INFO - PROCESS | 1674 | 03:33:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 03:33:27 INFO - PROCESS | 1674 | RSS: Main: 377503744 03:33:27 INFO - PROCESS | 1674 | 03:33:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 03:33:30 INFO - PROCESS | 1674 | RSS: Main: 280473600 03:33:30 INFO - PROCESS | 1674 | 03:33:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:33:33 INFO - PROCESS | 1674 | RSS: Main: 281010176 03:33:33 INFO - PROCESS | 1674 | 03:33:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 03:33:36 INFO - PROCESS | 1674 | RSS: Main: 318943232 03:33:36 INFO - PROCESS | 1674 | 03:33:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 03:33:40 INFO - PROCESS | 1674 | RSS: Main: 319160320 03:33:40 INFO - PROCESS | 1674 | 03:33:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 03:33:43 INFO - PROCESS | 1674 | RSS: Main: 315179008 03:33:43 INFO - PROCESS | 1674 | 03:33:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:33:45 INFO - PROCESS | 1674 | RSS: Main: 291254272 03:33:45 INFO - PROCESS | 1674 | 03:33:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:33:48 INFO - PROCESS | 1674 | RSS: Main: 295063552 03:33:48 INFO - PROCESS | 1674 | 03:33:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:50 INFO - PROCESS | 1674 | RSS: Main: 302592000 03:33:50 INFO - PROCESS | 1674 | 03:33:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:54 INFO - PROCESS | 1674 | RSS: Main: 311652352 03:33:54 INFO - PROCESS | 1674 | 03:33:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:33:58 INFO - PROCESS | 1674 | RSS: Main: 311562240 03:33:58 INFO - PROCESS | 1674 | 03:33:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 03:34:00 INFO - PROCESS | 1674 | RSS: Main: 355749888 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | __start_tp_report 03:34:00 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 03:34:00 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 03:34:00 INFO - PROCESS | 1674 | |i|pagename|runs| 03:34:00 INFO - PROCESS | 1674 | |0;ai-astar;114;114;115;112;113;115;111;113;112;112 03:34:00 INFO - PROCESS | 1674 | |1;audio-beat-detection;146;112;111;143;111;113;111;104;140;110 03:34:00 INFO - PROCESS | 1674 | |2;audio-dft;181;181;181;205;261;202;181;183;189;182 03:34:00 INFO - PROCESS | 1674 | |3;audio-fft;81;59;59;90;60;63;59;58;82;57 03:34:00 INFO - PROCESS | 1674 | |4;audio-oscillator;83;70;94;68;71;96;125;95;67;89 03:34:00 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;88;134;125;87;87;90;84;88;84 03:34:00 INFO - PROCESS | 1674 | |6;imaging-darkroom;95;95;94;97;95;95;94;95;94;93 03:34:00 INFO - PROCESS | 1674 | |7;imaging-desaturate;87;84;83;86;84;84;84;85;84;85 03:34:00 INFO - PROCESS | 1674 | |8;json-parse-financial;59;55;54;56;57;58;60;58;58;57 03:34:00 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;67;75;73;74;72;70;69;70;71;72 03:34:00 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;82;83;89;84;101;105;76;84;87;88 03:34:00 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;134;137;140;143;144;138;141;148;187;145 03:34:00 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;163;162;167;163;161;168;163;165;164;162 03:34:00 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;66;68;67;66;66;68;68;74;63 03:34:00 INFO - PROCESS | 1674 | __end_tp_report 03:34:00 INFO - PROCESS | 1674 | __start_cc_report 03:34:00 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,2031 03:34:00 INFO - PROCESS | 1674 | __end_cc_report 03:34:00 INFO - PROCESS | 1674 | __startTimestamp1477737240024__endTimestamp 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | ------- Summary: start ------- 03:34:00 INFO - PROCESS | 1674 | Number of tests: 14 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.37 (1.2%) stddev-sans-first:1.41 03:34:00 INFO - PROCESS | 1674 | Values: 114.0 114.0 115.0 112.0 113.0 115.0 111.0 113.0 112.0 112.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:112.50 stddev:16.04 (14.3%) stddev-sans-first:14.02 03:34:00 INFO - PROCESS | 1674 | Values: 146.0 112.0 111.0 143.0 111.0 113.0 111.0 104.0 140.0 110.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:194.60 Median:186.00 stddev:25.03 (13.5%) stddev-sans-first:26.05 03:34:00 INFO - PROCESS | 1674 | Values: 181.0 181.0 181.0 205.0 261.0 202.0 181.0 183.0 189.0 182.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:12.42 (20.2%) stddev-sans-first:12.06 03:34:00 INFO - PROCESS | 1674 | Values: 81.0 59.0 59.0 90.0 60.0 63.0 59.0 58.0 82.0 57.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:86.00 stddev:18.10 (21.1%) stddev-sans-first:19.17 03:34:00 INFO - PROCESS | 1674 | Values: 83.0 70.0 94.0 68.0 71.0 96.0 125.0 95.0 67.0 89.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:87.50 stddev:18.14 (20.7%) stddev-sans-first:19.03 03:34:00 INFO - PROCESS | 1674 | Values: 88.0 88.0 134.0 125.0 87.0 87.0 90.0 84.0 88.0 84.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 03:34:00 INFO - PROCESS | 1674 | Values: 95.0 95.0 94.0 97.0 95.0 95.0 94.0 95.0 94.0 93.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.17 (1.4%) stddev-sans-first:0.87 03:34:00 INFO - PROCESS | 1674 | Values: 87.0 84.0 83.0 86.0 84.0 84.0 84.0 85.0 84.0 85.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.81 (3.1%) stddev-sans-first:1.80 03:34:00 INFO - PROCESS | 1674 | Values: 59.0 55.0 54.0 56.0 57.0 58.0 60.0 58.0 58.0 57.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:2.41 (3.3%) stddev-sans-first:1.99 03:34:00 INFO - PROCESS | 1674 | Values: 67.0 75.0 73.0 74.0 72.0 70.0 69.0 70.0 71.0 72.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.00 stddev:8.80 (10.5%) stddev-sans-first:9.07 03:34:00 INFO - PROCESS | 1674 | Values: 82.0 83.0 89.0 84.0 101.0 105.0 76.0 84.0 87.0 88.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:143.50 stddev:15.09 (10.5%) stddev-sans-first:15.39 03:34:00 INFO - PROCESS | 1674 | Values: 134.0 137.0 140.0 143.0 144.0 138.0 141.0 148.0 187.0 145.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.50 stddev:2.25 (1.4%) stddev-sans-first:2.37 03:34:00 INFO - PROCESS | 1674 | Values: 163.0 162.0 167.0 163.0 161.0 168.0 163.0 165.0 164.0 162.0 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.79 (4.1%) stddev-sans-first:2.96 03:34:00 INFO - PROCESS | 1674 | Values: 67.0 66.0 68.0 67.0 66.0 66.0 68.0 68.0 74.0 63.0 03:34:00 INFO - PROCESS | 1674 | -------- Summary: end -------- 03:34:00 INFO - PROCESS | 1674 | 03:34:00 INFO - TEST-INFO | 1674: exit 0 03:34:00 INFO - TEST-OK | kraken | took 58688ms 03:34:00 INFO - SUITE-END | took 1176s 03:34:01 INFO - Completed test suite (00:19:36) 03:34:01 INFO - javascript benchmark 03:34:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.2120291130127, 3300.3234336960927, 3309.1892486340844, 3317.9216754554777, 3360.680735330143, 4683.2975053741875, 5637.041702910505, 5728.42715728427, 5728.541716662668, 5742.28221472316, 5592.720363981805, 5684.829455116343, 5690.5447564194765, 5703.629264097841, 5728.742206600703, 5130.9994551062555, 5167.4574169712205, 5171.327727395434, 5218.112920803454, 5220.843374698765, 4456.108778244348, 5129.384473863123, 5241.475852414766, 5279.128943724281, 5303.018941495836, 5018.723970181639, 5173.637845350808, 5178.430372659023, 5232.2674825524455, 5243.318368612094, 5220.582353411737, 5247.895042099175, 5248.107821670325, 5293.86765330866, 5296.496832800878, 4324.935125973113, 5138.820141295074, 5211.400688920785, 5220.660657057279, 5273.604479664003, 5500.22996780451, 5509.531689806371, 5547.195656629807, 5554.222408862763, 5621.213030175779, 6163.691815409212, 6173.47525460332, 6180.227471566054, 6220.782272620482, 6231.065340198961, 6208.844778880519, 6246.05584182621, 6267.62394256346, 6282.717277722513, 6292.276388215368, 5636.971815140898, 5678.5741069419955, 5695.373508914057, 5710.8001219957105, 5742.569307301969, 6245.75016999324, 6267.874642507216, 6282.968585157137, 6283.403076707706, 6292.937070629327, 5936.990711579042, 6128.846778830565, 6137.1101190328045, 6139.662318572432, 6147.938520614826, 6117.571769976059, 6124.289394097934, 6156.938430615726, 6174.043023331391, 6203.069539569011, 6151.569390142647, 6165.198524191826, 6177.598456100339, 6179.969100154471, 6186.690665466709, 6125.724342404603, 6195.783147589813, 6203.16257305267, 6205.720742566596, 6209.410106039919, 4826.638002149853, 4856.73287969158, 4867.902641947141, 4877.878053048631, 4890.24201248807, 4384.276594361894, 4384.714993525411, 4401.471823381151, 4465.0400163964905, 4465.866024019285, 5719.828405147852, 5728.828135155952, 5730.598858079978, 5731.799387021434, 5770.88458230833, 6062.090686397076, 6166.938330616636, 6282.277538083179, 6283.931731605638, 6285.59143655661, 5592.2730045094695, 5646.2942132233475, 5663.433656634304, 5668.348139963957, 5735.77056917727, 5358.062339090644, 5370.543503802142, 5392.649477783932, 5398.298221231294, 5410.0, 6236.03341482071, 6260.248770147611, 6263.467605253604, 6264.561480696308, 6275.623462592259, 5968.0, 6136.2943261523715, 6143.293521245114, 6188.44304012623, 6255.874882502416, 6196.0, 6278.529110316836, 6281.497480201481, 6284.528660350584, 6291.0, 5915.053591425351, 5919.348871624204, 5921.3782552831335, 5924.002010160328, 5961.254843144607, 5965.403459654, 6095.359987201457, 6098.481629061402, 6117.724702388314, 6142.836439233709, 6031.396860314109, 6056.878862422815, 6110.266767987692, 6144.910730351702, 6149.200603921461, 6052.303985041601, 6056.454919057306, 6067.393260673897, 6082.0, 6094.2077529920825, 4972.5276098770555, 5761.193432919478, 5866.413358664099, 5882.088276317178, 5927.081302398135, 5982.641041537521, 5998.34018258, 6060.606060606046, 6086.482648974709, 6120.081455037999, 5900.763969441346, 5902.793402231073, 5909.970450147894, 5935.9703201485445, 5941.673207973603], "value": 5642.5131651558995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.6329081670888, 491.5575981616545, 501.6388200495643, 502.10875695640254, 527.0065925730003, 29675.851620741894, 30180.54729179061, 30205.24486887829, 30284.394312113745, 31488.84255578719, 41156.76529704106, 42560.787196064055, 42570.78714606431, 45278.0, 45340.0, 9663.613455461791, 9824.852627210597, 9833.01669833018, 9836.557354919047, 9867.950660246688, 8792.648294068262, 9747.0, 9853.556589953434, 9862.30963832532, 9879.110880020797, 8735.301175905945, 10910.5090270938, 12022.819657705142, 12075.939620301886, 12443.942264907493, 12090.51637934486, 12159.939200303941, 12160.0, 12166.087543434278, 12178.26930384171, 8674.956625216833, 8919.643214271486, 11913.0, 12013.759724805543, 12025.037996960222, 38915.221695566215, 39238.0, 39279.25045246834, 41865.95335116616, 42020.57979420197, 3110.5178697301953, 3275.4759238521724, 3525.5416795816636, 3697.9445308320396, 3935.9016024599327, 29972.8501357494, 30246.24384390386, 30332.8483357584, 31815.681843181505, 32092.03723888287, 2646.4045589742345, 3162.57305263791, 3270.656581058978, 3303.636599974001, 3335.483000134983, 504088.91822163353, 508522.9999999963, 509101.54492275236, 509209.0, 509505.0, 52160.73919630377, 52681.83908965474, 56143.0, 59887.0, 60694.393056069755, 63522.364776352566, 63793.0, 63840.68079659665, 63938.6803065991, 64009.35990640034, 15918.9204053979, 16113.033218006956, 16131.354745810271, 16132.354705811871, 16158.353665853469, 12253.081018923616, 12342.938285308515, 12381.071419643562, 12382.442790074469, 12543.623691289276, 15845.0, 16100.838991609933, 16145.273462694207, 18428.355007574937, 18747.90626046861, 6648.368405001517, 7798.22017798227, 7878.085108509774, 7972.720954766555, 7984.720534781255, 878.3500209844669, 938.1369140390857, 959.6593209410698, 1014.9441780702132, 1051.9263651544472, 29376.559351609743, 29957.0, 30030.399392012037, 30101.645425955885, 30287.545686814716, 1040.2614143957874, 1079.4279032112993, 1085.148158695436, 1085.9294145880492, 1143.2054721968152, 14654.780178297335, 15500.30248638814, 15538.912276140787, 15577.221138943007, 15684.529464116094, 699595.0, 708534.0, 709002.0, 709059.0, 710174.0, 56950.14574781382, 57473.0, 57559.71220143873, 57636.0, 57813.71093144507, 1337.7190789934027, 1355.335885416139, 1379.6895698467765, 1385.591250581081, 1388.0977364712815, 29090.12729618115, 29462.705372945995, 29814.254643633216, 30377.0, 30602.387952241275, 48541.75729121332, 54284.728576358444, 55836.72081639566, 56070.0, 59230.0, 612472.0, 616905.0, 616934.0, 618433.0, 618989.0, 42825.14349712926, 42889.0, 43143.56856431521, 43404.0, 43475.130497390506, 45948.0, 47506.0, 47719.0, 47773.76113119412, 47875.52124478711, 38240.2351952965, 38601.80699096486, 39321.60678393294, 40606.593934061464, 40813.0, 38062.61937380591, 39089.609103908595, 39193.2161356777, 39899.800500997306, 40410.79794601008, 38003.239935201695, 38008.04979875525, 39011.634592789116, 39205.41191882067, 40601.59398405978, 31924.6807531931, 34687.47968780521, 34769.0, 35256.471152932216, 35278.82360588283, 25695.843687033754, 25740.742592573835, 25773.871130644977, 26207.0, 26289.342766430993], "value": 20537.501759239032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5851353915918, 368.08897977505677, 376.89635350278655, 386.7447484660124, 403.70932928291637, 14980.0, 15553.300101495432, 16885.49343519695, 20376.083076261566, 21083.57832843342, 11541.596044138458, 14866.776998345034, 19759.70360444591, 20356.083976221067, 20594.691079633816, 4917.557419832206, 5617.297837770278, 5618.5786066045, 5621.915671264914, 5627.352854421753, 5497.285352904117, 5694.6867922264255, 6153.969230153843, 6207.720652570622, 6226.968865155691, 6178.227721534809, 6183.752649893999, 6184.319724830265, 6197.442230199281, 6198.535109866755, 5900.409959004087, 6109.725062372204, 6168.0439531872635, 6177.1969643945995, 6180.690965451732, 5212.192110222922, 5326.387465441485, 5443.455654434564, 5455.618106732531, 5464.23500709901, 24994.625080623806, 25751.484970300677, 25844.870775646188, 25991.480170396677, 26128.86935565329, 2181.1711549611205, 2236.4185311818883, 2259.9209027684115, 2265.3770213191337, 2410.7830295273334, 9833.655822046194, 10295.073443390056, 10454.163666906628, 10518.737031574195, 10570.52432640533, 1850.9814901850943, 1938.079412279156, 1940.3790786948182, 1968.2734947767378, 2013.3758534854242, 84245.0, 90175.0, 110543.0, 126289.0, 134580.0, 11556.364399957914, 11667.066634669207, 11669.76660466803, 11792.115591330685, 11809.704757381134, 11751.529938802523, 12290.0, 14854.554363369116, 14926.850731492763, 15060.698786024219, 7915.722949696733, 8072.233137851895, 8165.265126138676, 8176.795580110426, 8193.631286591999, 8415.368847336475, 8419.95790021046, 8455.915440845512, 8579.957100214458, 8598.484090954438, 3265.42855000374, 3844.75009124406, 3855.575886652466, 3877.3990031545154, 3996.6003399659803, 1891.8581106417073, 1962.1170473286793, 1963.6661767499559, 1972.5265936175215, 1983.335582579823, 838.5513750143766, 892.0375174615871, 902.386377263454, 949.6913503111379, 957.411192116857, 20094.69857952132, 20970.475738106365, 21038.0, 21140.78859211419, 21178.046987885584, 938.9953050234706, 940.9388389754644, 964.9758756031156, 966.0532677975623, 993.3692105513052, 9991.550380232908, 10326.173906087495, 10362.844557331646, 11047.005769480786, 11084.612038578773, 579032.0, 579261.0, 592065.0, 592162.0, 598113.0, 107783.0, 110212.0, 131362.0, 134167.0, 137742.0, 916.326500022483, 916.3356566489375, 953.6566835939057, 954.88063992001, 956.8803899512561, 16821.495355139366, 17196.31214751396, 18432.447026589223, 18772.0, 18919.337823176123, 54278.18582721183, 54860.107874648624, 54874.95577734825, 55218.0, 55419.3266113794, 77759.61120194363, 79942.80085798835, 80637.0, 82019.94950126295, 83697.30421566383, 7611.543307401574, 7740.806479838049, 7931.2068793120225, 8103.529036565928, 8144.674213031412, 8958.776030599287, 12056.0, 12058.095642826647, 12201.0, 12458.252504849737, 9449.724287221137, 9679.564419600994, 10577.206709496972, 10591.83489816135, 10922.399268040333, 10383.0, 10467.319624224401, 10514.684559463229, 10545.736356591147, 10682.62610808618, 9590.0, 9685.6610018649, 10644.89355106439, 10659.4137322448, 10694.304870183412, 7018.368346848808, 7203.279672032755, 7302.525335853153, 7494.70021199146, 7612.885806713015, 9102.225066112045, 11200.063966097981, 11358.318500889973, 11392.772144557228, 11493.48279327449], "value": 9287.157708165289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.5924222733177, 1529.1283968138162, 1692.2300353339233, 1817.4275103342454, 1875.7655293088355, 7035.5075144739885, 7663.271989161035, 7901.249381308781, 8246.051704054036, 8267.958660206697, 7844.843103137934, 8120.593970301491, 8292.460990035659, 8305.086440491541, 8563.571821408921, 2371.5138396628695, 2393.7845593896545, 2402.3633737059695, 2409.3976505873534, 2413.3845869303304, 2092.163134746106, 2359.7286312074075, 2380.1550449590404, 2401.0995876546294, 2401.6997875265592, 2099.0449345547813, 2300.7354154272307, 2372.7508611595795, 2379.7858192762646, 2380.95238095238, 1993.4119434766778, 2343.6367363058753, 2364.810815134785, 2366.7751563601514, 2374.6319320505263, 2352.3295860679796, 2359.3629719975684, 2359.457324815302, 2360.2565191964477, 2367.2188177901253, 8401.41190116692, 8653.524056176908, 8668.739937801876, 8707.172818582225, 8722.651093956234, 5120.539151476348, 5282.656627319212, 5316.867078323035, 5318.654287471302, 5326.760295786699, 3199.7760156789036, 3552.6447355264527, 3722.7021838252876, 3741.1769410729594, 3749.2126653402547, 1073.5974009746344, 1098.758273179899, 1108.9112870970303, 1125.3754166437625, 1131.4286285425808, 11196.496157672842, 11224.551017959271, 11290.774184516264, 11306.886931130666, 11510.827337589943, 4476.597106260452, 4568.70303430276, 4732.952670473252, 4765.285207218945, 4797.688150270221, 9589.664361747446, 9746.025397460338, 9766.853497197548, 9795.314327997114, 9804.950975245221, 4664.836730714476, 5265.894682106336, 5285.709285989231, 5291.126964050965, 5291.470852914755, 4607.216773148572, 4799.368214806982, 4808.783604737725, 4837.2260438329695, 4862.246351815404, 3941.704372172041, 3942.211557688474, 3969.801509924492, 3992.441058251847, 4012.9398059029136, 1105.3975583307117, 1185.2532904270254, 1277.3357853915911, 1288.5876519513854, 1306.9281189534477, 763.9343611722902, 889.3463304471209, 895.1809094678426, 924.1128516623982, 951.3626958906235, 5727.713614319267, 5787.5080618147085, 5808.593398462067, 5814.883702325929, 5876.47211724946, 981.1071924548627, 984.8083818579456, 1003.247564326755, 1007.3200589601989, 1018.709667744704, 3805.7335986481235, 3877.9806100969313, 3881.262560113569, 3981.064449854282, 4007.699422543321, 10165.94917025425, 10422.739431514272, 10466.947665261625, 10566.894331056745, 10653.201009924287, 10469.476526173661, 10600.575976960836, 10603.363798172135, 10637.308574942605, 10761.246712730033, 7826.452148349561, 7839.294463498312, 7846.646900889474, 8056.7180148694515, 8115.513069215984, 5530.557555395479, 5633.8309850704545, 5653.406392328746, 5813.302403711582, 5838.182654428469, 9592.136707696342, 9649.324547281623, 9674.564644591152, 9770.804583908424, 9785.902140978498, 9647.9035209647, 9817.85273220888, 9871.358361706467, 9953.0, 10029.348092373972, 6933.064036355027, 6951.339622735832, 7013.719451222098, 7029.894551581832, 7093.0, 6978.860422791618, 7997.680092796223, 8031.156728543652, 8098.3116435103675, 8111.351091912751, 7079.292070793085, 7250.528715633467, 7283.417326613964, 7333.376662983706, 7424.96287518559, 6228.906566401417, 7117.857642847218, 7162.46281528877, 7204.9639751800905, 7231.710731570678, 6624.668766561749, 6852.417544508772, 6857.588544687334, 6890.44876409896, 6928.688209030706, 4229.619334259932, 4746.976265118652, 4851.414871914546, 4955.40535135786, 5109.540141387293, 4901.975490122527, 4941.50584941503, 4974.980129073459, 5000.474950130184, 5003.574696150868], "value": 4512.956459945213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1762828663605, 304.6526959266437, 309.24852608162155, 314.4387268725324, 317.43179708322106, 5344.7974205803675, 5370.892582148354, 5398.6220964532495, 5428.45715428457, 5435.9728201358985, 4403.295472724365, 5251.921221181686, 5344.946550534503, 5362.705051222181, 5406.0, 3351.1066247570043, 3851.1912498375373, 3918.392649139388, 3999.2001599680034, 4102.097538541516, 3379.239671074001, 3907.628775266345, 4083.1629515949157, 4091.652209562191, 4172.415861779354, 3525.9598418466485, 4063.6952228582827, 4081.693857965452, 4100.85647002355, 4122.216778812016, 3340.699337059652, 3570.910872183983, 3747.925041499182, 4067.2882245607047, 4144.896377590554, 2827.473164491172, 3035.9544606830914, 3537.5224344713647, 3548.970798468441, 3562.5546806649168, 3843.0200298923874, 4702.905941881178, 5181.5077567631015, 5270.92093618596, 5284.4187139414635, 3706.9814650926573, 4068.776217308047, 4131.855385061538, 4708.835190768306, 4716.669833111683, 4887.535684110004, 5070.923936140961, 5717.656940583578, 5723.227364305807, 5751.424857514257, 3888.4361767543546, 3893.0, 3916.921661566753, 3938.5864484229314, 3943.605639436062, 5039.44566097729, 5742.100239379129, 6040.305364883051, 6058.121572372025, 6079.908801367983, 3882.417637354363, 3911.882643520699, 3919.7648141111627, 3930.6855451563806, 3964.3458829292845, 3795.69634429245, 3982.980085099556, 4006.959930400659, 4014.337634290368, 4017.979910100431, 4628.033085938463, 4671.299305104261, 4702.871310885363, 4727.314539391838, 4735.905281894343, 5294.523492885659, 5635.059508171544, 5677.37548869624, 5706.115552089433, 5716.542676585863, 1239.9690007749878, 1283.6201083834915, 1327.0180066750536, 1358.9524366647317, 1368.2144801034547, 658.6673729766437, 722.2163952111912, 723.5875550935916, 765.8894602825925, 817.7342363731692, 5087.364079490064, 5271.156614941591, 5295.920561191585, 5297.708626025606, 5413.891722165535, 5224.399194092652, 5524.889502209933, 5942.286925568873, 5950.345461999176, 5972.701364931823, 4711.3639658646325, 5202.996846214159, 5407.675539467645, 5415.241866138744, 5440.265564148868, 2948.3513627002026, 3043.9346228820177, 3046.1470788179345, 3052.2064263291704, 3059.6634370219704, 5125.948740512622, 5974.970125149346, 6005.849853753691, 6048.45764330093, 6079.896070152718, 5122.871928201825, 5461.290032295776, 5616.382197958222, 5996.183701809238, 6067.332593414721, 4595.425571803525, 4969.428515720666, 5189.455107213839, 5219.295395121686, 5677.37548869624, 4977.377827771528, 5605.579581531483, 5931.703414829155, 5949.405059494189, 6041.6375017499095, 4878.829240976549, 5176.0, 5897.174395584708, 5930.911036334544, 5934.643921364732, 6154.261488621394, 6163.476104531165, 6172.475339596184, 6216.564840461125, 6256.7810126645345, 3972.7219094663096, 3995.7003224757677, 4008.2882918104065, 4035.1727895781883, 4147.751134931914, 5864.354920958605, 5872.588918775645, 5893.70531473416, 5919.556033297606, 5926.703664816828, 4937.839607692117, 5309.486796263047, 5525.530329921841, 5787.855303617275, 5807.354116706533, 4914.8771280718265, 5659.9151012735665, 5684.431556844283, 5716.657000579979, 5724.425782909733, 4662.976685116552, 5130.48695130484, 5164.896702065863, 5594.86012849682, 5622.465865742748, 4755.334253204624, 4942.431620363561, 5463.344398672185, 5686.829395118153, 5740.942590574041, 4552.931706024346, 5518.668879867221, 5574.860628484158, 5628.439060227504, 5637.49262566371], "value": 4097.880259497193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9718702255775, 736.8121129112076, 773.9303462688357, 793.5794029164543, 793.8412317536494, 15174.0, 16435.0, 16457.50627481176, 16458.259378327974, 16464.75302870455, 14755.114693118421, 14954.027988180787, 14968.850311496883, 14969.176695281754, 14976.700465990674, 679.4937771360344, 697.7906628011601, 824.2458150792019, 851.6210286422545, 855.2217482091298, 692.1279188222825, 838.6184286149818, 851.5954921412341, 865.709987154304, 868.6395146014396, 914.0996118822954, 914.8581969794692, 915.5742579700438, 917.0691747875911, 919.2829592917535, 712.5795780489484, 914.9039350868129, 915.354674954159, 916.9358144929857, 919.5678031325266, 551.9365272993617, 660.2572106380322, 683.361057411322, 688.5111570784749, 690.2579726793666, 12882.355882205946, 15297.770533442008, 15364.615884602974, 15368.231588420535, 15369.154696491689, 13793.0, 14154.646133846736, 14196.0, 14244.074135181283, 14282.07166534172, 12238.938805305916, 12466.875331246662, 12511.624651260387, 13243.072984891061, 13350.799738003938, 4612.561806628365, 4617.353570500132, 4637.2116740153915, 4683.378616901022, 4798.448178459452, 116500.0, 116637.41681291624, 119812.40093799563, 121282.0, 121309.78690213073, 10701.571937122584, 11149.665510034712, 11245.775084498264, 11280.605178818701, 11293.15301352402, 21932.671009934864, 22215.000324985416, 22249.44376390603, 22354.105835766713, 22376.0, 8031.0, 8064.354851611857, 8095.0, 8221.876671849926, 8257.587120643944, 4305.483341998917, 4406.250937340596, 4502.5047244803045, 4531.071130418322, 4552.817887284537, 3470.0977745786277, 3553.466979953028, 3562.786232826039, 3564.500969864221, 3571.5535558055244, 617.7251123250201, 631.9842003949938, 642.5583525160305, 661.6691654172913, 661.9569727967666, 528.7197785173864, 573.4809996952764, 605.5488660947534, 610.3164455809522, 646.4279112985042, 8680.696175633822, 9091.136342047495, 9200.723978280663, 9212.447253164832, 9296.581653825458, 530.2973560032895, 584.0919103270389, 612.461034289831, 617.274702224884, 644.3910504573133, 4491.573300536444, 4506.412049059143, 4506.977465112654, 4528.117017181618, 4532.456105267389, 171302.0, 171423.14288428478, 171526.0, 174089.0, 180686.09656951632, 96889.031109688, 101909.49045254875, 114362.42818785853, 117781.0, 134296.0, 104601.95398046075, 104618.47690761497, 105026.0, 108317.458412709, 108635.0, 9669.613215471303, 9833.065858743408, 9946.602135914773, 10142.594296228068, 10199.643012494527, 63386.68306658437, 64147.67926160526, 65555.34444655683, 65724.34275657182, 67457.3254267451, 97056.0, 98811.0, 99014.0, 102473.48763256136, 102721.0, 12584.433700483683, 12709.110362274552, 12877.678058048623, 13079.803802942773, 13212.464928061867, 14306.213158276394, 14588.92705536508, 14774.6306342338, 14870.851291486946, 14959.700805983603, 9701.854472183064, 10118.898811011795, 13054.0, 13553.661158471117, 13998.650033749238, 11924.701882453008, 13194.406251718889, 13485.595432137052, 14066.624010237674, 14339.996200265881, 13462.798058028942, 13591.728165436438, 13678.0, 13735.52651195118, 13801.51694690681, 10901.674989128393, 10958.56165753361, 11007.229493935347, 11625.12811539121, 12115.454804533994, 11302.265352752045, 11450.083993280685, 11493.261562405689, 11592.942035289769, 11685.065194784567], "value": 7900.989137667814, "unit": "score"}], "name": "dromaeo_css", "value": 7346.977504732742, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 112.0, 113.0, 115.0, 111.0, 113.0, 112.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 111.0, 143.0, 111.0, 113.0, 111.0, 104.0, 140.0, 110.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 181.0, 205.0, 261.0, 202.0, 181.0, 183.0, 189.0, 182.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 90.0, 60.0, 63.0, 59.0, 58.0, 82.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 94.0, 68.0, 71.0, 96.0, 125.0, 95.0, 67.0, 89.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 134.0, 125.0, 87.0, 87.0, 90.0, 84.0, 88.0, 84.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 97.0, 95.0, 95.0, 94.0, 95.0, 94.0, 93.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 54.0, 56.0, 57.0, 58.0, 60.0, 58.0, 58.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 73.0, 74.0, 72.0, 70.0, 69.0, 70.0, 71.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 89.0, 84.0, 101.0, 105.0, 76.0, 84.0, 87.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 140.0, 143.0, 144.0, 138.0, 141.0, 148.0, 187.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 167.0, 163.0, 161.0, 168.0, 163.0, 165.0, 164.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 68.0, 68.0, 74.0, 63.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1448.4, "alertThreshold": 2.0}]} 03:34:01 INFO - Return code: 0 03:34:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:34:01 INFO - # TBPL SUCCESS # 03:34:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:34:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:34:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:34:01 INFO - 2016-10-29 03:34:01.328 screenresolution[1678:11675] starting screenresolution argv=screenresolution get 03:34:01 INFO - 2016-10-29 03:34:01.331 screenresolution[1678:11675] Display 0: 1600x1200x32@60 03:34:01 INFO - 2016-10-29 03:34:01.337 screenresolution[1679:11678] starting screenresolution argv=screenresolution list 03:34:01 INFO - Available Modes on Display 0 03:34:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:34:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:34:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:34:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:34:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:34:01 INFO - Intel Iris: 03:34:01 INFO - Chipset Model: Intel Iris 03:34:01 INFO - Type: GPU 03:34:01 INFO - Bus: Built-In 03:34:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:34:01 INFO - Vendor: Intel (0x8086) 03:34:01 INFO - Device ID: 0x0a2e 03:34:01 INFO - Revision ID: 0x0009 03:34:01 INFO - Displays: 03:34:01 INFO - Display: 03:34:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:34:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:34:01 INFO - Display Serial Number: 1600x1200 60 03:34:01 INFO - Main Display: Yes 03:34:01 INFO - Mirror: Off 03:34:01 INFO - Online: Yes 03:34:01 INFO - Rotation: Supported 03:34:01 INFO - Return code: 0 03:34:01 INFO - Running post-action listener: _resource_record_post_action 03:34:01 INFO - [mozharness: 2016-10-29 10:34:01.572269Z] Finished run-tests step (success) 03:34:01 INFO - Running post-run listener: _resource_record_post_run 03:34:01 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33266688; Write bytes: 664322560; Read time: 313; Write time: 1874 03:34:01 INFO - TinderboxPrint: CPU usage
53.3% 03:34:01 INFO - TinderboxPrint: I/O read bytes / time
33,266,688 / 313 03:34:01 INFO - TinderboxPrint: I/O write bytes / time
664,322,560 / 1,874 03:34:01 INFO - TinderboxPrint: CPU idle
2,260.2 (46.7%) 03:34:01 INFO - TinderboxPrint: CPU system
964.9 (19.9%) 03:34:01 INFO - TinderboxPrint: CPU user
1,612.5 (33.3%) 03:34:01 INFO - TinderboxPrint: Swap in / out
392,519,680 / 0 03:34:01 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355465728; Write bytes: 356107776; Read time: 27854; Write time: 708 03:34:01 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32328704; Write bytes: 298060800; Read time: 299; Write time: 1133 03:34:02 INFO - Running post-run listener: _upload_blobber_files 03:34:02 INFO - Blob upload gear active. 03:34:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:34:02 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 03:34:02 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:34:02 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:34:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:06 INFO - (blobuploader) - INFO - Done attempting. 03:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:07 INFO - (blobuploader) - INFO - Done attempting. 03:34:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:34:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:09 INFO - (blobuploader) - INFO - Done attempting. 03:34:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:34:09 INFO - Return code: 0 03:34:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:34:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:34:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b4b0ab1b8ba19a706d6d1cad1810c9aa42a8abbcb78e11022058db9ca8bf1b521298b882c6a4147fff4e5fceb2dc916a9f8b985be9693b29c17835b75da5cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9013b2d447142c886f323123fc26960a419df00971cac2e7a9d60acd32887348d7e1c86eb3560b786fc6c03e7b73e66f212d6676a1278a3ab0a5dfb50d4baf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87090ee183e5cffda5ac9b11e76d103ed6c8bb12ee5f2b5a89ed295bb737d445f7cf824484c106bcddb7eba12c164d2fa8b86e41848279b0eccaa7e22da20ed3"} 03:34:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:34:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:34:09 INFO - Contents: 03:34:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b4b0ab1b8ba19a706d6d1cad1810c9aa42a8abbcb78e11022058db9ca8bf1b521298b882c6a4147fff4e5fceb2dc916a9f8b985be9693b29c17835b75da5cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9013b2d447142c886f323123fc26960a419df00971cac2e7a9d60acd32887348d7e1c86eb3560b786fc6c03e7b73e66f212d6676a1278a3ab0a5dfb50d4baf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87090ee183e5cffda5ac9b11e76d103ed6c8bb12ee5f2b5a89ed295bb737d445f7cf824484c106bcddb7eba12c164d2fa8b86e41848279b0eccaa7e22da20ed3"} 03:34:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:34:09 INFO - Copying logs to upload dir... 03:34:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:34:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.863429 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-29 03:34:10.494725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 03:34:10.498580) ========= 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.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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-Aurora/sha512/0b4b0ab1b8ba19a706d6d1cad1810c9aa42a8abbcb78e11022058db9ca8bf1b521298b882c6a4147fff4e5fceb2dc916a9f8b985be9693b29c17835b75da5cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9013b2d447142c886f323123fc26960a419df00971cac2e7a9d60acd32887348d7e1c86eb3560b786fc6c03e7b73e66f212d6676a1278a3ab0a5dfb50d4baf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87090ee183e5cffda5ac9b11e76d103ed6c8bb12ee5f2b5a89ed295bb737d445f7cf824484c106bcddb7eba12c164d2fa8b86e41848279b0eccaa7e22da20ed3"} build_url:https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/T4feXsLHQC6yPCY5UuZxEQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b4b0ab1b8ba19a706d6d1cad1810c9aa42a8abbcb78e11022058db9ca8bf1b521298b882c6a4147fff4e5fceb2dc916a9f8b985be9693b29c17835b75da5cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9013b2d447142c886f323123fc26960a419df00971cac2e7a9d60acd32887348d7e1c86eb3560b786fc6c03e7b73e66f212d6676a1278a3ab0a5dfb50d4baf12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87090ee183e5cffda5ac9b11e76d103ed6c8bb12ee5f2b5a89ed295bb737d445f7cf824484c106bcddb7eba12c164d2fa8b86e41848279b0eccaa7e22da20ed3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 03:34:10.532897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:34:10.533246) ========= 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.GXEoWt6LVw/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.hanZympsAy/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 03:34:10.582504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 03:34:10.582846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 03:34:10.583187) ========= ========= Total master_lag: 0.73 =========