builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0289 starttime: 1483405771.41 results: success (0) buildid: 20170102145221 builduid: 4ed27431bb3a4c139d0a568f4e9a05de revision: 817d5c09bd437051dbb406f6a04b1f454066899c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.410804) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.411234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.411551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.746378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.746766) ========= 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.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-02 17:09:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.5M=0.001s 2017-01-02 17:09:31 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168982 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.956531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:31.956895) ========= 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.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.019966 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:32.031022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 17:09:32.031359) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 817d5c09bd437051dbb406f6a04b1f454066899c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 817d5c09bd437051dbb406f6a04b1f454066899c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-02 17:09:32,133 truncating revision to first 12 chars 2017-01-02 17:09:32,133 Setting DEBUG logging. 2017-01-02 17:09:32,133 attempt 1/10 2017-01-02 17:09:32,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/817d5c09bd43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 17:09:33,027 unpacking tar archive at: mozilla-beta-817d5c09bd43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.181928 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 17:09:33.265620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:33.265945) ========= script_repo_revision: 817d5c09bd437051dbb406f6a04b1f454066899c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:33.266414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:33.266693) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 17:09:33.294148) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-02 17:09:33.294561) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:09:33 INFO - MultiFileLogger online at 20170102 17:09:33 in /builds/slave/test 17:09:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:33 INFO - {'append_to_log': False, 17:09:33 INFO - 'base_work_dir': '/builds/slave/test', 17:09:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:33 INFO - 'branch': 'Mozilla-Beta', 17:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:33 INFO - 'config_files': ('talos/mac_config.py',), 17:09:33 INFO - 'default_actions': ('clobber', 17:09:33 INFO - 'read-buildbot-config', 17:09:33 INFO - 'download-and-extract', 17:09:33 INFO - 'populate-webroot', 17:09:33 INFO - 'create-virtualenv', 17:09:33 INFO - 'install', 17:09:33 INFO - 'run-tests'), 17:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:33 INFO - 'download_minidump_stackwalk': True, 17:09:33 INFO - 'download_symbols': 'ondemand', 17:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:33 INFO - 'installer_path': 'installer.exe', 17:09:33 INFO - 'log_level': 'info', 17:09:33 INFO - 'log_name': 'talos', 17:09:33 INFO - 'log_to_console': True, 17:09:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:09:33 INFO - 'opt_config_files': (), 17:09:33 INFO - 'pip_index': False, 17:09:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:33 INFO - 'cmd': ('bash', 17:09:33 INFO - '-c', 17:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:33 INFO - 'enabled': True, 17:09:33 INFO - 'halt_on_failure': False, 17:09:33 INFO - 'name': 'check_screen_resolution'},), 17:09:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:33 INFO - 'cmd': ('bash', 17:09:33 INFO - '-c', 17:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:33 INFO - 'enabled': True, 17:09:33 INFO - 'halt_on_failure': False, 17:09:33 INFO - 'name': 'check_screen_resolution'},), 17:09:33 INFO - 'run_cmd_checks_enabled': True, 17:09:33 INFO - 'sps_profile': False, 17:09:33 INFO - 'sps_profile_interval': 0, 17:09:33 INFO - 'suite': 'dromaeojs', 17:09:33 INFO - 'system_bits': '32', 17:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:33 INFO - 'title': 't-yosemite-r7-0289', 17:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:33 INFO - 'use_talos_json': True, 17:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:33 INFO - 'work_dir': 'build'} 17:09:33 INFO - [mozharness: 2017-01-03 01:09:33.485916Z] Running clobber step. 17:09:33 INFO - Running pre-action listener: _resource_record_pre_action 17:09:33 INFO - Running main action method: clobber 17:09:33 INFO - rmtree: /builds/slave/test/build 17:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:35 INFO - Running post-action listener: _resource_record_post_action 17:09:35 INFO - [mozharness: 2017-01-03 01:09:35.183168Z] Finished clobber step (success) 17:09:35 INFO - [mozharness: 2017-01-03 01:09:35.183289Z] Running read-buildbot-config step. 17:09:35 INFO - Running pre-action listener: _resource_record_pre_action 17:09:35 INFO - Running main action method: read_buildbot_config 17:09:35 INFO - Using buildbot properties: 17:09:35 INFO - { 17:09:35 INFO - "project": "", 17:09:35 INFO - "product": "firefox", 17:09:35 INFO - "script_repo_revision": "production", 17:09:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:09:35 INFO - "repository": "", 17:09:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:09:35 INFO - "buildid": "20170102145221", 17:09:35 INFO - "pgo_build": "False", 17:09:35 INFO - "basedir": "/builds/slave/test", 17:09:35 INFO - "buildnumber": 4, 17:09:35 INFO - "slavename": "t-yosemite-r7-0289", 17:09:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:09:35 INFO - "platform": "yosemite_r7", 17:09:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:09:35 INFO - "branch": "mozilla-beta", 17:09:35 INFO - "repo_path": "releases/mozilla-beta", 17:09:35 INFO - "revision": "817d5c09bd437051dbb406f6a04b1f454066899c", 17:09:35 INFO - "stage_platform": "macosx64", 17:09:35 INFO - "builduid": "4ed27431bb3a4c139d0a568f4e9a05de", 17:09:35 INFO - "slavebuilddir": "test" 17:09:35 INFO - } 17:09:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 17:09:35 INFO - Running post-action listener: _resource_record_post_action 17:09:35 INFO - [mozharness: 2017-01-03 01:09:35.186591Z] Finished read-buildbot-config step (success) 17:09:35 INFO - [mozharness: 2017-01-03 01:09:35.186722Z] Running download-and-extract step. 17:09:35 INFO - Running pre-action listener: _resource_record_pre_action 17:09:35 INFO - Running main action method: download_and_extract 17:09:35 INFO - mkdir: /builds/slave/test/build/tests 17:09: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')]} 17:09:35 INFO - trying https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 17:09:35 INFO - Downloading https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 17:09:35 INFO - Downloaded 1165 bytes. 17:09:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:09:35 INFO - Using the following test package requirements: 17:09:35 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:09:35 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 17:09:35 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 17:09:35 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:09:35 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 17:09:35 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:09:35 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 17:09:35 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 17:09:35 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 17:09:35 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:09:35 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 17:09:35 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 17:09:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:09:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:09:35 INFO - Fetch https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:09:36 INFO - Expected file size: 16234664 17:09:43 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:09:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:09:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:09:43 INFO - Fetch https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:09:43 INFO - Expected file size: 16234664 17:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 17:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 17:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 17:09:51 INFO - Expected file size: 14414089 17:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:52 INFO - trying https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:09:52 INFO - Downloading https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 17:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 17:09:55 INFO - Downloaded 86087533 bytes. 17:09:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:09:55 INFO - mkdir: /builds/slave/test/properties 17:09:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:55 INFO - Contents: 17:09:55 INFO - build_url:https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:09:56 INFO - Running post-action listener: _resource_record_post_action 17:09:56 INFO - Running post-action listener: set_extra_try_arguments 17:09:56 INFO - [mozharness: 2017-01-03 01:09:56.138792Z] Finished download-and-extract step (success) 17:09:56 INFO - [mozharness: 2017-01-03 01:09:56.138905Z] Running populate-webroot step. 17:09:56 INFO - Running pre-action listener: _resource_record_pre_action 17:09:56 INFO - Running main action method: populate_webroot 17:09:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:56 INFO - '--tppagecycles', 17:09:56 INFO - '7'], 17:09:56 INFO - 'tests': ['tsvgm']}}, 17:09:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['damp', 'tps']}, 17:09:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'tests': ['damp', 'tps']}, 17:09:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['dromaeo_dom']}, 17:09:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['basic_compositor_video']}, 17:09:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:09:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['a11yr', 17:09:56 INFO - 'ts_paint', 17:09:56 INFO - 'tpaint', 17:09:56 INFO - 'sessionrestore', 17:09:56 INFO - 'sessionrestore_no_auto_restore', 17:09:56 INFO - 'tabpaint']}, 17:09:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['tsvgx', 17:09:56 INFO - 'tsvgr_opacity', 17:09:56 INFO - 'tart', 17:09:56 INFO - 'tscrollx', 17:09:56 INFO - 'cart']}, 17:09:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:56 INFO - 'tsvgr_opacity', 17:09:56 INFO - 'tart', 17:09:56 INFO - 'tscrollx', 17:09:56 INFO - 'cart']}, 17:09:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'talos_options': ['--disable-e10s'], 17:09:56 INFO - 'tests': ['tp5o']}, 17:09:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'tests': ['tp5o']}, 17:09:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'talos_options': ['--disable-e10s', 17:09:56 INFO - '--xperf_path', 17:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:56 INFO - 'tests': ['tp5n']}, 17:09:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:56 INFO - 'talos_options': ['--xperf_path', 17:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:56 INFO - 'tests': ['tp5n']}}, 17:09:56 INFO - 'talos.zip': {'path': '', 17:09:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:56 INFO - Running post-action listener: _resource_record_post_action 17:09:56 INFO - [mozharness: 2017-01-03 01:09:56.157482Z] Finished populate-webroot step (success) 17:09:56 INFO - [mozharness: 2017-01-03 01:09:56.157612Z] Running create-virtualenv step. 17:09:56 INFO - Running pre-action listener: _resource_record_pre_action 17:09:56 INFO - Running main action method: create_virtualenv 17:09:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:56 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 17:09:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:56 INFO - Using real prefix '/tools/python27' 17:09:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:59 INFO - Installing pip.................done. 17:09:59 INFO - Return code: 0 17:09:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:59 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')]} 17:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:59 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')]} 17:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:59 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:09:59 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 17:09:59 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 17:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:59 INFO - 'HOME': '/Users/cltbld', 17:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:59 INFO - 'LOGNAME': 'cltbld', 17:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:59 INFO - 'MOZ_NO_REMOTE': '1', 17:09:59 INFO - 'NO_EM_RESTART': '1', 17:09:59 INFO - 'PAGER': '/bin/cat', 17:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:59 INFO - 'PWD': '/builds/slave/test', 17:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:59 INFO - 'SHELL': '/bin/bash', 17:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:09:59 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:59 INFO - 'USER': 'cltbld', 17:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:59 INFO - 'XPC_FLAGS': '0x0', 17:09:59 INFO - 'XPC_SERVICE_NAME': '0', 17:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 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 17:10:00 INFO - Cleaning up... 17:10:00 INFO - Return code: 0 17:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:00 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 17:10:00 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 17:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:00 INFO - 'HOME': '/Users/cltbld', 17:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:00 INFO - 'LOGNAME': 'cltbld', 17:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:00 INFO - 'MOZ_NO_REMOTE': '1', 17:10:00 INFO - 'NO_EM_RESTART': '1', 17:10:00 INFO - 'PAGER': '/bin/cat', 17:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:00 INFO - 'PWD': '/builds/slave/test', 17:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:00 INFO - 'SHELL': '/bin/bash', 17:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:00 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:00 INFO - 'USER': 'cltbld', 17:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:00 INFO - 'XPC_FLAGS': '0x0', 17:10:00 INFO - 'XPC_SERVICE_NAME': '0', 17:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 INFO - Downloading/unpacking psutil>=3.1.1 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:00 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 17:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:04 INFO - Installing collected packages: psutil 17:10:04 INFO - Running setup.py install for psutil 17:10:04 INFO - building 'psutil._psutil_osx' extension 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 INFO - building 'psutil._psutil_posix' extension 17:10:04 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 17:10:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:10:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:10:04 INFO - ^ 17:10:04 INFO - 1 warning generated. 17:10:04 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 17:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:05 INFO - Successfully installed psutil 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:05 INFO - 'HOME': '/Users/cltbld', 17:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PAGER': '/bin/cat', 17:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:05 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - 'XPC_FLAGS': '0x0', 17:10:05 INFO - 'XPC_SERVICE_NAME': '0', 17:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:10:08 INFO - Installing collected packages: mozsystemmonitor 17:10:08 INFO - Running setup.py install for mozsystemmonitor 17:10:08 INFO - Successfully installed mozsystemmonitor 17:10:08 INFO - Cleaning up... 17:10:08 INFO - Return code: 0 17:10:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:10:08 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')]} 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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')]} 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:08 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 17:10:08 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 17:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:08 INFO - 'HOME': '/Users/cltbld', 17:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:08 INFO - 'LOGNAME': 'cltbld', 17:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:08 INFO - 'MOZ_NO_REMOTE': '1', 17:10:08 INFO - 'NO_EM_RESTART': '1', 17:10:08 INFO - 'PAGER': '/bin/cat', 17:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:08 INFO - 'PWD': '/builds/slave/test', 17:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:08 INFO - 'SHELL': '/bin/bash', 17:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:08 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:08 INFO - 'USER': 'cltbld', 17:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:08 INFO - 'XPC_FLAGS': '0x0', 17:10:08 INFO - 'XPC_SERVICE_NAME': '0', 17:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 INFO - Downloading/unpacking jsonschema==2.5.1 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:11 INFO - warning: no files found matching '*.txt' 17:10:11 INFO - no previously-included directories found matching 'build' 17:10:11 INFO - no previously-included directories found matching 'dist' 17:10:11 INFO - no previously-included directories found matching '.git*' 17:10:11 INFO - Installing collected packages: jsonschema, functools32 17:10:11 INFO - Running setup.py install for functools32 17:10:11 INFO - warning: no files found matching '*.txt' 17:10:11 INFO - no previously-included directories found matching 'build' 17:10:11 INFO - no previously-included directories found matching 'dist' 17:10:11 INFO - no previously-included directories found matching '.git*' 17:10:11 INFO - Successfully installed jsonschema functools32 17:10:11 INFO - Cleaning up... 17:10:12 INFO - Return code: 0 17:10:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:12 INFO - 'HOME': '/Users/cltbld', 17:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:12 INFO - 'LOGNAME': 'cltbld', 17:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:12 INFO - 'MOZ_NO_REMOTE': '1', 17:10:12 INFO - 'NO_EM_RESTART': '1', 17:10:12 INFO - 'PAGER': '/bin/cat', 17:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:12 INFO - 'PWD': '/builds/slave/test', 17:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:12 INFO - 'SHELL': '/bin/bash', 17:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:12 INFO - 'USER': 'cltbld', 17:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:12 INFO - 'XPC_FLAGS': '0x0', 17:10:12 INFO - 'XPC_SERVICE_NAME': '0', 17:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:10:12 INFO - Cleaning up... 17:10:12 INFO - Return code: 0 17:10:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:12 INFO - 'HOME': '/Users/cltbld', 17:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:12 INFO - 'LOGNAME': 'cltbld', 17:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:12 INFO - 'MOZ_NO_REMOTE': '1', 17:10:12 INFO - 'NO_EM_RESTART': '1', 17:10:12 INFO - 'PAGER': '/bin/cat', 17:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:12 INFO - 'PWD': '/builds/slave/test', 17:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:12 INFO - 'SHELL': '/bin/bash', 17:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:12 INFO - 'USER': 'cltbld', 17:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:12 INFO - 'XPC_FLAGS': '0x0', 17:10:12 INFO - 'XPC_SERVICE_NAME': '0', 17:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 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 17:10:16 INFO - Downloading docopt-0.6.1.tar.gz 17:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:16 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:16 INFO - Running setup.py install for blobuploader 17:10:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:16 INFO - Running setup.py install for requests 17:10:17 INFO - Running setup.py install for docopt 17:10:17 INFO - Successfully installed blobuploader requests docopt 17:10:17 INFO - Cleaning up... 17:10:17 INFO - Return code: 0 17:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:17 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:17 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 17:10:17 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 17:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:17 INFO - 'HOME': '/Users/cltbld', 17:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:17 INFO - 'LOGNAME': 'cltbld', 17:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:17 INFO - 'MOZ_NO_REMOTE': '1', 17:10:17 INFO - 'NO_EM_RESTART': '1', 17:10:17 INFO - 'PAGER': '/bin/cat', 17:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:17 INFO - 'PWD': '/builds/slave/test', 17:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:17 INFO - 'SHELL': '/bin/bash', 17:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:17 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:17 INFO - 'USER': 'cltbld', 17:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:17 INFO - 'XPC_FLAGS': '0x0', 17:10:17 INFO - 'XPC_SERVICE_NAME': '0', 17:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-_UtJgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-fYOgfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Y12k3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-WG2T9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-D4AqPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-5mHiNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-J9tqLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-cyUxMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-SqfSfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-mvjYSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-urDltm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-sI5Wt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-g0zdYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-kh30gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ARawo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-uOh2rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-OfvZuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:19 INFO - Running setup.py install for manifestparser 17:10:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Running setup.py install for mozcrash 17:10:19 INFO - Running setup.py install for mozdebug 17:10:19 INFO - Running setup.py install for mozdevice 17:10:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Running setup.py install for mozfile 17:10:20 INFO - Running setup.py install for mozhttpd 17:10:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Running setup.py install for mozinfo 17:10:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Running setup.py install for mozInstall 17:10:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Running setup.py install for mozleak 17:10:20 INFO - Running setup.py install for mozlog 17:10:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:20 INFO - Running setup.py install for moznetwork 17:10:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Running setup.py install for mozprocess 17:10:21 INFO - Running setup.py install for mozprofile 17:10:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Running setup.py install for mozrunner 17:10:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:21 INFO - Running setup.py install for mozscreenshot 17:10:21 INFO - Running setup.py install for moztest 17:10:21 INFO - Running setup.py install for mozversion 17:10:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:22 INFO - Cleaning up... 17:10:22 INFO - Return code: 0 17:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:22 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')]} 17:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:22 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')]} 17:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:22 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:22 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 17:10:22 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 17:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:22 INFO - 'HOME': '/Users/cltbld', 17:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:22 INFO - 'LOGNAME': 'cltbld', 17:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:22 INFO - 'MOZ_NO_REMOTE': '1', 17:10:22 INFO - 'NO_EM_RESTART': '1', 17:10:22 INFO - 'PAGER': '/bin/cat', 17:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:22 INFO - 'PWD': '/builds/slave/test', 17:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:22 INFO - 'SHELL': '/bin/bash', 17:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:22 INFO - 'USER': 'cltbld', 17:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:22 INFO - 'XPC_FLAGS': '0x0', 17:10:22 INFO - 'XPC_SERVICE_NAME': '0', 17:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-nzUKyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-cXVDPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-3TBLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Ts9ynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-F0gjjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-c3UDAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:22 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)) 17:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-d544l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-NvdVNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Bti_c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1ipKok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-QB4CGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-aD96Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-3nE3Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-mNKIUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YRf1eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:23 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)) 17:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-7lKn6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:24 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)) 17:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-aP3LDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:24 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)) 17:10:24 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)) 17:10:24 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)) 17:10:24 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)) 17:10:24 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)) 17:10:24 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)) 17:10:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:26 INFO - Downloading blessings-1.6.tar.gz 17:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:26 INFO - Installing collected packages: blessings 17:10:26 INFO - Running setup.py install for blessings 17:10:26 INFO - Successfully installed blessings 17:10:26 INFO - Cleaning up... 17:10:27 INFO - Return code: 0 17:10:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:27 INFO - Reading from file tmpfile_stdout 17:10:27 INFO - Current package versions: 17:10:27 INFO - blessings == 1.6 17:10:27 INFO - blobuploader == 1.2.4 17:10:27 INFO - docopt == 0.6.1 17:10:27 INFO - functools32 == 3.2.3-2 17:10:27 INFO - jsonschema == 2.5.1 17:10:27 INFO - manifestparser == 1.1 17:10:27 INFO - mozInstall == 1.12 17:10:27 INFO - mozcrash == 0.17 17:10:27 INFO - mozdebug == 0.1 17:10:27 INFO - mozdevice == 0.48 17:10:27 INFO - mozfile == 1.2 17:10:27 INFO - mozhttpd == 0.7 17:10:27 INFO - mozinfo == 0.9 17:10:27 INFO - mozleak == 0.1 17:10:27 INFO - mozlog == 3.4 17:10:27 INFO - moznetwork == 0.27 17:10:27 INFO - mozprocess == 0.23 17:10:27 INFO - mozprofile == 0.28 17:10:27 INFO - mozrunner == 6.12 17:10:27 INFO - mozscreenshot == 0.1 17:10:27 INFO - mozsystemmonitor == 0.3 17:10:27 INFO - moztest == 0.7 17:10:27 INFO - mozversion == 1.4 17:10:27 INFO - psutil == 3.1.1 17:10:27 INFO - requests == 1.2.3 17:10:27 INFO - wsgiref == 0.1.2 17:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:27 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 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:27 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 17:10:27 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 17:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:27 INFO - 'HOME': '/Users/cltbld', 17:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:27 INFO - 'LOGNAME': 'cltbld', 17:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:27 INFO - 'MOZ_NO_REMOTE': '1', 17:10:27 INFO - 'NO_EM_RESTART': '1', 17:10:27 INFO - 'PAGER': '/bin/cat', 17:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:27 INFO - 'PWD': '/builds/slave/test', 17:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:27 INFO - 'SHELL': '/bin/bash', 17:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:27 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:27 INFO - 'USER': 'cltbld', 17:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:27 INFO - 'XPC_FLAGS': '0x0', 17:10:27 INFO - 'XPC_SERVICE_NAME': '0', 17:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 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)) 17:10:27 INFO - Cleaning up... 17:10:27 INFO - Return code: 0 17:10:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b611490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b587570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf915700c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, '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.tjINtVAZVh/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.KaxPTWlPPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 17:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:27 INFO - 'HOME': '/Users/cltbld', 17:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:27 INFO - 'LOGNAME': 'cltbld', 17:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:27 INFO - 'MOZ_NO_REMOTE': '1', 17:10:27 INFO - 'NO_EM_RESTART': '1', 17:10:27 INFO - 'PAGER': '/bin/cat', 17:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:27 INFO - 'PWD': '/builds/slave/test', 17:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:27 INFO - 'SHELL': '/bin/bash', 17:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:27 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:27 INFO - 'USER': 'cltbld', 17:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:27 INFO - 'XPC_FLAGS': '0x0', 17:10:27 INFO - 'XPC_SERVICE_NAME': '0', 17:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:10:27 INFO - Cleaning up... 17:10:27 INFO - Return code: 0 17:10:27 INFO - Running post-action listener: _resource_record_post_action 17:10:27 INFO - Running post-action listener: _start_resource_monitoring 17:10:27 INFO - Starting resource monitoring. 17:10:27 INFO - [mozharness: 2017-01-03 01:10:27.929360Z] Finished create-virtualenv step (success) 17:10:27 INFO - [mozharness: 2017-01-03 01:10:27.930373Z] Running install step. 17:10:27 INFO - Running pre-action listener: _resource_record_pre_action 17:10:27 INFO - Running main action method: install 17:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:28 INFO - Reading from file tmpfile_stdout 17:10:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:28 INFO - Reading from file tmpfile_stdout 17:10:28 INFO - Output received: 17:10:28 INFO - Usage: mozinstall [options] installer 17:10:28 INFO - Options: 17:10:28 INFO - -h, --help show this help message and exit 17:10:28 INFO - -d DEST, --destination=DEST 17:10:28 INFO - Directory to install application into. [default: 17:10:28 INFO - "/builds/slave/test"] 17:10:28 INFO - --app=APP Application being installed. [default: firefox] 17:10:28 INFO - mkdir: /builds/slave/test/build/application 17:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:10:50 INFO - Reading from file tmpfile_stdout 17:10:50 INFO - Output received: 17:10:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:10:50 INFO - Running post-action listener: _resource_record_post_action 17:10:50 INFO - [mozharness: 2017-01-03 01:10:50.395190Z] Finished install step (success) 17:10:50 INFO - [mozharness: 2017-01-03 01:10:50.395318Z] Running run-tests step. 17:10:50 INFO - Running pre-action listener: _resource_record_pre_action 17:10:50 INFO - Running main action method: run_tests 17:10:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:10:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:10:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:10:50 INFO - 2017-01-02 17:10:50.409 screenresolution[1900:16115] starting screenresolution argv=screenresolution get 17:10:50 INFO - 2017-01-02 17:10:50.412 screenresolution[1900:16115] Display 0: 1600x1200x32@60 17:10:50 INFO - 2017-01-02 17:10:50.418 screenresolution[1901:16118] starting screenresolution argv=screenresolution list 17:10:50 INFO - Available Modes on Display 0 17:10:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:10:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:10:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:10:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:10:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:10:50 INFO - Intel Iris: 17:10:50 INFO - Chipset Model: Intel Iris 17:10:50 INFO - Type: GPU 17:10:50 INFO - Bus: Built-In 17:10:50 INFO - VRAM (Dynamic, Max): 1536 MB 17:10:50 INFO - Vendor: Intel (0x8086) 17:10:50 INFO - Device ID: 0x0a2e 17:10:50 INFO - Revision ID: 0x0009 17:10:50 INFO - Displays: 17:10:50 INFO - Display: 17:10:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:10:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:10:50 INFO - Display Serial Number: 1600x1200 60 17:10:50 INFO - Main Display: Yes 17:10:50 INFO - Mirror: Off 17:10:50 INFO - Online: Yes 17:10:50 INFO - Rotation: Supported 17:10:50 INFO - Return code: 0 17:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:50 INFO - Python 2.7.3 17:10:50 INFO - Return code: 0 17:10:50 INFO - grabbing minidump binary from tooltool 17:10: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')]} 17:10:50 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 0x10b425d30>, '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 0x10b28bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b41db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:50 INFO - Return code: 0 17:10:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:10:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:10:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 17:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --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 17:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tjINtVAZVh/Render', 17:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:50 INFO - 'HOME': '/Users/cltbld', 17:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:50 INFO - 'LOGNAME': 'cltbld', 17:10:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:50 INFO - 'MOZ_NO_REMOTE': '1', 17:10:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:50 INFO - 'NO_EM_RESTART': '1', 17:10:50 INFO - 'PAGER': '/bin/cat', 17:10:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:50 INFO - 'PWD': '/builds/slave/test', 17:10:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:50 INFO - 'SHELL': '/bin/bash', 17:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KaxPTWlPPR/Listeners', 17:10:50 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 17:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:50 INFO - 'USER': 'cltbld', 17:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:50 INFO - 'XPC_FLAGS': '0x0', 17:10:50 INFO - 'XPC_SERVICE_NAME': '0', 17:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 17:10:51 INFO - mozversion application_buildid: 20170102145221 17:10:51 INFO - mozversion application_changeset: 817d5c09bd437051dbb406f6a04b1f454066899c 17:10:51 INFO - mozversion application_display_name: Firefox 17:10:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:51 INFO - mozversion application_name: Firefox 17:10:51 INFO - mozversion application_remotingname: firefox 17:10:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:10:51 INFO - mozversion application_vendor: Mozilla 17:10:51 INFO - mozversion application_version: 51.0 17:10:51 INFO - mozversion platform_buildid: 20170102145221 17:10:51 INFO - mozversion platform_changeset: 817d5c09bd437051dbb406f6a04b1f454066899c 17:10:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:10:51 INFO - mozversion platform_version: 51.0 17:10:51 INFO - using testdate: 1483405851 17:10:51 INFO - actual date: 1483405851 17:10:51 INFO - starting webserver on 'localhost:52436' 17:10:51 INFO - SUITE-START | Running 2 tests 17:10:51 INFO - TEST-START | dromaeo_css 17:10:51 INFO - operating with platform_type : mac_ 17:10:51 INFO - Initialising browser for dromaeo_css test... 17:10:51 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpqPaXae/profile http://localhost:52436/getInfo.html) 17:10:53 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 17:10:53 INFO - PROCESS | 1911 | colorDepth:24 17:10:53 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 17:10:53 INFO - PROCESS | 1911 | __metrics 17:10:53 INFO - PROCESS | 1911 | 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" 17:10:53 INFO - PROCESS | 1911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:54 INFO - TEST-INFO | 1911: exit 0 17:10:54 INFO - Browser initialized. 17:10:54 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:54 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpqPaXae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:05 INFO - PROCESS | 1914 | RSS: Main: 168898560 17:11:05 INFO - PROCESS | 1914 | 17:11:57 INFO - PROCESS | 1914 | 1483405917522 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] 17:14:07 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52436/tests/dromaeo/cssquery-ext.html) 17:14:08 INFO - PROCESS | 1914 | RSS: Main: 273739776 17:14:08 INFO - PROCESS | 1914 | 17:17:11 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-ext.html (next: http://localhost:52436/tests/dromaeo/cssquery-jquery.html) 17:17:12 INFO - PROCESS | 1914 | RSS: Main: 301613056 17:17:12 INFO - PROCESS | 1914 | 17:20:14 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52436/tests/dromaeo/cssquery-mootools.html) 17:20:14 INFO - PROCESS | 1914 | RSS: Main: 274477056 17:20:14 INFO - PROCESS | 1914 | 17:23:17 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52436/tests/dromaeo/cssquery-prototype.html) 17:23:17 INFO - PROCESS | 1914 | RSS: Main: 270299136 17:23:17 INFO - PROCESS | 1914 | 17:26:20 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52436/tests/dromaeo/cssquery-yui.html) 17:26:21 INFO - PROCESS | 1914 | RSS: Main: 259940352 17:26:21 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52436/tests/dromaeo/cssquery-yui.html (next: http://localhost:52436/tests/dromaeo/cssquery-dojo.html) 17:29:24 INFO - PROCESS | 1914 | RSS: Main: 311320576 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | __start_tp_report 17:29:24 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 17:29:24 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 17:29:24 INFO - PROCESS | 1914 | |i|pagename|runs| 17:29:24 INFO - PROCESS | 1914 | |0;dojo.html;3403.489476578514;3429.5713035870513;3436.5532480777497;3463.844127014284;3487.145649315918;5732.713364331782;5751.137329400592;5777.508911742497;5804;5812.796552120677;5708.514776244014;5752.28096487939;5804.970975145118;5810.738516766745;5813.30240371155;5220.556252718514;5261.657992230512;5283.524482796547;5289.127293996486;5315.016721906441;4172.7496350218935;5200.661956972804;5334.306540149794;5335.626506144571;5351.384590772052;5216.035033518792;5231.712255825928;5234.842954711365;5268.157094864822;5282.471752824706;5262.578993680497;5288.709120998344;5289.814856480043;5353;5363.356397232357;5215.087359712035;5258.868528286824;5292.761825717852;5297.073012222884;5313.07021271276;5586.078297080977;5631.549476041907;5635.323761148688;5638.689872057035;5658.943410565883;6150.415710507495;6177.3822617738315;6180.825643127836;6222.906656400158;6229.345918678564;6258.624482531062;6292.087647291163;6293.748250069992;6297.149884765589;6320.74717011319;5667.291588551472;5700.743466544015;5744.310682718101;5794.536437085023;5818.5345172386105;6227;6233.532485063638;6236.158118654014;6253.624782513064;6260.5617606768;6169.413905678954;6184.474319682878;6194.163787888668;6205.875882482325;6211.09939058834;6143.174139895608;6170.691465426711;6190.350013248544;6224.595401298991;6269.122322874801;5131.179011358165;6235.532335074888;6249.875002499924;6255;6256.343083976208;6186.876262474725;6210.4100110490335;6236.875262494725;6273.686315684197;6284.214473190851;4888.731119788375;4893.535114164149;4924.285978533093;4966.9817687374;5002.699838009731;4383.167198232326;4440.600345968878;4452.109578084396;4465.531119232499;4519.683622146484;5789.421057894177;5793.507551858055;5803.651780893076;5804.622699524602;5804.767809287581;6111.622125543816;6254.749810007549;6263.937360626335;6283.43449089575;6308.716107775161;5688.800891968761;5779.930712818142;5835.124731290341;5867.794627188028;5938.495227905676;5404.594655400782;5438.782448702008;5445.455454454523;5460.672359658433;5472.151816468454;6272.560920735596;6281.59169653971;6298.622082675054;6310.305866354789;6313.684315784192;6150.077488376779;6168.506519478341;6202.4417802398;6227.906581401192;6256.405641464054;6281.654509002049;6281.685915704288;6297.779577714758;6302.1492098566105;6305.8108256752375;6211.440970312694;6215.96892015537;6226.159468471698;6237.906431403442;6252.124702541557;6069.969650151721;6154.846128846814;6192.907106393318;6213.782517612042;6260.436560709558;5366.838994830161;5788.102844059177;6141.455323060992;6157.692115394302;6184.969075154595;5978.491828194652;6163.722632481459;6174.351693072163;6175.320714721467;6183.443490085914;5835.503982161564;5891.49922256613;5940.762369505172;5953.166556681981;6017.759289628366;6099.939000610115;6171.197744293213;6184.165137706352;6202.038684003986;6213.502919766498;5986.610870293417;6016.157737916783;6018.2778066630535;6037.09443583466;6038.909416358846 17:29:24 INFO - PROCESS | 1914 | |1;ext.html;495.341196209042;497.2814283360543;510.5532658923443;526.1292560811855;535.8419266316433;32072.67927320729;41866;43253.35119973195;43277.567224327744;46009.53990460094;44924.326135108;45162.77418612911;45224.54775452244;45323.093538129215;45410.77294613531;9995.250356223276;10184.74538136545;10188.083072523472;10192.745181370488;10194.59221631134;9371.812563748721;9561.904380956172;10180.694579162637;12612.180208286478;12649;12626.873731262707;12701.809472857914;12702.745945081093;12705.491780328775;12720.300383478905;12568.183068100545;12616.74766504674;12627.92662623678;12652.493900243979;12667.809982850265;12445.25328480294;12534;12535.749285014248;12535.874641253562;12548.1216314858;41976.58023419757;42273.36589951153;42284.15431691349;42327.78836105831;42382;3378.3074469733647;3468.150303175738;3504.8072356020407;3535.4166562517153;3900.2199560088097;30798;32338;32830.17924551881;32954.884377547554;33369.666303337144;3361.31937026427;3422.3155368926314;3427;3443.7933723976644;3512.4906888501278;506142.4692876549;507473;507899;508679.45660271833;508964;64883.351166488676;65377;65407;65533.67233163804;65624.34375656182;31887.202819929687;36540;37140;38692.80653596714;38714.41928371077;18026.63946721058;18207.362742303954;18254.908725456553;18266.543336416697;18271.26914923388;12516.624501264976;12692.238465692088;13738.86261137376;13869.306534673226;13917.373718182705;16994.575135621708;19931.003449827742;20340.49148771263;20393.286234981704;20769.480762980744;8174.386920980831;8244.5891448075;8258.339332853357;8282.378821588405;8307.543085130375;875.916787905148;1002.684154491333;1048.1457612046158;1059.645018918671;1084.2952081147316;31482.527762083588;31650.683493165234;31734;32098.83950580232;32316;916.3631276263067;1183.9704007399885;1192.2131393280567;1210.152892974921;1235.3144005077088;14154.433822647185;15131.686813432423;16576.83423165753;16695.33218671264;16950.57623559421;719021;727787;728152;729239;730412;61599.384006159366;62123.6893815528;62138.68930655318;62342.064869027;62574.68712656499;1294.9741005180033;1336.0580790542838;1409.7673883809057;1429.6640289531952;1457.016513853166;25490;30395;31246.68753312529;33179.50230746492;33566.328673426884;53191;53916.730416347666;53925.46074539205;54041;54084.459155407945;581618;581703;582711.0864445651;583579;584098.0795095997;24982.62526062147;25528.872355638847;27746.861265693544;28402.289942751595;28465;49051.773705657644;49480.50519494759;49552.752236238586;49647.00705985932;50088.998220034664;39801.601983980945;40997;41002.79498602607;41352.58647413487;42403.7879810599;39524.604753952095;39945.40081898716;40500.1899962005;40937.18125637411;41766.791166045194;38829.02927426837;39294.214115718096;39695.80152099221;39781.80109099436;39904.60095399009;28963.565546517242;33504.664953350155;36059.45910811392;36133.45799813057;36555.634443655224;26533;26682.332941676614;26749.598756019066;26979;27270.454590908466 17:29:24 INFO - PROCESS | 1914 | |2;jquery.html;331.61035782955025;386.3991493228031;392.67408051317403;403.1936127744511;412.03789152329307;19701.91639459829;21968.01143948522;22633;22660;22893.656595151086;17196.570085747862;17720.911395443036;17915.28338866447;22446.438839029033;22540.32379028632;5470.384144971686;5599.440055994409;6032.245969253832;6178.25860896693;6257.280412752523;6142.84642883927;6186.381361863822;6309.242890853081;6311.715972781213;6314.684265786692;6149.077638354261;6220.595661282025;6256.843578910518;6263.906041409383;6264.123022776815;5906.645601263895;6173.2900716417735;6240.43836054755;6248.625082495065;6253.781117660883;6126.417990290915;6127.662978536178;6132.264128304632;6140.048292514667;6155.476784473325;14570.781438278435;25558;26210.475790484274;26442;26634.73365266342;2074.3362124120285;2201.8678879267295;2333.369990102663;2783.0954939644494;2844.687084420712;9766.951165244129;10149.441780702058;10525.263231573794;10638.361698298128;10872.782544349147;1584.9603759905979;1751.9313218936438;1763.3211213682825;1897.7817550981677;1956.5597740508272;129286.3535682325;133226;137101.3144934279;140933;143258;11510.712232194095;11532.94233528827;11638.534458621729;11643.592474263529;11875.762484750257;13073.477060917647;14488.565343039725;15170.393184272505;15172.848271517365;15206.315715792816;8879.778005549784;8944.195022448012;8951.507667078373;8971.641134354682;9079.228265597367;8923.821523569492;9021.503817290111;9023.774405639911;9029.458232506071;9174.908250917539;3985.2228815381304;4559.9772001140445;4578.6794924355645;4598.172328980749;4705.4588722296685;1826.3699023836755;1922.4713203869048;1929.1029671202677;1929.6816025355658;1932.652122617914;863.9481631102154;913.196387179278;976.1751320134475;995.4922989275522;1040.0275742181084;18128.546786330448;22560.548789024127;22589.774102259096;22617.773822261897;22650.980705867947;965.3918031640162;968.9854652180223;990.2622546203124;993.1210878372548;1013.6198925402974;8566.914330856736;11028.558857645605;11841.407929603485;11841.407929603485;11866.525338986516;606782;612546;626074;634636;636869;77724;130876.3456182713;132700;136327.91016269528;145778;991.8710567626163;993.9751506212402;1041.7447725307347;1047.1727335405096;1051.4374809476892;18939.33712320062;19817;20537.31343283582;20565.588688225853;20780.79219207849;57474.42525574858;61077.77844443175;61122.77754444975;61435.69282153561;61745.9999999982;82700.58649706712;83163;87408;89011.55494222487;90281;8030.5181689098845;8296.70961516344;8334.708285209988;8489.83020339602;8581.528015959182;9153.679621213225;13101.672458188621;13279.66800829987;13782.104163229758;13798.862011380159;11010.449477526252;11109.500072496596;11428.599998999995;11567;11782.941085294518;11375;11387.487563059516;11576.594819181288;11584.652460426201;11901.583444579745;11657.650270491898;11713.297202167898;11887.821682674594;11974;12050.819237711266;8150.307223886036;8245.093039765741;8406.075331713384;8586.957065214634;8595.18345757152;8272.710455134042;10435.791284174426;11448.771024579295;11580.6525804226;11776.88223117792 17:29:24 INFO - PROCESS | 1914 | |3;mootools.html;1211.9515219391226;1336.0113515998164;1537.561794888457;1697.4822679082883;1968.6948522978935;8010.5594192319395;8535;8540.829183416328;8546.957265213681;8550.144985501447;8316.1268066853;8740.956295218532;8895;8983.281337493001;9097.999220085801;2391.5814732421845;2420.685310909579;2421.7699318564796;2425.0178677635586;2428.805695544352;2369.514249578841;2389.462370966536;2413.81896357773;2414.5653782319177;2417.2627348658652;2370.5614461324626;2403.591389463795;2404.9759502404927;2406.2781165650235;2414.987925060372;2353.7763912428463;2378.9762102378927;2385.2128797496785;2388.1522059668914;2402.2192787344184;2039.6736522156532;2321.303608917318;2382.4163080045328;2387.1883559589824;2388.10446082719;8914.86627700585;8987.056359082268;9067;9067.138621830916;9074.502707053329;5357.249985002103;5365.839024829262;5518.696471694056;5522.3649280332875;5528.944710552883;3558.9110272243142;3659.780413175218;3661.505696730934;3661.963380366189;3670.1742108025746;1068.615298492542;1081.9134469242442;1104.127739086121;1112.5772206561535;1114.2812885688766;11937.462814173383;12036.759264814742;12045.39773011346;12049.216800908001;12056.397180141046;3911.4523966644692;4559.361689363492;4601.4248218972625;4637.1421287062;4682.555157260055;9206.585703643352;9210.815783684422;9222.400543964755;9223.89313282397;9241;5311.654742441729;5322.893542129135;5324.946750532445;5327.121025030904;5346.893062138814;4310.913781724411;4583.449986001701;4713.481517033124;5002.724850133278;5033.0688822567945;3058.7552995760284;3863.7102217333813;3963.6432721055244;3974;3980.184062267286;1155.8324043013715;1179.5340840368006;1180.698921774959;1194.7491026884452;1194.7670204310075;756.2890882570366;860.3848248502351;908.0737647599411;913.9725808225763;931.7903471718809;5587.664740115606;5667.716614169358;5756.625819321731;5808.680522571215;6078.45293923549;917.9541022948825;938.3666025432942;952.766572189804;986.7582442301682;1019.658414431159;3397;3724.851005959731;3842.9047721399265;3857.479240302523;3989.082511022481;10642.201834862417;11115.221934464671;11129.833052504218;11132.777344453227;11137.164712646583;11079.778404432027;11083.778324433628;11097.223194376316;11106.111511079094;11120.666380008613;8472.576371181416;8504.829903401896;8616.78458038554;8629.784255393666;8639.95680021596;5723.198752174782;5724.284464441945;5780.393058728773;5917.615355001911;5929.733162007807;10006.899931000597;10141.797164056825;10246.333988290737;10300.793984120426;10304.948475257575;9648.517574121406;9930.503474826375;10358.689239322832;10583.5237414315;10600.257981941499;6932.61870597122;7039.331263529956;7254.927450725425;7334.633268336668;7345.081864766904;8364.581770911553;8496.235338819535;8577.8713319299;8721.302295816193;8734.21392074691;7608.961955190189;7677.61611919413;7705.42209334291;7719.996400468128;7746.070471543451;6290.905636415366;7563.281488258606;7620.123685776207;7663.233676632292;7674.232576742281;6873.175218973755;6997.895031574632;7107.360337569644;7181;7182.17404998411;4964.379452568429;5003.54968052877;5020.096382651158;5026.572741317029;5059.266406371129;4859.125357435695;4929.383827021622;4940.802367905244;5065.037642847995;5077.898442031213 17:29:24 INFO - PROCESS | 1914 | |4;prototype.html;255.9731228221037;306.0741257695472;310.54815243820235;315.68431568431566;320.7578278399808;5118.692878427297;5367.731613419328;5389.272448219489;5412.837614871555;5424.674519528831;5124;5256.159014557672;5272.23552584876;5303.946960530394;5314.734263286839;4087.9591204087874;4121.031557583965;4126.381042843567;4126.938095928564;4127.349060375844;3114.8286844223558;4048.0487085534874;4137.193247316774;4140.503139623234;4153.418521407006;3526.770759900598;3977.2045590881794;4033.1731994941115;4046.8988275293204;4070.9796451017705;3312.950305745416;4039;4043.4122161816463;4047.7773722445254;4082.2856000199845;2740.328619488238;3491.6508349165133;3498.335316289922;3519.732896157381;3538.5046093546666;4222.113356195172;4694.192735796709;4761.59526440253;5165.431802501722;5177.844664660066;4118.775861035037;4616.884577885546;4629.745364004978;4656.185167595691;4659.62722982164;5076.522582031321;5556.555475561945;5623.437656234385;5653.293338332708;5666.583354161459;3354.579989483172;3520.4510015593055;3647.963520364789;3707.5540539189738;3813.733038687293;4781.593564547018;5346.914703265729;5816.82549523515;5817.156512305734;5829.842958105528;3858.5176852893387;3888.580668056139;3890.8832735017995;3917.7845218512684;3933.8033098344968;3031.5301128325145;3638.199596088856;3647.835847386874;3650.5071815305123;3750.737448378642;3826.9234615307537;4183.514852227477;4591.44902611682;4594.450080205451;4617.538246175355;4874.731889746027;5027.572656324181;5648.435156484319;5660.433956604389;5697.800576979868;1027.7482016905906;1308.483149156078;1313.7438199551186;1327.1174668845304;1333.8399392073013;873.5195642396784;878.3236907581254;890.2699786175403;904.2088172848757;916.8074704312036;4204.8528301509305;4430.667699922518;5322.574194064466;5336.359636843604;5337.946620533823;5235.869103272448;5669;5696.487316141567;5719.742611582489;5726.3128424588485;4589;4704.894769452214;5123.590112790967;5274.7098909560345;5316.308879845596;2106.873587584719;2347.5070235250787;2494.8128890333296;2541.7458254174435;2548.9362765931;4901.162064225915;4983.6013118950395;5018.157478033715;5022.648414611015;5091.618128640367;4135.7518548887165;4258.87223383299;4340.696151269381;4380.991392875547;4947.14122984073;5755.510781583528;6052.66710330936;6058.242719660043;6069.605475644157;6075.362086980804;5307.708076055854;5837.94162058374;5838.649681019152;5876.147958546072;5889.734961926638;5061.519855270964;5743.224664670383;5764.394738552559;5769.711514424346;5862.355140934408;5766.798162064308;5894.557908156991;5955.344912059757;5965.642061476326;6048.667323297261;3500.1074725944723;3881.5342158941107;3904.96095039046;3951.683865290712;3964.623360780721;5090.898182036264;5281.098804430479;5522.6134170607675;5668.914966275427;5818.556206393409;4824.445188803192;5124.231365295235;5518;5646.830595082154;5718.456746609066;5192.688438693691;5658.632188907708;5667.858303542444;5671.801486948102;5676.801311954062;5252.737363131904;5460.6177567569885;5504.9449505504435;5549.611527193058;5560.944390556043;4878.438979517401;5131.740655256054;5395.541378982673;5513.696746678971;5640.605157638925;5103;5524.596800391842;5548.448992644791;5565.495527012779;5596.188552659923 17:29:24 INFO - PROCESS | 1914 | |5;yui.html;620.8478922663946;797.5493845977022;814.0963530481168;825.0965193113539;834.2200042959831;15812.44656437025;16864.662706745858;16883.24025418856;16905.239264233107;17688.292468301286;16936.153192340396;17377.47867563972;17631.73552396712;17639.941603503798;17650.38223662172;894.1237587164567;922.9953850230773;923.2014307623924;923.5428462910869;924.958376873039;728.1407938632411;745.8582869254824;882.5675419044654;904.9819003619924;910.5037754423855;965.9661911833088;966.0339660339661;968.70454511374;969.0745338202;970.0445061614339;962.0860182826343;963.0465838819554;963.1716723617683;965.8551217317388;966.9951650241738;707.8938159276098;708.2280314457266;710.9608971506565;711.5908352697168;713.6075158662767;16087.597810054725;16142.354305827752;16148.59628509285;16152.676946461122;16171;14382.640433989129;14498.27508624575;14813.703725925421;14834.480793172188;14847.183404912725;12172.756544869142;12290.139690221687;12345.444454999457;12843.29361885096;12916.547920822726;3830.9233815323537;4034.5561988181275;4052.6352628263303;4117.629413352783;4181.498220213593;100793;123612;123675.76324236822;126569;130575;10728.785424291471;11313.377764222882;11393.544258229744;11419.20065595417;11634.592789252505;23450.530989380117;23464.06143754265;23480.060797568247;23494.88252558726;23508;8269.338452923872;8278.337732981347;8461.95769021151;8700.260477859452;8723.258523025486;4631.8378856739855;4637.86086417408;4720.362751028636;4791.760411979387;4855.32025516428;3711.3319602471815;3821.2548553032448;3822.9869084692577;3827.827747751358;3836.5396152461885;680.7685386968454;681.3425044831761;699.9965000175068;707.5895980331395;712.8289210589421;567.6367125039977;636.9490440764728;670.4502308107305;707.2326525719652;720.4239188679583;9508.381955172892;9586.760330991781;9744.75638109053;9817.625532425465;9839.950800246095;571.5598988778701;592.9851753706106;627.4353082225941;635.7393468677819;649.6849028221309;4590.14102781628;4821.397325334333;4853.174960256765;4893.559579637849;5040.067587496252;118661;151617;153275;153805.23097384442;156935;135136.32431837975;136262.3186884059;136621.31689341489;136929.3153534226;137023;110368;111081.44459277813;111509;114602.85397146089;115682;9509.619615215313;9513.904860951301;9574.808503830023;9596.76008099803;9597.040295970348;61330.77338453295;61742.69128654328;62097.37902620916;62343.376566233754;62969.68515157395;81361.55915322549;86494.56752716195;87489;92505;95902.5204873999;11853.34806585646;11877.76244475123;12221.205621634565;12229.205101668364;12367.62897113088;12756;12792.6801829955;14091;14259.786103208668;14554.927225363805;11147.442627868411;12860.678483037998;13019.674508137372;13300;13430.328483575977;12229.816552751538;12590.937045314715;12864.163829351062;13311.800322995357;13405.396757146147;12224.266544007389;12620.179688320597;13000.219986800823;13001.674958126123;13332.2667253302;9633.843938727397;10425.739356516147;11022.724431889266;11397.886021139682;11438.370889601152;10394.22043346737;10979.39613321275;11148.55405783792;11221;11235.71910702239 17:29:24 INFO - PROCESS | 1914 | __end_tp_report 17:29:24 INFO - PROCESS | 1914 | __start_cc_report 17:29:24 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,1074 17:29:24 INFO - PROCESS | 1914 | __end_cc_report 17:29:24 INFO - PROCESS | 1914 | __startTimestamp1483406964793__endTimestamp 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | ------- Summary: start ------- 17:29:24 INFO - PROCESS | 1914 | Number of tests: 6 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5758.24 Median:5978.49 stddev:630.75 (10.6%) stddev-sans-first:605.03 17:29:24 INFO - PROCESS | 1914 | Values: 3403.5 3429.6 3436.6 3463.8 3487.1 5732.7 5751.1 5777.5 5804.0 5812.8 5708.5 5752.3 5805.0 5810.7 5813.3 5220.6 5261.7 5283.5 5289.1 5315.0 4172.7 5200.7 5334.3 5335.6 5351.4 5216.0 5231.7 5234.8 5268.2 5282.5 5262.6 5288.7 5289.8 5353.0 5363.4 5215.1 5258.9 5292.8 5297.1 5313.1 5586.1 5631.5 5635.3 5638.7 5658.9 6150.4 6177.4 6180.8 6222.9 6229.3 6258.6 6292.1 6293.7 6297.1 6320.7 5667.3 5700.7 5744.3 5794.5 5818.5 6227.0 6233.5 6236.2 6253.6 6260.6 6169.4 6184.5 6194.2 6205.9 6211.1 6143.2 6170.7 6190.4 6224.6 6269.1 5131.2 6235.5 6249.9 6255.0 6256.3 6186.9 6210.4 6236.9 6273.7 6284.2 4888.7 4893.5 4924.3 4967.0 5002.7 4383.2 4440.6 4452.1 4465.5 4519.7 5789.4 5793.5 5803.7 5804.6 5804.8 6111.6 6254.7 6263.9 6283.4 6308.7 5688.8 5779.9 5835.1 5867.8 5938.5 5404.6 5438.8 5445.5 5460.7 5472.2 6272.6 6281.6 6298.6 6310.3 6313.7 6150.1 6168.5 6202.4 6227.9 6256.4 6281.7 6281.7 6297.8 6302.1 6305.8 6211.4 6216.0 6226.2 6237.9 6252.1 6070.0 6154.8 6192.9 6213.8 6260.4 5366.8 5788.1 6141.5 6157.7 6185.0 5978.5 6163.7 6174.4 6175.3 6183.4 5835.5 5891.5 5940.8 5953.2 6017.8 6099.9 6171.2 6184.2 6202.0 6213.5 5986.6 6016.2 6018.3 6037.1 6038.9 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:73983.84 Median:3508.65 stddev:163905.19 (4671.5%) stddev-sans-first:164272.11 17:29:24 INFO - PROCESS | 1914 | Values: 495.3 497.3 510.6 526.1 535.8 32072.7 41866.0 43253.4 43277.6 46009.5 44924.3 45162.8 45224.5 45323.1 45410.8 9995.3 10184.7 10188.1 10192.7 10194.6 9371.8 9561.9 10180.7 12612.2 12649.0 12626.9 12701.8 12702.7 12705.5 12720.3 12568.2 12616.7 12627.9 12652.5 12667.8 12445.3 12534.0 12535.7 12535.9 12548.1 41976.6 42273.4 42284.2 42327.8 42382.0 3378.3 3468.2 3504.8 3535.4 3900.2 30798.0 32338.0 32830.2 32954.9 33369.7 3361.3 3422.3 3427.0 3443.8 3512.5 506142.5 507473.0 507899.0 508679.5 508964.0 64883.4 65377.0 65407.0 65533.7 65624.3 31887.2 36540.0 37140.0 38692.8 38714.4 18026.6 18207.4 18254.9 18266.5 18271.3 12516.6 12692.2 13738.9 13869.3 13917.4 16994.6 19931.0 20340.5 20393.3 20769.5 8174.4 8244.6 8258.3 8282.4 8307.5 875.9 1002.7 1048.1 1059.6 1084.3 31482.5 31650.7 31734.0 32098.8 32316.0 916.4 1184.0 1192.2 1210.2 1235.3 14154.4 15131.7 16576.8 16695.3 16950.6 719021.0 727787.0 728152.0 729239.0 730412.0 61599.4 62123.7 62138.7 62342.1 62574.7 1295.0 1336.1 1409.8 1429.7 1457.0 25490.0 30395.0 31246.7 33179.5 33566.3 53191.0 53916.7 53925.5 54041.0 54084.5 581618.0 581703.0 582711.1 583579.0 584098.1 24982.6 25528.9 27746.9 28402.3 28465.0 49051.8 49480.5 49552.8 49647.0 50089.0 39801.6 40997.0 41002.8 41352.6 42403.8 39524.6 39945.4 40500.2 40937.2 41766.8 38829.0 39294.2 39695.8 39781.8 39904.6 28963.6 33504.7 36059.5 36133.5 36555.6 26533.0 26682.3 26749.6 26979.0 27270.5 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:36788.77 Median:26326.24 stddev:104397.28 (396.6%) stddev-sans-first:104654.26 17:29:24 INFO - PROCESS | 1914 | Values: 331.6 386.4 392.7 403.2 412.0 19701.9 21968.0 22633.0 22660.0 22893.7 17196.6 17720.9 17915.3 22446.4 22540.3 5470.4 5599.4 6032.2 6178.3 6257.3 6142.8 6186.4 6309.2 6311.7 6314.7 6149.1 6220.6 6256.8 6263.9 6264.1 5906.6 6173.3 6240.4 6248.6 6253.8 6126.4 6127.7 6132.3 6140.0 6155.5 14570.8 25558.0 26210.5 26442.0 26634.7 2074.3 2201.9 2333.4 2783.1 2844.7 9767.0 10149.4 10525.3 10638.4 10872.8 1585.0 1751.9 1763.3 1897.8 1956.6 129286.4 133226.0 137101.3 140933.0 143258.0 11510.7 11532.9 11638.5 11643.6 11875.8 13073.5 14488.6 15170.4 15172.8 15206.3 8879.8 8944.2 8951.5 8971.6 9079.2 8923.8 9021.5 9023.8 9029.5 9174.9 3985.2 4560.0 4578.7 4598.2 4705.5 1826.4 1922.5 1929.1 1929.7 1932.7 863.9 913.2 976.2 995.5 1040.0 18128.5 22560.5 22589.8 22617.8 22651.0 965.4 969.0 990.3 993.1 1013.6 8566.9 11028.6 11841.4 11841.4 11866.5 606782.0 612546.0 626074.0 634636.0 636869.0 77724.0 130876.3 132700.0 136327.9 145778.0 991.9 994.0 1041.7 1047.2 1051.4 18939.3 19817.0 20537.3 20565.6 20780.8 57474.4 61077.8 61122.8 61435.7 61746.0 82700.6 83163.0 87408.0 89011.6 90281.0 8030.5 8296.7 8334.7 8489.8 8581.5 9153.7 13101.7 13279.7 13782.1 13798.9 11010.4 11109.5 11428.6 11567.0 11782.9 11375.0 11387.5 11576.6 11584.7 11901.6 11657.7 11713.3 11887.8 11974.0 12050.8 8150.3 8245.1 8406.1 8587.0 8595.2 8272.7 10435.8 11448.8 11580.7 11776.9 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5745.51 Median:4983.55 stddev:3267.80 (65.6%) stddev-sans-first:3259.20 17:29:24 INFO - PROCESS | 1914 | Values: 1212.0 1336.0 1537.6 1697.5 1968.7 8010.6 8535.0 8540.8 8547.0 8550.1 8316.1 8741.0 8895.0 8983.3 9098.0 2391.6 2420.7 2421.8 2425.0 2428.8 2369.5 2389.5 2413.8 2414.6 2417.3 2370.6 2403.6 2405.0 2406.3 2415.0 2353.8 2379.0 2385.2 2388.2 2402.2 2039.7 2321.3 2382.4 2387.2 2388.1 8914.9 8987.1 9067.0 9067.1 9074.5 5357.2 5365.8 5518.7 5522.4 5528.9 3558.9 3659.8 3661.5 3662.0 3670.2 1068.6 1081.9 1104.1 1112.6 1114.3 11937.5 12036.8 12045.4 12049.2 12056.4 3911.5 4559.4 4601.4 4637.1 4682.6 9206.6 9210.8 9222.4 9223.9 9241.0 5311.7 5322.9 5324.9 5327.1 5346.9 4310.9 4583.4 4713.5 5002.7 5033.1 3058.8 3863.7 3963.6 3974.0 3980.2 1155.8 1179.5 1180.7 1194.7 1194.8 756.3 860.4 908.1 914.0 931.8 5587.7 5667.7 5756.6 5808.7 6078.5 918.0 938.4 952.8 986.8 1019.7 3397.0 3724.9 3842.9 3857.5 3989.1 10642.2 11115.2 11129.8 11132.8 11137.2 11079.8 11083.8 11097.2 11106.1 11120.7 8472.6 8504.8 8616.8 8629.8 8640.0 5723.2 5724.3 5780.4 5917.6 5929.7 10006.9 10141.8 10246.3 10300.8 10304.9 9648.5 9930.5 10358.7 10583.5 10600.3 6932.6 7039.3 7254.9 7334.6 7345.1 8364.6 8496.2 8577.9 8721.3 8734.2 7609.0 7677.6 7705.4 7720.0 7746.1 6290.9 7563.3 7620.1 7663.2 7674.2 6873.2 6997.9 7107.4 7181.0 7182.2 4964.4 5003.5 5020.1 5026.6 5059.3 4859.1 4929.4 4940.8 5065.0 5077.9 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4462.11 Median:5044.55 stddev:1410.88 (28.0%) stddev-sans-first:1379.07 17:29:24 INFO - PROCESS | 1914 | Values: 256.0 306.1 310.5 315.7 320.8 5118.7 5367.7 5389.3 5412.8 5424.7 5124.0 5256.2 5272.2 5303.9 5314.7 4088.0 4121.0 4126.4 4126.9 4127.3 3114.8 4048.0 4137.2 4140.5 4153.4 3526.8 3977.2 4033.2 4046.9 4071.0 3313.0 4039.0 4043.4 4047.8 4082.3 2740.3 3491.7 3498.3 3519.7 3538.5 4222.1 4694.2 4761.6 5165.4 5177.8 4118.8 4616.9 4629.7 4656.2 4659.6 5076.5 5556.6 5623.4 5653.3 5666.6 3354.6 3520.5 3648.0 3707.6 3813.7 4781.6 5346.9 5816.8 5817.2 5829.8 3858.5 3888.6 3890.9 3917.8 3933.8 3031.5 3638.2 3647.8 3650.5 3750.7 3826.9 4183.5 4591.4 4594.5 4617.5 4874.7 5027.6 5648.4 5660.4 5697.8 1027.7 1308.5 1313.7 1327.1 1333.8 873.5 878.3 890.3 904.2 916.8 4204.9 4430.7 5322.6 5336.4 5337.9 5235.9 5669.0 5696.5 5719.7 5726.3 4589.0 4704.9 5123.6 5274.7 5316.3 2106.9 2347.5 2494.8 2541.7 2548.9 4901.2 4983.6 5018.2 5022.6 5091.6 4135.8 4258.9 4340.7 4381.0 4947.1 5755.5 6052.7 6058.2 6069.6 6075.4 5307.7 5837.9 5838.6 5876.1 5889.7 5061.5 5743.2 5764.4 5769.7 5862.4 5766.8 5894.6 5955.3 5965.6 6048.7 3500.1 3881.5 3905.0 3951.7 3964.6 5090.9 5281.1 5522.6 5668.9 5818.6 4824.4 5124.2 5518.0 5646.8 5718.5 5192.7 5658.6 5667.9 5671.8 5676.8 5252.7 5460.6 5504.9 5549.6 5560.9 4878.4 5131.7 5395.5 5513.7 5640.6 5103.0 5524.6 5548.4 5565.5 5596.2 17:29:24 INFO - PROCESS | 1914 | 17:29:24 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:25514.76 Median:3822.12 stddev:40752.96 (1066.2%) stddev-sans-first:40824.41 17:29:24 INFO - PROCESS | 1914 | Values: 620.8 797.5 814.1 825.1 834.2 15812.4 16864.7 16883.2 16905.2 17688.3 16936.2 17377.5 17631.7 17639.9 17650.4 894.1 923.0 923.2 923.5 925.0 728.1 745.9 882.6 905.0 910.5 966.0 966.0 968.7 969.1 970.0 962.1 963.0 963.2 965.9 967.0 707.9 708.2 711.0 711.6 713.6 16087.6 16142.4 16148.6 16152.7 16171.0 14382.6 14498.3 14813.7 14834.5 14847.2 12172.8 12290.1 12345.4 12843.3 12916.5 3830.9 4034.6 4052.6 4117.6 4181.5 100793.0 123612.0 123675.8 126569.0 130575.0 10728.8 11313.4 11393.5 11419.2 11634.6 23450.5 23464.1 23480.1 23494.9 23508.0 8269.3 8278.3 8462.0 8700.3 8723.3 4631.8 4637.9 4720.4 4791.8 4855.3 3711.3 3821.3 3823.0 3827.8 3836.5 680.8 681.3 700.0 707.6 712.8 567.6 636.9 670.5 707.2 720.4 9508.4 9586.8 9744.8 9817.6 9840.0 571.6 593.0 627.4 635.7 649.7 4590.1 4821.4 4853.2 4893.6 5040.1 118661.0 151617.0 153275.0 153805.2 156935.0 135136.3 136262.3 136621.3 136929.3 137023.0 110368.0 111081.4 111509.0 114602.9 115682.0 9509.6 9513.9 9574.8 9596.8 9597.0 61330.8 61742.7 62097.4 62343.4 62969.7 81361.6 86494.6 87489.0 92505.0 95902.5 11853.3 11877.8 12221.2 12229.2 12367.6 12756.0 12792.7 14091.0 14259.8 14554.9 11147.4 12860.7 13019.7 13300.0 13430.3 12229.8 12590.9 12864.2 13311.8 13405.4 12224.3 12620.2 13000.2 13001.7 13332.3 9633.8 10425.7 11022.7 11397.9 11438.4 10394.2 10979.4 11148.6 11221.0 11235.7 17:29:24 INFO - PROCESS | 1914 | -------- Summary: end -------- 17:29:24 INFO - PROCESS | 1914 | 17:29:25 INFO - TEST-INFO | 1914: exit 0 17:29:25 INFO - TEST-OK | dromaeo_css | took 1114468ms 17:29:25 INFO - TEST-START | kraken 17:29:25 INFO - operating with platform_type : mac_ 17:29:25 INFO - Initialising browser for kraken test... 17:29:25 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpveWuG6/profile http://localhost:52436/getInfo.html) 17:29:27 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 17:29:27 INFO - PROCESS | 1917 | colorDepth:24 17:29:27 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 17:29:27 INFO - PROCESS | 1917 | __metrics 17:29:27 INFO - PROCESS | 1917 | 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" 17:29:27 INFO - PROCESS | 1917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:28 INFO - TEST-INFO | 1917: exit 0 17:29:28 INFO - Browser initialized. 17:29:28 INFO - Running cycle 1/1 for kraken test... 17:29:28 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpveWuG6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:40 INFO - PROCESS | 1919 | RSS: Main: 168697856 17:29:40 INFO - PROCESS | 1919 | 17:29:42 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:43 INFO - PROCESS | 1919 | RSS: Main: 218370048 17:29:43 INFO - PROCESS | 1919 | 17:29:46 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-dft) 17:29:46 INFO - PROCESS | 1919 | RSS: Main: 232173568 17:29:46 INFO - PROCESS | 1919 | 17:29:49 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-fft) 17:29:50 INFO - PROCESS | 1919 | RSS: Main: 330121216 17:29:50 INFO - PROCESS | 1919 | 17:29:52 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52436/tests/kraken/driver.html?testName=audio-oscillator) 17:29:53 INFO - PROCESS | 1919 | RSS: Main: 229322752 17:29:53 INFO - PROCESS | 1919 | 17:29:55 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:55 INFO - PROCESS | 1919 | RSS: Main: 229638144 17:29:55 INFO - PROCESS | 1919 | 17:29:58 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:59 INFO - PROCESS | 1919 | RSS: Main: 266567680 17:29:59 INFO - PROCESS | 1919 | 17:30:01 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52436/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:02 INFO - PROCESS | 1919 | RSS: Main: 268128256 17:30:02 INFO - PROCESS | 1919 | 17:30:05 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52436/tests/kraken/driver.html?testName=json-parse-financial) 17:30:06 INFO - PROCESS | 1919 | RSS: Main: 265285632 17:30:06 INFO - PROCESS | 1919 | 17:30:07 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:08 INFO - PROCESS | 1919 | RSS: Main: 240160768 17:30:08 INFO - PROCESS | 1919 | 17:30:10 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:10 INFO - PROCESS | 1919 | RSS: Main: 246444032 17:30:10 INFO - PROCESS | 1919 | 17:30:12 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:13 INFO - PROCESS | 1919 | RSS: Main: 251359232 17:30:13 INFO - PROCESS | 1919 | 17:30:16 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:17 INFO - PROCESS | 1919 | RSS: Main: 258281472 17:30:17 INFO - PROCESS | 1919 | 17:30:19 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:20 INFO - PROCESS | 1919 | RSS: Main: 258846720 17:30:20 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52436/tests/kraken/driver.html?testName=ai-astar) 17:30:22 INFO - PROCESS | 1919 | RSS: Main: 303157248 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | __start_tp_report 17:30:22 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 17:30:22 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 17:30:22 INFO - PROCESS | 1919 | |i|pagename|runs| 17:30:22 INFO - PROCESS | 1919 | |0;ai-astar;114;112;112;111;113;113;111;113;112;112 17:30:22 INFO - PROCESS | 1919 | |1;audio-beat-detection;144;108;109;141;109;113;110;112;169;136 17:30:22 INFO - PROCESS | 1919 | |2;audio-dft;183;185;182;184;185;181;182;183;182;183 17:30:22 INFO - PROCESS | 1919 | |3;audio-fft;79;61;73;112;86;60;58;58;81;57 17:30:22 INFO - PROCESS | 1919 | |4;audio-oscillator;85;71;95;68;68;70;121;98;100;90 17:30:22 INFO - PROCESS | 1919 | |5;imaging-gaussian-blur;90;87;90;87;89;86;91;87;89;85 17:30:22 INFO - PROCESS | 1919 | |6;imaging-darkroom;98;97;98;98;98;98;98;97;98;97 17:30:22 INFO - PROCESS | 1919 | |7;imaging-desaturate;88;86;84;85;86;87;83;100;134;135 17:30:22 INFO - PROCESS | 1919 | |8;json-parse-financial;56;55;55;55;58;58;58;59;58;57 17:30:22 INFO - PROCESS | 1919 | |9;json-stringify-tinderbox;63;71;69;73;69;67;69;69;69;70 17:30:22 INFO - PROCESS | 1919 | |10;stanford-crypto-aes;85;82;87;85;83;81;87;87;99;90 17:30:22 INFO - PROCESS | 1919 | |11;stanford-crypto-ccm;136;135;135;134;135;144;165;152;148;144 17:30:22 INFO - PROCESS | 1919 | |12;stanford-crypto-pbkdf2;160;161;179;209;163;178;160;163;160;159 17:30:22 INFO - PROCESS | 1919 | |13;stanford-crypto-sha256-iterative;67;64;67;65;66;66;66;65;65;65 17:30:22 INFO - PROCESS | 1919 | __end_tp_report 17:30:22 INFO - PROCESS | 1919 | __start_cc_report 17:30:22 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1836 17:30:22 INFO - PROCESS | 1919 | __end_cc_report 17:30:22 INFO - PROCESS | 1919 | __startTimestamp1483407022399__endTimestamp 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | ------- Summary: start ------- 17:30:22 INFO - PROCESS | 1919 | Number of tests: 14 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:0.95 (0.8%) stddev-sans-first:0.78 17:30:22 INFO - PROCESS | 1919 | Values: 114.0 112.0 112.0 111.0 113.0 113.0 111.0 113.0 112.0 112.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:124.50 stddev:21.12 (17.0%) stddev-sans-first:21.26 17:30:22 INFO - PROCESS | 1919 | Values: 144.0 108.0 109.0 141.0 109.0 113.0 110.0 112.0 169.0 136.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.33 (0.7%) stddev-sans-first:1.41 17:30:22 INFO - PROCESS | 1919 | Values: 183.0 185.0 182.0 184.0 185.0 181.0 182.0 183.0 182.0 183.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#3] audio-fft Cycles:10 Average:72.50 Median:67.00 stddev:17.66 (26.4%) stddev-sans-first:18.57 17:30:22 INFO - PROCESS | 1919 | Values: 79.0 61.0 73.0 112.0 86.0 60.0 58.0 58.0 81.0 57.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:78.00 stddev:17.60 (22.6%) stddev-sans-first:18.66 17:30:22 INFO - PROCESS | 1919 | Values: 85.0 71.0 95.0 68.0 68.0 70.0 121.0 98.0 100.0 90.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:1.97 (2.2%) stddev-sans-first:1.96 17:30:22 INFO - PROCESS | 1919 | Values: 90.0 87.0 90.0 87.0 89.0 86.0 91.0 87.0 89.0 85.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:98.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:30:22 INFO - PROCESS | 1919 | Values: 98.0 97.0 98.0 98.0 98.0 98.0 98.0 97.0 98.0 97.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:85.50 stddev:20.42 (23.9%) stddev-sans-first:21.41 17:30:22 INFO - PROCESS | 1919 | Values: 88.0 86.0 84.0 85.0 86.0 87.0 83.0 100.0 134.0 135.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:1.52 (2.6%) stddev-sans-first:1.58 17:30:22 INFO - PROCESS | 1919 | Values: 56.0 55.0 55.0 55.0 58.0 58.0 58.0 59.0 58.0 57.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:2.60 (3.8%) stddev-sans-first:1.67 17:30:22 INFO - PROCESS | 1919 | Values: 63.0 71.0 69.0 73.0 69.0 67.0 69.0 69.0 69.0 70.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:5.13 (5.9%) stddev-sans-first:5.40 17:30:22 INFO - PROCESS | 1919 | Values: 85.0 82.0 87.0 85.0 83.0 81.0 87.0 87.0 99.0 90.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:144.00 stddev:10.08 (7.0%) stddev-sans-first:10.38 17:30:22 INFO - PROCESS | 1919 | Values: 136.0 135.0 135.0 134.0 135.0 144.0 165.0 152.0 148.0 144.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:163.00 stddev:15.85 (9.7%) stddev-sans-first:16.45 17:30:22 INFO - PROCESS | 1919 | Values: 160.0 161.0 179.0 209.0 163.0 178.0 160.0 163.0 160.0 159.0 17:30:22 INFO - PROCESS | 1919 | 17:30:22 INFO - PROCESS | 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 17:30:22 INFO - PROCESS | 1919 | Values: 67.0 64.0 67.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 17:30:22 INFO - PROCESS | 1919 | -------- Summary: end -------- 17:30:22 INFO - PROCESS | 1919 | 17:30:23 INFO - TEST-INFO | 1919: exit 0 17:30:23 INFO - TEST-OK | kraken | took 57741ms 17:30:23 INFO - SUITE-END | took 1172s 17:30:23 INFO - Completed test suite (00:19:32) 17:30:23 INFO - javascript benchmark 17:30:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.489476578514, 3429.5713035870513, 3436.5532480777497, 3463.844127014284, 3487.145649315918, 5732.713364331782, 5751.137329400592, 5777.508911742497, 5804.0, 5812.796552120677, 5708.514776244014, 5752.28096487939, 5804.970975145118, 5810.738516766745, 5813.30240371155, 5220.556252718514, 5261.657992230512, 5283.524482796547, 5289.127293996486, 5315.016721906441, 4172.7496350218935, 5200.661956972804, 5334.306540149794, 5335.626506144571, 5351.384590772052, 5216.035033518792, 5231.712255825928, 5234.842954711365, 5268.157094864822, 5282.471752824706, 5262.578993680497, 5288.709120998344, 5289.814856480043, 5353.0, 5363.356397232357, 5215.087359712035, 5258.868528286824, 5292.761825717852, 5297.073012222884, 5313.07021271276, 5586.078297080977, 5631.549476041907, 5635.323761148688, 5638.689872057035, 5658.943410565883, 6150.415710507495, 6177.3822617738315, 6180.825643127836, 6222.906656400158, 6229.345918678564, 6258.624482531062, 6292.087647291163, 6293.748250069992, 6297.149884765589, 6320.74717011319, 5667.291588551472, 5700.743466544015, 5744.310682718101, 5794.536437085023, 5818.5345172386105, 6227.0, 6233.532485063638, 6236.158118654014, 6253.624782513064, 6260.5617606768, 6169.413905678954, 6184.474319682878, 6194.163787888668, 6205.875882482325, 6211.09939058834, 6143.174139895608, 6170.691465426711, 6190.350013248544, 6224.595401298991, 6269.122322874801, 5131.179011358165, 6235.532335074888, 6249.875002499924, 6255.0, 6256.343083976208, 6186.876262474725, 6210.4100110490335, 6236.875262494725, 6273.686315684197, 6284.214473190851, 4888.731119788375, 4893.535114164149, 4924.285978533093, 4966.9817687374, 5002.699838009731, 4383.167198232326, 4440.600345968878, 4452.109578084396, 4465.531119232499, 4519.683622146484, 5789.421057894177, 5793.507551858055, 5803.651780893076, 5804.622699524602, 5804.767809287581, 6111.622125543816, 6254.749810007549, 6263.937360626335, 6283.43449089575, 6308.716107775161, 5688.800891968761, 5779.930712818142, 5835.124731290341, 5867.794627188028, 5938.495227905676, 5404.594655400782, 5438.782448702008, 5445.455454454523, 5460.672359658433, 5472.151816468454, 6272.560920735596, 6281.59169653971, 6298.622082675054, 6310.305866354789, 6313.684315784192, 6150.077488376779, 6168.506519478341, 6202.4417802398, 6227.906581401192, 6256.405641464054, 6281.654509002049, 6281.685915704288, 6297.779577714758, 6302.1492098566105, 6305.8108256752375, 6211.440970312694, 6215.96892015537, 6226.159468471698, 6237.906431403442, 6252.124702541557, 6069.969650151721, 6154.846128846814, 6192.907106393318, 6213.782517612042, 6260.436560709558, 5366.838994830161, 5788.102844059177, 6141.455323060992, 6157.692115394302, 6184.969075154595, 5978.491828194652, 6163.722632481459, 6174.351693072163, 6175.320714721467, 6183.443490085914, 5835.503982161564, 5891.49922256613, 5940.762369505172, 5953.166556681981, 6017.759289628366, 6099.939000610115, 6171.197744293213, 6184.165137706352, 6202.038684003986, 6213.502919766498, 5986.610870293417, 6016.157737916783, 6018.2778066630535, 6037.09443583466, 6038.909416358846], "value": 5719.200952195125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.341196209042, 497.2814283360543, 510.5532658923443, 526.1292560811855, 535.8419266316433, 32072.67927320729, 41866.0, 43253.35119973195, 43277.567224327744, 46009.53990460094, 44924.326135108, 45162.77418612911, 45224.54775452244, 45323.093538129215, 45410.77294613531, 9995.250356223276, 10184.74538136545, 10188.083072523472, 10192.745181370488, 10194.59221631134, 9371.812563748721, 9561.904380956172, 10180.694579162637, 12612.180208286478, 12649.0, 12626.873731262707, 12701.809472857914, 12702.745945081093, 12705.491780328775, 12720.300383478905, 12568.183068100545, 12616.74766504674, 12627.92662623678, 12652.493900243979, 12667.809982850265, 12445.25328480294, 12534.0, 12535.749285014248, 12535.874641253562, 12548.1216314858, 41976.58023419757, 42273.36589951153, 42284.15431691349, 42327.78836105831, 42382.0, 3378.3074469733647, 3468.150303175738, 3504.8072356020407, 3535.4166562517153, 3900.2199560088097, 30798.0, 32338.0, 32830.17924551881, 32954.884377547554, 33369.666303337144, 3361.31937026427, 3422.3155368926314, 3427.0, 3443.7933723976644, 3512.4906888501278, 506142.4692876549, 507473.0, 507899.0, 508679.45660271833, 508964.0, 64883.351166488676, 65377.0, 65407.0, 65533.67233163804, 65624.34375656182, 31887.202819929687, 36540.0, 37140.0, 38692.80653596714, 38714.41928371077, 18026.63946721058, 18207.362742303954, 18254.908725456553, 18266.543336416697, 18271.26914923388, 12516.624501264976, 12692.238465692088, 13738.86261137376, 13869.306534673226, 13917.373718182705, 16994.575135621708, 19931.003449827742, 20340.49148771263, 20393.286234981704, 20769.480762980744, 8174.386920980831, 8244.5891448075, 8258.339332853357, 8282.378821588405, 8307.543085130375, 875.916787905148, 1002.684154491333, 1048.1457612046158, 1059.645018918671, 1084.2952081147316, 31482.527762083588, 31650.683493165234, 31734.0, 32098.83950580232, 32316.0, 916.3631276263067, 1183.9704007399885, 1192.2131393280567, 1210.152892974921, 1235.3144005077088, 14154.433822647185, 15131.686813432423, 16576.83423165753, 16695.33218671264, 16950.57623559421, 719021.0, 727787.0, 728152.0, 729239.0, 730412.0, 61599.384006159366, 62123.6893815528, 62138.68930655318, 62342.064869027, 62574.68712656499, 1294.9741005180033, 1336.0580790542838, 1409.7673883809057, 1429.6640289531952, 1457.016513853166, 25490.0, 30395.0, 31246.68753312529, 33179.50230746492, 33566.328673426884, 53191.0, 53916.730416347666, 53925.46074539205, 54041.0, 54084.459155407945, 581618.0, 581703.0, 582711.0864445651, 583579.0, 584098.0795095997, 24982.62526062147, 25528.872355638847, 27746.861265693544, 28402.289942751595, 28465.0, 49051.773705657644, 49480.50519494759, 49552.752236238586, 49647.00705985932, 50088.998220034664, 39801.601983980945, 40997.0, 41002.79498602607, 41352.58647413487, 42403.7879810599, 39524.604753952095, 39945.40081898716, 40500.1899962005, 40937.18125637411, 41766.791166045194, 38829.02927426837, 39294.214115718096, 39695.80152099221, 39781.80109099436, 39904.60095399009, 28963.565546517242, 33504.664953350155, 36059.45910811392, 36133.45799813057, 36555.634443655224, 26533.0, 26682.332941676614, 26749.598756019066, 26979.0, 27270.454590908466], "value": 21126.832993001823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.61035782955025, 386.3991493228031, 392.67408051317403, 403.1936127744511, 412.03789152329307, 19701.91639459829, 21968.01143948522, 22633.0, 22660.0, 22893.656595151086, 17196.570085747862, 17720.911395443036, 17915.28338866447, 22446.438839029033, 22540.32379028632, 5470.384144971686, 5599.440055994409, 6032.245969253832, 6178.25860896693, 6257.280412752523, 6142.84642883927, 6186.381361863822, 6309.242890853081, 6311.715972781213, 6314.684265786692, 6149.077638354261, 6220.595661282025, 6256.843578910518, 6263.906041409383, 6264.123022776815, 5906.645601263895, 6173.2900716417735, 6240.43836054755, 6248.625082495065, 6253.781117660883, 6126.417990290915, 6127.662978536178, 6132.264128304632, 6140.048292514667, 6155.476784473325, 14570.781438278435, 25558.0, 26210.475790484274, 26442.0, 26634.73365266342, 2074.3362124120285, 2201.8678879267295, 2333.369990102663, 2783.0954939644494, 2844.687084420712, 9766.951165244129, 10149.441780702058, 10525.263231573794, 10638.361698298128, 10872.782544349147, 1584.9603759905979, 1751.9313218936438, 1763.3211213682825, 1897.7817550981677, 1956.5597740508272, 129286.3535682325, 133226.0, 137101.3144934279, 140933.0, 143258.0, 11510.712232194095, 11532.94233528827, 11638.534458621729, 11643.592474263529, 11875.762484750257, 13073.477060917647, 14488.565343039725, 15170.393184272505, 15172.848271517365, 15206.315715792816, 8879.778005549784, 8944.195022448012, 8951.507667078373, 8971.641134354682, 9079.228265597367, 8923.821523569492, 9021.503817290111, 9023.774405639911, 9029.458232506071, 9174.908250917539, 3985.2228815381304, 4559.9772001140445, 4578.6794924355645, 4598.172328980749, 4705.4588722296685, 1826.3699023836755, 1922.4713203869048, 1929.1029671202677, 1929.6816025355658, 1932.652122617914, 863.9481631102154, 913.196387179278, 976.1751320134475, 995.4922989275522, 1040.0275742181084, 18128.546786330448, 22560.548789024127, 22589.774102259096, 22617.773822261897, 22650.980705867947, 965.3918031640162, 968.9854652180223, 990.2622546203124, 993.1210878372548, 1013.6198925402974, 8566.914330856736, 11028.558857645605, 11841.407929603485, 11841.407929603485, 11866.525338986516, 606782.0, 612546.0, 626074.0, 634636.0, 636869.0, 77724.0, 130876.3456182713, 132700.0, 136327.91016269528, 145778.0, 991.8710567626163, 993.9751506212402, 1041.7447725307347, 1047.1727335405096, 1051.4374809476892, 18939.33712320062, 19817.0, 20537.31343283582, 20565.588688225853, 20780.79219207849, 57474.42525574858, 61077.77844443175, 61122.77754444975, 61435.69282153561, 61745.9999999982, 82700.58649706712, 83163.0, 87408.0, 89011.55494222487, 90281.0, 8030.5181689098845, 8296.70961516344, 8334.708285209988, 8489.83020339602, 8581.528015959182, 9153.679621213225, 13101.672458188621, 13279.66800829987, 13782.104163229758, 13798.862011380159, 11010.449477526252, 11109.500072496596, 11428.599998999995, 11567.0, 11782.941085294518, 11375.0, 11387.487563059516, 11576.594819181288, 11584.652460426201, 11901.583444579745, 11657.650270491898, 11713.297202167898, 11887.821682674594, 11974.0, 12050.819237711266, 8150.307223886036, 8245.093039765741, 8406.075331713384, 8586.957065214634, 8595.18345757152, 8272.710455134042, 10435.791284174426, 11448.771024579295, 11580.6525804226, 11776.88223117792], "value": 9907.249934151558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.9515219391226, 1336.0113515998164, 1537.561794888457, 1697.4822679082883, 1968.6948522978935, 8010.5594192319395, 8535.0, 8540.829183416328, 8546.957265213681, 8550.144985501447, 8316.1268066853, 8740.956295218532, 8895.0, 8983.281337493001, 9097.999220085801, 2391.5814732421845, 2420.685310909579, 2421.7699318564796, 2425.0178677635586, 2428.805695544352, 2369.514249578841, 2389.462370966536, 2413.81896357773, 2414.5653782319177, 2417.2627348658652, 2370.5614461324626, 2403.591389463795, 2404.9759502404927, 2406.2781165650235, 2414.987925060372, 2353.7763912428463, 2378.9762102378927, 2385.2128797496785, 2388.1522059668914, 2402.2192787344184, 2039.6736522156532, 2321.303608917318, 2382.4163080045328, 2387.1883559589824, 2388.10446082719, 8914.86627700585, 8987.056359082268, 9067.0, 9067.138621830916, 9074.502707053329, 5357.249985002103, 5365.839024829262, 5518.696471694056, 5522.3649280332875, 5528.944710552883, 3558.9110272243142, 3659.780413175218, 3661.505696730934, 3661.963380366189, 3670.1742108025746, 1068.615298492542, 1081.9134469242442, 1104.127739086121, 1112.5772206561535, 1114.2812885688766, 11937.462814173383, 12036.759264814742, 12045.39773011346, 12049.216800908001, 12056.397180141046, 3911.4523966644692, 4559.361689363492, 4601.4248218972625, 4637.1421287062, 4682.555157260055, 9206.585703643352, 9210.815783684422, 9222.400543964755, 9223.89313282397, 9241.0, 5311.654742441729, 5322.893542129135, 5324.946750532445, 5327.121025030904, 5346.893062138814, 4310.913781724411, 4583.449986001701, 4713.481517033124, 5002.724850133278, 5033.0688822567945, 3058.7552995760284, 3863.7102217333813, 3963.6432721055244, 3974.0, 3980.184062267286, 1155.8324043013715, 1179.5340840368006, 1180.698921774959, 1194.7491026884452, 1194.7670204310075, 756.2890882570366, 860.3848248502351, 908.0737647599411, 913.9725808225763, 931.7903471718809, 5587.664740115606, 5667.716614169358, 5756.625819321731, 5808.680522571215, 6078.45293923549, 917.9541022948825, 938.3666025432942, 952.766572189804, 986.7582442301682, 1019.658414431159, 3397.0, 3724.851005959731, 3842.9047721399265, 3857.479240302523, 3989.082511022481, 10642.201834862417, 11115.221934464671, 11129.833052504218, 11132.777344453227, 11137.164712646583, 11079.778404432027, 11083.778324433628, 11097.223194376316, 11106.111511079094, 11120.666380008613, 8472.576371181416, 8504.829903401896, 8616.78458038554, 8629.784255393666, 8639.95680021596, 5723.198752174782, 5724.284464441945, 5780.393058728773, 5917.615355001911, 5929.733162007807, 10006.899931000597, 10141.797164056825, 10246.333988290737, 10300.793984120426, 10304.948475257575, 9648.517574121406, 9930.503474826375, 10358.689239322832, 10583.5237414315, 10600.257981941499, 6932.61870597122, 7039.331263529956, 7254.927450725425, 7334.633268336668, 7345.081864766904, 8364.581770911553, 8496.235338819535, 8577.8713319299, 8721.302295816193, 8734.21392074691, 7608.961955190189, 7677.61611919413, 7705.42209334291, 7719.996400468128, 7746.070471543451, 6290.905636415366, 7563.281488258606, 7620.123685776207, 7663.233676632292, 7674.232576742281, 6873.175218973755, 6997.895031574632, 7107.360337569644, 7181.0, 7182.17404998411, 4964.379452568429, 5003.54968052877, 5020.096382651158, 5026.572741317029, 5059.266406371129, 4859.125357435695, 4929.383827021622, 4940.802367905244, 5065.037642847995, 5077.898442031213], "value": 4594.516051315184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.9731228221037, 306.0741257695472, 310.54815243820235, 315.68431568431566, 320.7578278399808, 5118.692878427297, 5367.731613419328, 5389.272448219489, 5412.837614871555, 5424.674519528831, 5124.0, 5256.159014557672, 5272.23552584876, 5303.946960530394, 5314.734263286839, 4087.9591204087874, 4121.031557583965, 4126.381042843567, 4126.938095928564, 4127.349060375844, 3114.8286844223558, 4048.0487085534874, 4137.193247316774, 4140.503139623234, 4153.418521407006, 3526.770759900598, 3977.2045590881794, 4033.1731994941115, 4046.8988275293204, 4070.9796451017705, 3312.950305745416, 4039.0, 4043.4122161816463, 4047.7773722445254, 4082.2856000199845, 2740.328619488238, 3491.6508349165133, 3498.335316289922, 3519.732896157381, 3538.5046093546666, 4222.113356195172, 4694.192735796709, 4761.59526440253, 5165.431802501722, 5177.844664660066, 4118.775861035037, 4616.884577885546, 4629.745364004978, 4656.185167595691, 4659.62722982164, 5076.522582031321, 5556.555475561945, 5623.437656234385, 5653.293338332708, 5666.583354161459, 3354.579989483172, 3520.4510015593055, 3647.963520364789, 3707.5540539189738, 3813.733038687293, 4781.593564547018, 5346.914703265729, 5816.82549523515, 5817.156512305734, 5829.842958105528, 3858.5176852893387, 3888.580668056139, 3890.8832735017995, 3917.7845218512684, 3933.8033098344968, 3031.5301128325145, 3638.199596088856, 3647.835847386874, 3650.5071815305123, 3750.737448378642, 3826.9234615307537, 4183.514852227477, 4591.44902611682, 4594.450080205451, 4617.538246175355, 4874.731889746027, 5027.572656324181, 5648.435156484319, 5660.433956604389, 5697.800576979868, 1027.7482016905906, 1308.483149156078, 1313.7438199551186, 1327.1174668845304, 1333.8399392073013, 873.5195642396784, 878.3236907581254, 890.2699786175403, 904.2088172848757, 916.8074704312036, 4204.8528301509305, 4430.667699922518, 5322.574194064466, 5336.359636843604, 5337.946620533823, 5235.869103272448, 5669.0, 5696.487316141567, 5719.742611582489, 5726.3128424588485, 4589.0, 4704.894769452214, 5123.590112790967, 5274.7098909560345, 5316.308879845596, 2106.873587584719, 2347.5070235250787, 2494.8128890333296, 2541.7458254174435, 2548.9362765931, 4901.162064225915, 4983.6013118950395, 5018.157478033715, 5022.648414611015, 5091.618128640367, 4135.7518548887165, 4258.87223383299, 4340.696151269381, 4380.991392875547, 4947.14122984073, 5755.510781583528, 6052.66710330936, 6058.242719660043, 6069.605475644157, 6075.362086980804, 5307.708076055854, 5837.94162058374, 5838.649681019152, 5876.147958546072, 5889.734961926638, 5061.519855270964, 5743.224664670383, 5764.394738552559, 5769.711514424346, 5862.355140934408, 5766.798162064308, 5894.557908156991, 5955.344912059757, 5965.642061476326, 6048.667323297261, 3500.1074725944723, 3881.5342158941107, 3904.96095039046, 3951.683865290712, 3964.623360780721, 5090.898182036264, 5281.098804430479, 5522.6134170607675, 5668.914966275427, 5818.556206393409, 4824.445188803192, 5124.231365295235, 5518.0, 5646.830595082154, 5718.456746609066, 5192.688438693691, 5658.632188907708, 5667.858303542444, 5671.801486948102, 5676.801311954062, 5252.737363131904, 5460.6177567569885, 5504.9449505504435, 5549.611527193058, 5560.944390556043, 4878.438979517401, 5131.740655256054, 5395.541378982673, 5513.696746678971, 5640.605157638925, 5103.0, 5524.596800391842, 5548.448992644791, 5565.495527012779, 5596.188552659923], "value": 4011.4933866258816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8478922663946, 797.5493845977022, 814.0963530481168, 825.0965193113539, 834.2200042959831, 15812.44656437025, 16864.662706745858, 16883.24025418856, 16905.239264233107, 17688.292468301286, 16936.153192340396, 17377.47867563972, 17631.73552396712, 17639.941603503798, 17650.38223662172, 894.1237587164567, 922.9953850230773, 923.2014307623924, 923.5428462910869, 924.958376873039, 728.1407938632411, 745.8582869254824, 882.5675419044654, 904.9819003619924, 910.5037754423855, 965.9661911833088, 966.0339660339661, 968.70454511374, 969.0745338202, 970.0445061614339, 962.0860182826343, 963.0465838819554, 963.1716723617683, 965.8551217317388, 966.9951650241738, 707.8938159276098, 708.2280314457266, 710.9608971506565, 711.5908352697168, 713.6075158662767, 16087.597810054725, 16142.354305827752, 16148.59628509285, 16152.676946461122, 16171.0, 14382.640433989129, 14498.27508624575, 14813.703725925421, 14834.480793172188, 14847.183404912725, 12172.756544869142, 12290.139690221687, 12345.444454999457, 12843.29361885096, 12916.547920822726, 3830.9233815323537, 4034.5561988181275, 4052.6352628263303, 4117.629413352783, 4181.498220213593, 100793.0, 123612.0, 123675.76324236822, 126569.0, 130575.0, 10728.785424291471, 11313.377764222882, 11393.544258229744, 11419.20065595417, 11634.592789252505, 23450.530989380117, 23464.06143754265, 23480.060797568247, 23494.88252558726, 23508.0, 8269.338452923872, 8278.337732981347, 8461.95769021151, 8700.260477859452, 8723.258523025486, 4631.8378856739855, 4637.86086417408, 4720.362751028636, 4791.760411979387, 4855.32025516428, 3711.3319602471815, 3821.2548553032448, 3822.9869084692577, 3827.827747751358, 3836.5396152461885, 680.7685386968454, 681.3425044831761, 699.9965000175068, 707.5895980331395, 712.8289210589421, 567.6367125039977, 636.9490440764728, 670.4502308107305, 707.2326525719652, 720.4239188679583, 9508.381955172892, 9586.760330991781, 9744.75638109053, 9817.625532425465, 9839.950800246095, 571.5598988778701, 592.9851753706106, 627.4353082225941, 635.7393468677819, 649.6849028221309, 4590.14102781628, 4821.397325334333, 4853.174960256765, 4893.559579637849, 5040.067587496252, 118661.0, 151617.0, 153275.0, 153805.23097384442, 156935.0, 135136.32431837975, 136262.3186884059, 136621.31689341489, 136929.3153534226, 137023.0, 110368.0, 111081.44459277813, 111509.0, 114602.85397146089, 115682.0, 9509.619615215313, 9513.904860951301, 9574.808503830023, 9596.76008099803, 9597.040295970348, 61330.77338453295, 61742.69128654328, 62097.37902620916, 62343.376566233754, 62969.68515157395, 81361.55915322549, 86494.56752716195, 87489.0, 92505.0, 95902.5204873999, 11853.34806585646, 11877.76244475123, 12221.205621634565, 12229.205101668364, 12367.62897113088, 12756.0, 12792.6801829955, 14091.0, 14259.786103208668, 14554.927225363805, 11147.442627868411, 12860.678483037998, 13019.674508137372, 13300.0, 13430.328483575977, 12229.816552751538, 12590.937045314715, 12864.163829351062, 13311.800322995357, 13405.396757146147, 12224.266544007389, 12620.179688320597, 13000.219986800823, 13001.674958126123, 13332.2667253302, 9633.843938727397, 10425.739356516147, 11022.724431889266, 11397.886021139682, 11438.370889601152, 10394.22043346737, 10979.39613321275, 11148.55405783792, 11221.0, 11235.71910702239], "value": 8073.292651677228, "unit": "score"}], "name": "dromaeo_css", "value": 7501.155291017282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 112.0, 111.0, 113.0, 113.0, 111.0, 113.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 109.0, 141.0, 109.0, 113.0, 110.0, 112.0, 169.0, 136.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 184.0, 185.0, 181.0, 182.0, 183.0, 182.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 73.0, 112.0, 86.0, 60.0, 58.0, 58.0, 81.0, 57.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 95.0, 68.0, 68.0, 70.0, 121.0, 98.0, 100.0, 90.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 86.0, 91.0, 87.0, 89.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 98.0, 98.0, 98.0, 98.0, 98.0, 97.0, 98.0, 97.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 84.0, 85.0, 86.0, 87.0, 83.0, 100.0, 134.0, 135.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 58.0, 58.0, 58.0, 59.0, 58.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 69.0, 73.0, 69.0, 67.0, 69.0, 69.0, 69.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 87.0, 85.0, 83.0, 81.0, 87.0, 87.0, 99.0, 90.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 135.0, 134.0, 135.0, 144.0, 165.0, 152.0, 148.0, 144.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 179.0, 209.0, 163.0, 178.0, 160.0, 163.0, 160.0, 159.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1452.1, "alertThreshold": 2.0}]} 17:30:23 INFO - Return code: 0 17:30:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:30:23 INFO - # TBPL SUCCESS # 17:30:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:30:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:30:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:30:23 INFO - 2017-01-02 17:30:23.723 screenresolution[1924:18325] starting screenresolution argv=screenresolution get 17:30:23 INFO - 2017-01-02 17:30:23.726 screenresolution[1924:18325] Display 0: 1600x1200x32@60 17:30:23 INFO - 2017-01-02 17:30:23.732 screenresolution[1925:18328] starting screenresolution argv=screenresolution list 17:30:23 INFO - Available Modes on Display 0 17:30:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:30:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:30:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:30:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:30:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:30:23 INFO - Intel Iris: 17:30:23 INFO - Chipset Model: Intel Iris 17:30:23 INFO - Type: GPU 17:30:23 INFO - Bus: Built-In 17:30:23 INFO - VRAM (Dynamic, Max): 1536 MB 17:30:23 INFO - Vendor: Intel (0x8086) 17:30:23 INFO - Device ID: 0x0a2e 17:30:23 INFO - Revision ID: 0x0009 17:30:23 INFO - Displays: 17:30:23 INFO - Display: 17:30:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:30:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:30:23 INFO - Display Serial Number: 1600x1200 60 17:30:23 INFO - Main Display: Yes 17:30:23 INFO - Mirror: Off 17:30:23 INFO - Online: Yes 17:30:23 INFO - Rotation: Supported 17:30:23 INFO - Return code: 0 17:30:23 INFO - Running post-action listener: _resource_record_post_action 17:30:23 INFO - [mozharness: 2017-01-03 01:30:23.973326Z] Finished run-tests step (success) 17:30:23 INFO - Running post-run listener: _resource_record_post_run 17:30:24 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 2531328; Write bytes: 495781888; Read time: 12; Write time: 1557 17:30:24 INFO - TinderboxPrint: CPU usage
53.3% 17:30:24 INFO - TinderboxPrint: I/O read bytes / time
2,531,328 / 12 17:30:24 INFO - TinderboxPrint: I/O write bytes / time
495,781,888 / 1,557 17:30:24 INFO - TinderboxPrint: CPU idle
2,233.8 (46.7%) 17:30:24 INFO - TinderboxPrint: CPU system
957.7 (20.0%) 17:30:24 INFO - TinderboxPrint: CPU user
1,590.1 (33.3%) 17:30:24 INFO - TinderboxPrint: Swap in / out
197,439,488 / 0 17:30:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190302720; Write bytes: 188469248; Read time: 17483; Write time: 405 17:30:24 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 1695744; Write bytes: 296290304; Read time: 9; Write time: 1117 17:30:24 INFO - Running post-run listener: _upload_blobber_files 17:30:24 INFO - Blob upload gear active. 17:30:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:24 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 17:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:26 INFO - (blobuploader) - INFO - Done attempting. 17:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:27 INFO - (blobuploader) - INFO - Done attempting. 17:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:30:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:30 INFO - (blobuploader) - INFO - Done attempting. 17:30:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:30 INFO - Return code: 0 17:30:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2e1f5ce9d2c91907d196fb3fd96c6b98cbdc61b276879c2d1980489056e7bb3fc2c34dcbe321260312bae801a3a210fe7f14388ffb91f8f3e629c3fff4d485", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/298b73b1414e32cd86a2e4d1a0f6be9267473a4b344f02f565475d55e956600e77b8e027549e4bf17e29268e2b99c6f69177ea4f1d73d672d372e3fe0b733362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b18e2636451de063c3dd4a5d53b81d9db859512cda16cf1361a8ae97e6fd8d5106eab89d0473a9c8d64ef4424e9d59025d6258bf7b430ce017be2112848edb82"} 17:30:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:30 INFO - Contents: 17:30:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2e1f5ce9d2c91907d196fb3fd96c6b98cbdc61b276879c2d1980489056e7bb3fc2c34dcbe321260312bae801a3a210fe7f14388ffb91f8f3e629c3fff4d485", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/298b73b1414e32cd86a2e4d1a0f6be9267473a4b344f02f565475d55e956600e77b8e027549e4bf17e29268e2b99c6f69177ea4f1d73d672d372e3fe0b733362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b18e2636451de063c3dd4a5d53b81d9db859512cda16cf1361a8ae97e6fd8d5106eab89d0473a9c8d64ef4424e9d59025d6258bf7b430ce017be2112848edb82"} 17:30:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:30 INFO - Copying logs to upload dir... 17:30:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.894321 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-02 17:30:30.230693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 17:30:30.234193) ========= 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.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2e1f5ce9d2c91907d196fb3fd96c6b98cbdc61b276879c2d1980489056e7bb3fc2c34dcbe321260312bae801a3a210fe7f14388ffb91f8f3e629c3fff4d485", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/298b73b1414e32cd86a2e4d1a0f6be9267473a4b344f02f565475d55e956600e77b8e027549e4bf17e29268e2b99c6f69177ea4f1d73d672d372e3fe0b733362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b18e2636451de063c3dd4a5d53b81d9db859512cda16cf1361a8ae97e6fd8d5106eab89d0473a9c8d64ef4424e9d59025d6258bf7b430ce017be2112848edb82"} build_url:https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/OPYRgE6pTN2d35_A9g06Ew/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e2e1f5ce9d2c91907d196fb3fd96c6b98cbdc61b276879c2d1980489056e7bb3fc2c34dcbe321260312bae801a3a210fe7f14388ffb91f8f3e629c3fff4d485", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/298b73b1414e32cd86a2e4d1a0f6be9267473a4b344f02f565475d55e956600e77b8e027549e4bf17e29268e2b99c6f69177ea4f1d73d672d372e3fe0b733362", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b18e2636451de063c3dd4a5d53b81d9db859512cda16cf1361a8ae97e6fd8d5106eab89d0473a9c8d64ef4424e9d59025d6258bf7b430ce017be2112848edb82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 17:30:30.269793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:30:30.270137) ========= 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.tjINtVAZVh/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.KaxPTWlPPR/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005104 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 17:30:30.319702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 17:30:30.320026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 17:30:30.320398) ========= ========= Total master_lag: 0.26 =========