builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0391 starttime: 1487498700.96 results: success (0) buildid: 20170219004014 builduid: 406c45069d2842258d9cebb1f3fa0d41 revision: 2d8d146df0cf29099265ce354b438a7a97251313 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:00.962451) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:00.962927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:00.963213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:00.991145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:00.991534) ========= 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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-19 02:05:01-- 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% 29.8M=0s 2017-02-19 02:05:01 (29.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.807868 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:01.873180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:01.873552) ========= 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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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.032512 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:01.957005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-19 02:05:01.957407) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d8d146df0cf29099265ce354b438a7a97251313 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d8d146df0cf29099265ce354b438a7a97251313 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-19 02:05:02,076 truncating revision to first 12 chars 2017-02-19 02:05:02,076 Setting DEBUG logging. 2017-02-19 02:05:02,076 attempt 1/10 2017-02-19 02:05:02,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d8d146df0cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-19 02:05:03,614 unpacking tar archive at: mozilla-aurora-2d8d146df0cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.796108 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-19 02:05:03.788065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:03.788375) ========= script_repo_revision: 2d8d146df0cf29099265ce354b438a7a97251313 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:03.788795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:03.789084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-19 02:05:03.862053) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-02-19 02:05:03.863035) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:04 INFO - MultiFileLogger online at 20170219 02:05:04 in /builds/slave/test 02:05:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:05:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:04 INFO - {'append_to_log': False, 02:05:04 INFO - 'base_work_dir': '/builds/slave/test', 02:05:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:05:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:04 INFO - 'branch': 'Mozilla-Aurora', 02:05:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:04 INFO - 'config_files': ('talos/mac_config.py',), 02:05:04 INFO - 'default_actions': ('clobber', 02:05:04 INFO - 'read-buildbot-config', 02:05:04 INFO - 'download-and-extract', 02:05:04 INFO - 'populate-webroot', 02:05:04 INFO - 'create-virtualenv', 02:05:04 INFO - 'install', 02:05:04 INFO - 'run-tests'), 02:05:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:04 INFO - 'download_minidump_stackwalk': True, 02:05:04 INFO - 'download_symbols': 'ondemand', 02:05:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:04 INFO - 'installer_path': 'installer.exe', 02:05:04 INFO - 'log_level': 'info', 02:05:04 INFO - 'log_name': 'talos', 02:05:04 INFO - 'log_to_console': True, 02:05:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:05:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:05:04 INFO - 'opt_config_files': (), 02:05:04 INFO - 'pip_index': False, 02:05:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:05:04 INFO - 'cmd': ('bash', 02:05:04 INFO - '-c', 02:05:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:05:04 INFO - 'enabled': True, 02:05:04 INFO - 'halt_on_failure': False, 02:05:04 INFO - 'name': 'check_screen_resolution'},), 02:05:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:05:04 INFO - 'cmd': ('bash', 02:05:04 INFO - '-c', 02:05:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:05:04 INFO - 'enabled': True, 02:05:04 INFO - 'halt_on_failure': False, 02:05:04 INFO - 'name': 'check_screen_resolution'},), 02:05:04 INFO - 'run_cmd_checks_enabled': True, 02:05:04 INFO - 'sps_profile': False, 02:05:04 INFO - 'sps_profile_interval': 0, 02:05:04 INFO - 'suite': 'dromaeojs', 02:05:04 INFO - 'system_bits': '32', 02:05:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:04 INFO - 'title': 't-yosemite-r7-0391', 02:05:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:04 INFO - 'use_talos_json': True, 02:05:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:04 INFO - 'work_dir': 'build'} 02:05:04 INFO - [mozharness: 2017-02-19 10:05:04.080731Z] Running clobber step. 02:05:04 INFO - Running pre-action listener: _resource_record_pre_action 02:05:04 INFO - Running main action method: clobber 02:05:04 INFO - rmtree: /builds/slave/test/build 02:05:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:06 INFO - Running post-action listener: _resource_record_post_action 02:05:06 INFO - [mozharness: 2017-02-19 10:05:06.560025Z] Finished clobber step (success) 02:05:06 INFO - [mozharness: 2017-02-19 10:05:06.560291Z] Running read-buildbot-config step. 02:05:06 INFO - Running pre-action listener: _resource_record_pre_action 02:05:06 INFO - Running main action method: read_buildbot_config 02:05:06 INFO - Using buildbot properties: 02:05:06 INFO - { 02:05:06 INFO - "project": "", 02:05:06 INFO - "product": "firefox", 02:05:06 INFO - "script_repo_revision": "production", 02:05:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:05:06 INFO - "repository": "", 02:05:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:05:06 INFO - "buildid": "20170219004014", 02:05:06 INFO - "stage_platform": "macosx64", 02:05:06 INFO - "basedir": "/builds/slave/test", 02:05:06 INFO - "nightly_build": "True", 02:05:06 INFO - "buildnumber": 6, 02:05:06 INFO - "slavename": "t-yosemite-r7-0391", 02:05:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:05:06 INFO - "platform": "yosemite_r7", 02:05:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:05:06 INFO - "branch": "mozilla-aurora", 02:05:06 INFO - "repo_path": "releases/mozilla-aurora", 02:05:06 INFO - "revision": "2d8d146df0cf29099265ce354b438a7a97251313", 02:05:06 INFO - "pgo_build": "False", 02:05:06 INFO - "builduid": "406c45069d2842258d9cebb1f3fa0d41", 02:05:06 INFO - "slavebuilddir": "test" 02:05:06 INFO - } 02:05:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:05:06 INFO - Running post-action listener: _resource_record_post_action 02:05:06 INFO - [mozharness: 2017-02-19 10:05:06.566194Z] Finished read-buildbot-config step (success) 02:05:06 INFO - [mozharness: 2017-02-19 10:05:06.566437Z] Running download-and-extract step. 02:05:06 INFO - Running pre-action listener: _resource_record_pre_action 02:05:06 INFO - Running main action method: download_and_extract 02:05:06 INFO - mkdir: /builds/slave/test/build/tests 02:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:06 INFO - trying https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:05:08 INFO - Downloaded 1199 bytes. 02:05:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:05:08 INFO - Using the following test package requirements: 02:05:08 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:05:08 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:05:08 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:05:08 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'jsshell-mac.zip'], 02:05:08 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:05:08 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:05:08 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:05:08 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:05:08 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:05:08 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:05:08 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:05:08 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:05:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:05:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:05:08 INFO - Fetch https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:05:09 INFO - Expected file size: 16359058 02:05:09 INFO - Obtained file size: 16359058 02:05:16 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:05:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:05:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:05:16 INFO - Fetch https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:05:18 INFO - Expected file size: 16359058 02:05:18 INFO - Obtained file size: 16359058 02:05:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:05:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:05:24 INFO - Fetch https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:05:26 INFO - Expected file size: 14403485 02:05:26 INFO - Obtained file size: 14403485 02:05:26 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')]} 02:05:26 INFO - trying https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:05:29 INFO - Downloaded 74025067 bytes. 02:05:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:05:29 INFO - mkdir: /builds/slave/test/properties 02:05:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:29 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:29 INFO - Contents: 02:05:29 INFO - build_url:https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:05:31 INFO - Running post-action listener: _resource_record_post_action 02:05:31 INFO - Running post-action listener: set_extra_try_arguments 02:05:31 INFO - [mozharness: 2017-02-19 10:05:31.984180Z] Finished download-and-extract step (success) 02:05:31 INFO - [mozharness: 2017-02-19 10:05:31.984303Z] Running populate-webroot step. 02:05:31 INFO - Running pre-action listener: _resource_record_pre_action 02:05:31 INFO - Running main action method: populate_webroot 02:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:31 INFO - '--tppagecycles', 02:05:31 INFO - '7'], 02:05:31 INFO - 'tests': ['tsvgm']}}, 02:05:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:05:31 INFO - 'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['damp', 'tps']}, 02:05:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:05:31 INFO - 'tests': ['damp', 'tps']}, 02:05:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['dromaeo_dom']}, 02:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['basic_compositor_video']}, 02:05:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:05:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['a11yr', 02:05:31 INFO - 'ts_paint', 02:05:31 INFO - 'tpaint', 02:05:31 INFO - 'sessionrestore', 02:05:31 INFO - 'sessionrestore_no_auto_restore', 02:05:31 INFO - 'tabpaint']}, 02:05:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:31 INFO - 'tests': ['tsvgx', 02:05:31 INFO - 'tsvgr_opacity', 02:05:32 INFO - 'tart', 02:05:32 INFO - 'tscrollx', 02:05:32 INFO - 'cart', 02:05:32 INFO - 'tsvg_static']}, 02:05:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:32 INFO - 'tsvgr_opacity', 02:05:32 INFO - 'tart', 02:05:32 INFO - 'tscrollx', 02:05:32 INFO - 'cart', 02:05:32 INFO - 'tsvg_static']}, 02:05:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:05:32 INFO - 'talos_options': ['--disable-e10s'], 02:05:32 INFO - 'tests': ['tp5o']}, 02:05:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:05:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:05:32 INFO - 'talos_options': ['--disable-e10s', 02:05:32 INFO - '--xperf_path', 02:05:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:32 INFO - 'tests': ['tp5n']}, 02:05:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:05:32 INFO - 'talos_options': ['--xperf_path', 02:05:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:32 INFO - 'tests': ['tp5n']}}, 02:05:32 INFO - 'talos.zip': {'path': '', 02:05:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:32 INFO - Running post-action listener: _resource_record_post_action 02:05:32 INFO - [mozharness: 2017-02-19 10:05:32.002737Z] Finished populate-webroot step (success) 02:05:32 INFO - [mozharness: 2017-02-19 10:05:32.002868Z] Running create-virtualenv step. 02:05:32 INFO - Running pre-action listener: _resource_record_pre_action 02:05:32 INFO - Running main action method: create_virtualenv 02:05:32 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:32 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 02:05:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:32 INFO - Using real prefix '/tools/python27' 02:05:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:35 INFO - Installing pip.................done. 02:05:35 INFO - Return code: 0 02:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:05:35 INFO - Reading from file tmpfile_stdout 02:05:35 INFO - Output received: 02:05:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:05:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:37 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 02:05:37 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 02:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:37 INFO - 'HOME': '/Users/cltbld', 02:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PAGER': '/bin/cat', 02:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:37 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - 'XPC_FLAGS': '0x0', 02:05:37 INFO - 'XPC_SERVICE_NAME': '0', 02:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:37 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 02:05:37 INFO - Cleaning up... 02:05:37 INFO - Return code: 0 02:05:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05:37 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')]} 02:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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')]} 02:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:37 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 02:05:37 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 02:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:37 INFO - 'HOME': '/Users/cltbld', 02:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PAGER': '/bin/cat', 02:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:37 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - 'XPC_FLAGS': '0x0', 02:05:37 INFO - 'XPC_SERVICE_NAME': '0', 02:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:37 INFO - Downloading/unpacking psutil>=3.1.1 02:05:37 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 02:05:37 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 02:05:37 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 02:05:37 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 02:05:37 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 02:05:37 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 02:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:42 INFO - Installing collected packages: psutil 02:05:42 INFO - Running setup.py install for psutil 02:05:42 INFO - building 'psutil._psutil_osx' extension 02:05:42 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 02:05:43 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 02:05:43 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 02:05:43 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 02:05:43 INFO - building 'psutil._psutil_posix' extension 02:05:43 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 02:05:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:05:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:05:43 INFO - ^ 02:05:43 INFO - 1 warning generated. 02:05:43 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 02:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:43 INFO - Successfully installed psutil 02:05:43 INFO - Cleaning up... 02:05:44 INFO - Return code: 0 02:05:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:44 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:44 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 02:05:44 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 02:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:44 INFO - 'HOME': '/Users/cltbld', 02:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:44 INFO - 'LOGNAME': 'cltbld', 02:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:44 INFO - 'MOZ_NO_REMOTE': '1', 02:05:44 INFO - 'NO_EM_RESTART': '1', 02:05:44 INFO - 'PAGER': '/bin/cat', 02:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:44 INFO - 'PWD': '/builds/slave/test', 02:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:44 INFO - 'SHELL': '/bin/bash', 02:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:44 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:44 INFO - 'USER': 'cltbld', 02:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:44 INFO - 'XPC_FLAGS': '0x0', 02:05:44 INFO - 'XPC_SERVICE_NAME': '0', 02:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:05:44 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 02:05:44 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 02:05:44 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 02:05:44 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 02:05:44 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 02:05:44 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 02:05:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:05:48 INFO - Installing collected packages: mozsystemmonitor 02:05:48 INFO - Running setup.py install for mozsystemmonitor 02:05:48 INFO - Successfully installed mozsystemmonitor 02:05:48 INFO - Cleaning up... 02:05:48 INFO - Return code: 0 02:05:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:05:48 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')]} 02:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:48 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')]} 02:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:48 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:48 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 02:05:48 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 02:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:48 INFO - 'HOME': '/Users/cltbld', 02:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:48 INFO - 'LOGNAME': 'cltbld', 02:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:48 INFO - 'MOZ_NO_REMOTE': '1', 02:05:48 INFO - 'NO_EM_RESTART': '1', 02:05:48 INFO - 'PAGER': '/bin/cat', 02:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:48 INFO - 'PWD': '/builds/slave/test', 02:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:48 INFO - 'SHELL': '/bin/bash', 02:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:48 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:48 INFO - 'USER': 'cltbld', 02:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:48 INFO - 'XPC_FLAGS': '0x0', 02:05:48 INFO - 'XPC_SERVICE_NAME': '0', 02:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:05:48 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 02:05:48 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 02:05:48 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 02:05:48 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 02:05:48 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 02:05:48 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 02:05:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:05:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:05:54 INFO - warning: no files found matching '*.txt' 02:05:54 INFO - no previously-included directories found matching 'build' 02:05:54 INFO - no previously-included directories found matching 'dist' 02:05:54 INFO - no previously-included directories found matching '.git*' 02:05:54 INFO - Installing collected packages: jsonschema, functools32 02:05:54 INFO - Running setup.py install for functools32 02:05:54 INFO - warning: no files found matching '*.txt' 02:05:54 INFO - no previously-included directories found matching 'build' 02:05:54 INFO - no previously-included directories found matching 'dist' 02:05:54 INFO - no previously-included directories found matching '.git*' 02:05:54 INFO - Successfully installed jsonschema functools32 02:05:54 INFO - Cleaning up... 02:05:54 INFO - Return code: 0 02:05:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:05:54 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')]} 02:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:54 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')]} 02:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:54 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:54 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 02:05:54 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 02:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:54 INFO - 'HOME': '/Users/cltbld', 02:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:54 INFO - 'LOGNAME': 'cltbld', 02:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:54 INFO - 'MOZ_NO_REMOTE': '1', 02:05:54 INFO - 'NO_EM_RESTART': '1', 02:05:54 INFO - 'PAGER': '/bin/cat', 02:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:54 INFO - 'PWD': '/builds/slave/test', 02:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:54 INFO - 'SHELL': '/bin/bash', 02:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:54 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:54 INFO - 'USER': 'cltbld', 02:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:54 INFO - 'XPC_FLAGS': '0x0', 02:05:54 INFO - 'XPC_SERVICE_NAME': '0', 02:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:05:54 INFO - Cleaning up... 02:05:54 INFO - Return code: 0 02:05:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:05:54 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')]} 02:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:54 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')]} 02:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:54 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:05:54 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 02:05:54 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 02:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:54 INFO - 'HOME': '/Users/cltbld', 02:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:54 INFO - 'LOGNAME': 'cltbld', 02:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:54 INFO - 'MOZ_NO_REMOTE': '1', 02:05:54 INFO - 'NO_EM_RESTART': '1', 02:05:54 INFO - 'PAGER': '/bin/cat', 02:05:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:54 INFO - 'PWD': '/builds/slave/test', 02:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:54 INFO - 'SHELL': '/bin/bash', 02:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:05:54 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:54 INFO - 'USER': 'cltbld', 02:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:54 INFO - 'XPC_FLAGS': '0x0', 02:05:54 INFO - 'XPC_SERVICE_NAME': '0', 02:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:05:54 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 02:05:54 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 02:05:54 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 02:05:54 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 02:05:54 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 02:05:54 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 02:05:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:05:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:59 INFO - Downloading docopt-0.6.1.tar.gz 02:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:05:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:05:59 INFO - Running setup.py install for blobuploader 02:05:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:05:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:05:59 INFO - Running setup.py install for requests 02:06:00 INFO - Running setup.py install for docopt 02:06:00 INFO - Successfully installed blobuploader requests docopt 02:06:00 INFO - Cleaning up... 02:06:00 INFO - Return code: 0 02:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:06:00 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 02:06:00 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 02:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:00 INFO - 'HOME': '/Users/cltbld', 02:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:00 INFO - 'LOGNAME': 'cltbld', 02:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:00 INFO - 'MOZ_NO_REMOTE': '1', 02:06:00 INFO - 'NO_EM_RESTART': '1', 02:06:00 INFO - 'PAGER': '/bin/cat', 02:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:00 INFO - 'PWD': '/builds/slave/test', 02:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:00 INFO - 'SHELL': '/bin/bash', 02:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:06:00 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:00 INFO - 'USER': 'cltbld', 02:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:00 INFO - 'XPC_FLAGS': '0x0', 02:06:00 INFO - 'XPC_SERVICE_NAME': '0', 02:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-58McoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-R7XDO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-duHEsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-MvF6To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-HGx3It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-__rto8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-fOhrX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-9Vm9eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ELQD5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-08ODph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ZVBr3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-3ZPe1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-Q4_eaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-foEcij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:01 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-A3n95w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:02 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-gpUWy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:02 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-xtAlYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:02 INFO - Running setup.py install for manifestparser 02:06:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozcrash 02:06:02 INFO - Running setup.py install for mozdebug 02:06:02 INFO - Running setup.py install for mozdevice 02:06:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:02 INFO - Running setup.py install for mozfile 02:06:03 INFO - Running setup.py install for mozhttpd 02:06:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for mozinfo 02:06:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for mozInstall 02:06:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for mozleak 02:06:03 INFO - Running setup.py install for mozlog 02:06:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for moznetwork 02:06:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:03 INFO - Running setup.py install for mozprocess 02:06:04 INFO - Running setup.py install for mozprofile 02:06:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:04 INFO - Running setup.py install for mozrunner 02:06:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:04 INFO - Running setup.py install for mozscreenshot 02:06:04 INFO - Running setup.py install for moztest 02:06:04 INFO - Running setup.py install for mozversion 02:06:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:04 INFO - Cleaning up... 02:06:04 INFO - Return code: 0 02:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:04 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')]} 02:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:04 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')]} 02:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:04 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:06:04 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 02:06:04 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 02:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:04 INFO - 'HOME': '/Users/cltbld', 02:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:04 INFO - 'LOGNAME': 'cltbld', 02:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:04 INFO - 'MOZ_NO_REMOTE': '1', 02:06:04 INFO - 'NO_EM_RESTART': '1', 02:06:04 INFO - 'PAGER': '/bin/cat', 02:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:04 INFO - 'PWD': '/builds/slave/test', 02:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:04 INFO - 'SHELL': '/bin/bash', 02:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:06:04 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:04 INFO - 'USER': 'cltbld', 02:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:04 INFO - 'XPC_FLAGS': '0x0', 02:06:04 INFO - 'XPC_SERVICE_NAME': '0', 02:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-RQeW_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:05 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)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-DcCrgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-sWQdWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:05 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)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-bN5TBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-PTj6Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:05 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)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ULAbud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:05 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)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-diE1gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:05 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)) 02:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:05 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-JmIXeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-X27_RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-XY0xiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-nugXZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-h01IFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-FYabXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ido90a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-TPojlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:06 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)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-VYyQUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:06 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ohDZTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:06 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)) 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:06 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)) 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:07 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 02:06:07 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 02:06:07 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 02:06:07 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 02:06:07 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 02:06:07 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 02:06:10 INFO - Downloading blessings-1.6.tar.gz 02:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:10 INFO - Installing collected packages: blessings 02:06:10 INFO - Running setup.py install for blessings 02:06:10 INFO - Successfully installed blessings 02:06:10 INFO - Cleaning up... 02:06:10 INFO - Return code: 0 02:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:10 INFO - Reading from file tmpfile_stdout 02:06:10 INFO - Current package versions: 02:06:10 INFO - blessings == 1.6 02:06:10 INFO - blobuploader == 1.2.4 02:06:10 INFO - docopt == 0.6.1 02:06:10 INFO - functools32 == 3.2.3-2 02:06:10 INFO - jsonschema == 2.5.1 02:06:10 INFO - manifestparser == 1.1 02:06:10 INFO - mozInstall == 1.12 02:06:10 INFO - mozcrash == 1.0 02:06:10 INFO - mozdebug == 0.1 02:06:10 INFO - mozdevice == 0.49 02:06:10 INFO - mozfile == 1.2 02:06:10 INFO - mozhttpd == 0.7 02:06:10 INFO - mozinfo == 0.9 02:06:10 INFO - mozleak == 0.1 02:06:10 INFO - mozlog == 3.4 02:06:10 INFO - moznetwork == 0.27 02:06:10 INFO - mozprocess == 0.24 02:06:10 INFO - mozprofile == 0.28 02:06:10 INFO - mozrunner == 6.13 02:06:10 INFO - mozscreenshot == 0.1 02:06:10 INFO - mozsystemmonitor == 0.3 02:06:10 INFO - moztest == 0.8 02:06:10 INFO - mozversion == 1.4 02:06:10 INFO - psutil == 3.1.1 02:06:10 INFO - requests == 1.2.3 02:06:10 INFO - wsgiref == 0.1.2 02:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:10 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:06:10 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 02:06:10 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 02:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:10 INFO - 'HOME': '/Users/cltbld', 02:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:10 INFO - 'LOGNAME': 'cltbld', 02:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:10 INFO - 'MOZ_NO_REMOTE': '1', 02:06:10 INFO - 'NO_EM_RESTART': '1', 02:06:10 INFO - 'PAGER': '/bin/cat', 02:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:10 INFO - 'PWD': '/builds/slave/test', 02:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:10 INFO - 'SHELL': '/bin/bash', 02:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:06:10 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:10 INFO - 'USER': 'cltbld', 02:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:10 INFO - 'XPC_FLAGS': '0x0', 02:06:10 INFO - 'XPC_SERVICE_NAME': '0', 02:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 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)) 02:06:11 INFO - Cleaning up... 02:06:11 INFO - Return code: 0 02:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:11 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')]} 02:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:11 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')]} 02:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:11 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 0x10473eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104741768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd158f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, '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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 02:06:11 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 02:06:11 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 02:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:11 INFO - 'HOME': '/Users/cltbld', 02:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:11 INFO - 'LOGNAME': 'cltbld', 02:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:11 INFO - 'MOZ_NO_REMOTE': '1', 02:06:11 INFO - 'NO_EM_RESTART': '1', 02:06:11 INFO - 'PAGER': '/bin/cat', 02:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:11 INFO - 'PWD': '/builds/slave/test', 02:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:11 INFO - 'SHELL': '/bin/bash', 02:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:06:11 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:11 INFO - 'USER': 'cltbld', 02:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:11 INFO - 'XPC_FLAGS': '0x0', 02:06:11 INFO - 'XPC_SERVICE_NAME': '0', 02:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:11 INFO - Cleaning up... 02:06:11 INFO - Return code: 0 02:06:11 INFO - Running post-action listener: _resource_record_post_action 02:06:11 INFO - Running post-action listener: _start_resource_monitoring 02:06:11 INFO - Starting resource monitoring. 02:06:11 INFO - [mozharness: 2017-02-19 10:06:11.444731Z] Finished create-virtualenv step (success) 02:06:11 INFO - [mozharness: 2017-02-19 10:06:11.445663Z] Running install step. 02:06:11 INFO - Running pre-action listener: _resource_record_pre_action 02:06:11 INFO - Running main action method: install 02:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:11 INFO - Reading from file tmpfile_stdout 02:06:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:11 INFO - Reading from file tmpfile_stdout 02:06:11 INFO - Output received: 02:06:11 INFO - Usage: mozinstall [options] installer 02:06:11 INFO - Options: 02:06:11 INFO - -h, --help show this help message and exit 02:06:11 INFO - -d DEST, --destination=DEST 02:06:11 INFO - Directory to install application into. [default: 02:06:11 INFO - "/builds/slave/test"] 02:06:11 INFO - --app=APP Application being installed. [default: firefox] 02:06:11 INFO - mkdir: /builds/slave/test/build/application 02:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:06:32 INFO - Reading from file tmpfile_stdout 02:06:32 INFO - Output received: 02:06:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:06:32 INFO - Running post-action listener: _resource_record_post_action 02:06:32 INFO - [mozharness: 2017-02-19 10:06:32.001996Z] Finished install step (success) 02:06:32 INFO - [mozharness: 2017-02-19 10:06:32.002173Z] Running run-tests step. 02:06:32 INFO - Running pre-action listener: _resource_record_pre_action 02:06:32 INFO - Running main action method: run_tests 02:06:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:06:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:06:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:06:32 INFO - 2017-02-19 02:06:32.017 screenresolution[1641:11793] starting screenresolution argv=screenresolution get 02:06:32 INFO - 2017-02-19 02:06:32.019 screenresolution[1641:11793] Display 0: 1600x1200x32@60 02:06:32 INFO - 2017-02-19 02:06:32.025 screenresolution[1642:11795] starting screenresolution argv=screenresolution list 02:06:32 INFO - Available Modes on Display 0 02:06:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:06:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:06:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:06:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:06:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:06:32 INFO - Intel Iris: 02:06:32 INFO - Chipset Model: Intel Iris 02:06:32 INFO - Type: GPU 02:06:32 INFO - Bus: Built-In 02:06:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:06:32 INFO - Vendor: Intel (0x8086) 02:06:32 INFO - Device ID: 0x0a2e 02:06:32 INFO - Revision ID: 0x0009 02:06:32 INFO - Displays: 02:06:32 INFO - Display: 02:06:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:06:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:06:32 INFO - Display Serial Number: 1600x1200 60 02:06:32 INFO - Main Display: Yes 02:06:32 INFO - Mirror: Off 02:06:32 INFO - Online: Yes 02:06:32 INFO - Rotation: Supported 02:06:32 INFO - Return code: 0 02:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:32 INFO - Python 2.7.3 02:06:32 INFO - Return code: 0 02:06:32 INFO - grabbing minidump binary from tooltool 02:06:32 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')]} 02:06:32 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 0x10451cd30>, '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 0x104443db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104511be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:32 INFO - Return code: 0 02:06:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0391', '--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 02:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0391 --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 02:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l9qsxdKOZJ/Render', 02:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:32 INFO - 'HOME': '/Users/cltbld', 02:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:32 INFO - 'LOGNAME': 'cltbld', 02:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:32 INFO - 'MOZ_NO_REMOTE': '1', 02:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:32 INFO - 'NO_EM_RESTART': '1', 02:06:32 INFO - 'PAGER': '/bin/cat', 02:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:32 INFO - 'PWD': '/builds/slave/test', 02:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:32 INFO - 'SHELL': '/bin/bash', 02:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w0Kf2OtUes/Listeners', 02:06:32 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 02:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:32 INFO - 'USER': 'cltbld', 02:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:32 INFO - 'XPC_FLAGS': '0x0', 02:06:32 INFO - 'XPC_SERVICE_NAME': '0', 02:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0391', '--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 02:06:32 INFO - mozversion application_buildid: 20170219004014 02:06:32 INFO - mozversion application_changeset: 2d8d146df0cf29099265ce354b438a7a97251313 02:06:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:32 INFO - mozversion application_name: Firefox 02:06:32 INFO - mozversion application_remotingname: firefox-dev 02:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:06:32 INFO - mozversion application_vendor: Mozilla 02:06:32 INFO - mozversion application_version: 53.0a2 02:06:32 INFO - mozversion platform_buildid: 20170219004014 02:06:32 INFO - mozversion platform_changeset: 2d8d146df0cf29099265ce354b438a7a97251313 02:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:06:32 INFO - mozversion platform_version: 53.0a2 02:06:32 INFO - using testdate: 1487498792 02:06:32 INFO - actual date: 1487498792 02:06:32 INFO - starting webserver on 'localhost:49247' 02:06:32 INFO - SUITE-START | Running 2 tests 02:06:32 INFO - TEST-START | dromaeo_css 02:06:32 INFO - operating with platform_type : mac_ 02:06:32 INFO - Initialising browser for dromaeo_css test... 02:06:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmp3owYkz/profile http://localhost:49247/getInfo.html) 02:06:36 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 02:06:36 INFO - PROCESS | 1652 | colorDepth:24 02:06:36 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 02:06:36 INFO - PROCESS | 1652 | __metrics 02:06:36 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:06:36 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:37 INFO - TEST-INFO | 1652: exit 0 02:06:37 INFO - Browser initialized. 02:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:37 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmp3owYkz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:49 INFO - PROCESS | 1656 | RSS: Main: 213700608 02:06:49 INFO - PROCESS | 1656 | 02:09:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:09:55 INFO - PROCESS | 1656 | RSS: Main: 354471936 02:09:55 INFO - PROCESS | 1656 | 02:11:39 INFO - PROCESS | 1656 | ************************* 02:11:39 INFO - PROCESS | 1656 | A coding exception was thrown and uncaught in a Task. 02:11:39 INFO - PROCESS | 1656 | 02:11:39 ERROR - PROCESS | 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:11:39 INFO - PROCESS | 1656 | Full stack: 02:11:39 INFO - PROCESS | 1656 | ************************* 02:12:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 02:12:58 INFO - PROCESS | 1656 | RSS: Main: 353595392 02:12:58 INFO - PROCESS | 1656 | 02:16:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 02:16:01 INFO - PROCESS | 1656 | RSS: Main: 318824448 02:16:01 INFO - PROCESS | 1656 | 02:19:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 02:19:05 INFO - PROCESS | 1656 | RSS: Main: 335663104 02:19:05 INFO - PROCESS | 1656 | 02:22:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 02:22:09 INFO - PROCESS | 1656 | RSS: Main: 316153856 02:22:09 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 02:25:12 INFO - PROCESS | 1656 | RSS: Main: 388374528 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | __start_tp_report 02:25:12 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 02:25:12 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 02:25:12 INFO - PROCESS | 1656 | |i|pagename|runs| 02:25:12 INFO - PROCESS | 1656 | |0;dojo.html;3090.7636945221907;3329.0678609989213;3338.8497517611704;3352.865885364584;3370.090075679565;5583.748731307091;5661.433856614337;5688.744006519706;5693.572982026344;5700.1449782532645;5648.4633959773855;5654.236678048463;5755.25181726376;5756.971215143918;5757.856053598652;5202.635815492917;5212.087884620195;5219.295395121667;5235.1885457753915;5284.313039304885;5122.257272695476;5136.460671629462;5153.871153221162;5307.177387504924;5326.227696983954;5166.689998600077;5179.482051794828;5193.948060519403;5245.423003469616;5256.369235691704;5253.500917412878;5261.500157485052;5269.6311258211945;5287.471252874701;5321.467853214686;5080.161773307437;5151.5106064923775;5208.817691380821;5226.346706661668;5241.9213711794355;5561.193626924114;5571.415001424833;5606.691631960241;5641.971790141064;5662.405447428002;6177.752889884399;6215.440610345046;6217.129601855744;6221.626702397825;6231.314555398948;6195.7521699131985;6257.593256438363;6261.8747625047245;6264.686765661744;6269.185005949197;4669.673122881366;5619.915701264485;5670.489655930904;5815.127730840408;5839.0949402842625;6267.0286105653695;6325.114483972247;6357.141785858942;6360.618362898241;6372.968135159294;6178.938210617926;6188.81433556994;6189.195404597373;6190.907136392958;6216.844578885473;6139.995903338765;6168.25980882297;6198.535109866778;6212.534059945522;6231.875362492725;6133.457080270768;6187.288461826857;6187.597806142587;6231.034189700604;6236.376362363727;6207.6585787781205;6217.751289948352;6221.720022598994;6226.875462490725;6228.47058000066;4907.09218794517;4988.6757360771435;5040.067587496325;5042.823501177441;5056.772445239973;4395.208862404734;4411.7794110295;4446.177457170434;4449.243628583149;4477.977610111994;5893.852653683606;5915.142304365843;5925.288965324189;5950;5962.34414214436;6115.118650813463;6121.908171377433;6129.908988904127;6165.475934545524;6218.906716399258;5811.476967072984;5837.182794408786;5888.293404791452;5892.322382925932;5930.7924222652;5339.706316152571;5373.7581808818695;5378.78484860609;5453.345598528202;5454.809081682201;6298.275698294755;6310.873782524415;6322.114903913548;6444.806655800334;6467.320931302145;6257.374262573706;6259.561830671809;6270.153529273673;6274.372562743689;6283.937160628335;6159.1069294951085;6420.1974753155855;6427.1002059710745;6430.2926678066315;6438.7102580384935;6049;6118.710550942667;6131.804871722127;6154.446099851035;6208.00671892495;6186.566940314135;6231.9688401557705;6232.283287422005;6238.906416403667;6252.562320637694;5003.874128321098;6102.328743838263;6166.845828854314;6180.165677633642;6191.318954914866;5914.172015917861;5950.613210141327;6096.420840020191;6102.694865256631;6108.463491842691;6030.939690603038;6065.181200537871;6065.272167339947;6066.817995460143;6081;5029.899402012013;6159.599626024294;6165.383461653799;6183.598066125687;6187.133801267916;5735.11105778605;5845.1232315153065;5876.471117599436;5879.235699359056;5996.67018313997 02:25:12 INFO - PROCESS | 1656 | |1;ext.html;460.4520620461652;491.08657896312855;504.9596032317415;507.79434329096716;547.0071819647342;30559.847200763994;36600.81699591502;40489;42009.15981680364;44123.77938110313;43421.34867976975;43944;43976;44019;44023.559764402344;8354.24811766941;9283.81432371354;9450.480223587734;9458.00690927453;9468.053194680546;8372.079071302152;11233.775324493505;11446.599369022086;11495.540178392854;11698.766024679502;11429.942850285737;11488.13838962077;11498.482568284406;11504;11532.769344613103;8399.244068033906;11451.885481145207;11493.885061149365;11502.942485287562;11508.309501429942;8434.831303373898;11139.944300278528;11411.714707132389;11420.257683250562;11648.126390520745;40622.796886015676;41028.79485602583;41034.58965410337;41064;41130.79434602838;3941.6182061899976;3953.6639385652256;3980.223856348013;3984.183242435294;4005.5794141615293;29647.258818529495;29683.109506714834;29708.108756737332;30545.541816872767;30674;3079.3687294104657;3144.5912031435996;3224.8548815303366;3324.0526449961885;3325.7671962962604;452620;453619;454545;455253;456664;62855;63108;63211;63252.683736581945;63305.366946329945;63442.0483692745;63496;63515.6824215876;63586;63673.95097465826;15119.412461691583;15999.200039998186;16521;16866.325346985985;16916.323347066227;11724.531018759155;11987.460564274628;12828.93585532085;12897.35513224335;12897.613071607866;14909.478168264059;15001.174935378658;15039.323230454656;15061.47284845047;15081.849181508045;4918.532739389752;5791.0734282514595;6345.620392352867;6435;6468.579542329828;806.4435539477741;868.5092922498768;872.6378552900602;876.4522173641474;896.789254525186;29154.85422572916;29495.410091798472;29569.55645665317;30603.081907542808;30626.846865765976;798.6805277888891;941.868138460616;1079.3362082319475;1162.8313894485252;1174.3893175548667;14508.927455362656;14838.109713417014;14851.851481485046;15593.610159746097;15595.688086238211;626565;631677;632767;632935;633157;61666.69166654138;62001.37998620046;62012.069818952754;62024.06963895545;62116.689416552625;1411.2661416063795;1442.386985531145;1459.2484870291596;1462.2688655672164;1464.3556834992569;27818.860905695343;28891;29159;29360.944733869277;29922.551161732157;50626.49373506218;51046;51047;51151;51549.226761597856;507574;508642;509984;509991;510548;38972.6102738969;39321.80339098286;39721;39727.60272397355;40093.59906401015;45845.77077114593;46284.7685761569;47006;47011.29483057689;47077.529224707316;35289.47065794066;35438.64561354354;35855;37157.25685486329;38204.85385438441;35360.469592956644;35395.64604353924;36628.267434651694;36784.81607591945;36827.447588285664;35158.47262291119;35637.82181089078;36101.638983609824;36149.63850361568;36334.90995270146;26634.600480993187;31659.84170079135;32022.77104057076;32510;32533;23921.641175382036;24257.401028405548;24448.388790280384;24528.754712452646;24996.37509062288 02:25:12 INFO - PROCESS | 1656 | |2;jquery.html;350.5512943432407;376.476697390627;380.5851621732313;387.73246459942646;411.94644696189494;14262;15223.619409514768;17751.467455976326;20756;20975.378077740283;20253.69619455706;21092.894535527303;22044.779552204473;22375.440613984658;22422.103115875387;5204.531592156705;5243.659162154458;5257.7108259045735;5262.368515778093;5972;5838.591298609099;5956.70216489176;5967.104934259853;5968.194293770351;5975.790847320344;3891.416287556861;4093.0585965228015;4798.920242945344;5823;6065.211522502091;5582.413846546095;6082.482988945922;6096.085587161917;6108.053251746009;6114.847128821771;5701.57238207132;5815.73829177688;5820.82537523875;5828.825135245949;5832.9708351457975;13231;15324.616884577863;20584.79415205844;25634.974601015936;26033.609495857578;2645.8412495250345;2804.3129433288773;2819.492491351556;2875.43928933858;2974.2861713188895;15757.212139392985;16708.74936875948;17018.65962680752;17820.376286829898;17913.19390627425;1941.369055057112;1975.2790231565518;1984.2955750708436;1989.9403017909485;1999.7400337955974;123782;162926.1853690736;164551.17724411542;174665;176021;19576.510587235432;24174;24310.149144779847;24774.876125619256;24778.25665230046;42775.71672849819;42789;43617.12765744731;44051.559484405385;44063.77968110139;9487.335886488017;11120.277181983145;11261.943690281496;11681.396497776828;11702.590409335802;9208.90791092094;9283.210927071139;9302.395344302598;9351.672691455766;9768.51157442125;10992.725181870357;11066.833997490045;11097.33415995043;11154.721131971603;11167.994880460798;3674.8975307407673;3856.9614303857165;3883.8834834954996;4150.605692459211;4251.489821221411;984.4191926763101;1008.5713571731984;1017.6794309792392;1030.1861529391847;1053.5048527192207;20795.792042079687;21122.471938201666;21270.680939785914;21275.680864787042;21494.89252553727;913.8987520038471;985.5663508056432;1021.4688362051692;1062.2458054781036;1065.3767545985531;10634.627788027537;10898.232894428094;10966.342019478856;11022.669319920415;11029.062529685067;705894;714431;714546;731121;747646;107667;109442;127218;159936;163591.18204408902;959.8080383923243;987.5259875259771;1024.574801457387;1073.0717928991367;1083.230906056693;18427;18611.72082418792;19412.611747765248;19487.317943871898;19498.902505487382;52999.73500132475;53199;53923;54732.72633636806;60899.78200436055;66886.33113668801;73919.8912016331;78369;79634;82427.5878620603;6632.966835165793;6936.618485983319;7582.886256706264;7696.461247712607;7745.148033716174;12271.509139634314;13284.136531125447;13305.334733263491;13606;13644.795328069888;5676.233708449472;6321.494280457644;11162.944185279022;11288.153388495732;11777.823332650189;8636.913630863612;10614.203934704774;11073.224874259047;11466.656000320003;11920.821187682019;11652.883471165518;11744;11946.701332466759;12050.397480126134;12089.637310880687;7478.214787447458;7565.2812982766545;7675.884861726967;7896.09194942589;8736.126387361468;9798.755031123994;10265.12746416563;11305;11566.537338506701;11710.238834475731 02:25:12 INFO - PROCESS | 1656 | |3;mootools.html;1279.756846199222;1356.159181307589;1449.2463918762244;1464.2166440954093;1467.1270593996576;7965.800854978628;8417.83164336713;8420.957895210515;8421.368397370206;8430.494170349783;7409.259074092588;7660.770176894688;7666.34836038936;7974.242446967529;8138.186181381859;2304.8156147508157;2351.905923763047;2352.12971200656;2352.647102934565;2353.670486131943;2267.716535433071;2302.8157747380255;2328.359701082199;2367.95264094718;2373.786359227669;2030.2995466564012;2109;2248.325502349297;2317.327974887289;2336.042222688698;2317.6060069788177;2326.31373744744;2328.406256404623;2330.603797354454;2332.953340933172;2270.818334533233;2323.6514522821544;2346.6831977682964;2349.6592994015773;2360.362702070431;8308;8334.291585215264;8348.749537513884;8398.076211616717;8402.411831171821;5054.671446355975;5135.563477104451;5141.434442211354;5176.120059589879;5223.13818219997;3232.983835080833;3260.543523906655;3316.8341582920757;3486.9651303486894;3534.2401383702627;1163.5811108001112;1209.8911098001133;1213.6723084767152;1259.7732408166526;1261.627819793154;10747.19396045292;10827.729306767314;10883.945580272128;10903.727406814814;10917.39954302513;4489.19194544985;4683.555062269147;4732.763361831895;4756.072565849626;4770.546798054179;9503.66737164196;9511.57197926095;9512.667056652985;9515.524223788783;9523.809523809485;5269.683818970874;5275.287836142148;5278.868028299246;5279.656822306538;5300.09898317287;4287.885149861058;4293.2272191005295;4654.720716757005;4734.573888349996;4791.185498465269;3815.389537673959;3864.961350386516;3978.1844721831953;3986.1828325193264;3989.740666856645;1247.6756043428775;1258.182181581979;1266.4174479739238;1274.388293619068;1285.0747461827468;870.2689740617911;887.7958069644018;888.5512816027993;889.4174315823146;915.7756349694234;5385.3268341457315;5568.136938774496;5605.299337582802;5614.69119198448;5663.923854467638;564.7797359029981;570.6576054367347;573.9913901291484;577.6967092276504;586.718375179916;3631.219287853124;3632.800195989193;3696.667299943018;3745.0637340664834;3764.7176461765475;9485.288603354777;9869.161121304769;9885.555150018266;9970.401775893324;10116.747081323027;10000.199984001263;10014.599416023277;10017.599296028224;10017.749556261006;10029.247806414549;7424.183339832614;7666.348360389429;7757.53454792703;7839.529628222325;7868.173841746649;5576.107822748503;5611.859703507445;5642;5739.971300143639;5804.100364443518;8812.735617931472;8992.100789920956;9173.495457749888;9313.068693130905;9343.719688409086;8719.38964272495;9287.257019438564;9386.906130938603;9464.810703785748;9473.24214062887;6660.300668429745;6892.965535172292;7106.289371062852;7207.243239459991;7217.747378841926;6665.733370665119;7730.806729831799;8048.758537243892;8056.879146812686;8068.031836179696;7234.74678386254;7361.079865016873;7388.519746216479;7424.331810137113;7446.441516886147;7160.928390716026;7186.281371862772;7274.454415918933;7298.416126709957;7302.0142280791415;4895.46149923501;6453.257875344208;6455.483561315177;6488.124103246001;6488.221413430419;4445.955540444684;5008.5492305691205;5059.822906198266;5087.364079490064;5097.643164978416;4612.654050946126;4840.370751802243;5024.598032157492;5039.823606173766;5169.457206993362 02:25:12 INFO - PROCESS | 1656 | |4;prototype.html;310.30336893673706;351.8891549162014;362.23206801580653;371.33716316375273;374.9962500374997;4134.917301653969;4226.852060177886;4776.522347765226;5046;5141.614378921578;4219.346001369785;4940.283658869462;4960;5042.647014708972;5060.734816295926;3428.742844286676;4016.9355120892988;4036.414719865618;4040.2525532776385;4051.453053837731;3237.983810080946;3598.1004748812798;3790.3656958413912;4063.9593604063875;4083.1629515949157;3872.961270387288;3990.840366385341;4074.6129117733767;4128.174365126972;4135.710500264968;3121.562981182636;3496.5629296337956;4043.858464953742;4051.513818341803;4084;3489.6859282664427;3642.8889188797407;3658.8657516170074;3676.650718181795;3702.8518859245596;4352.496240526375;4552.749598772066;4699.389079419653;4976.477469865648;5054.191329387317;4630.693455086768;4667.976660116712;4690;4742.5298157570915;4787.928181077286;4729.337892694991;5314.973425132888;5402.892407056544;5424.891502169974;5433.7283135843445;3881.3401721707096;4001.8199181036925;4022.557518672944;4032.717709760318;4052.4529188559463;4955.231939049453;5413.593980451482;5588.888222235532;5688.800891968761;5689.862027594498;4074.7555146691293;4082.897927551835;4090.466075221792;4095.7542547447247;4118.897027574335;3950.9802450987563;4108.383742438598;4112.321466957978;4158.9376159357025;4171.791410429527;4638.652101092432;4640.721556706609;4646.25659894422;4650.395448591661;4718.8584342469785;4565.771711414416;5424.1321388577635;5468.7539060742365;5476.205950137208;5477.863053423696;1084.6854412220525;1213.9757204855853;1297.5134324628264;1340;1360.7346567419258;840.8990921089509;931.3527098666498;946.7727745341068;968.4770224079059;972.8492083726892;4007.7156021067713;4732.432108146975;4747.0537079797805;4747.8100875965265;4762.9761851191215;4488.461384633865;4885;4930.559373110262;4974.328465657162;5264.920691258283;4051.8784436466954;4594.333821595917;4616.422947131608;4690.64820138491;4720.480747117815;2733.904313349023;2741.8629068546493;2747.049594787723;2749.505089083984;2757.076379412879;4502.684812063124;4512.796924138422;5126.846459546647;5335.67985920846;5426.67439953604;4648.372469716613;4719.4100737407825;5248.370195576479;5310.097283461821;5316.255724198615;4615.861524154281;4858.489858564941;5189.662671926313;5348.475684429919;5379.811706590329;4463.977680111579;4923.236898280772;4964.96756440926;5167.405748338989;5177.508136727005;5495.5878309127775;5504.889902201853;5532.557395408277;5572.4706152915405;5582;4457.665675074447;4637.76811159434;5270;5767.8558036049435;5772.134179873053;3236.9352612948082;3439.3465241604017;3677.8528858845348;3732.869349572752;3789.2610940866266;4617.561331673485;5529.364123125892;5536.7231638417115;5538.335399752055;5554.861128471821;4804.42346918372;4831.782569784438;5168.896622067613;5469.699166545878;5534.640248383842;4973.651844370859;5370.409254982027;5481.123020316731;5487.341519017744;5495.450454954473;4872.9512704872495;4900.932226252274;5001.849944501525;5113.974430127825;5194.558462530727;5039.748012599429;5135.768890399866;5372.7582258797665;5375.3280839895015;5386.59600529954;4143.316352801754;5096;5267.631265811357;5268.394134674408;5269.683818970874 02:25:12 INFO - PROCESS | 1656 | |5;yui.html;709.531709072012;728.0644371982004;763.2253262938119;823.8352329534093;832.6794184239068;14655.633609159777;15637.21813909303;15661;15685.921570392145;15704.057756534601;14456.5663030109;14463.638409039779;14466.349014294356;14613;14641.92679036606;674.9898751518731;701;849.7153453593038;863.7624653220352;868.7741187291318;831.4886344897905;855.9657613695476;860.1613426908746;865.4504389712546;866.800635853754;921.6497730862296;922.9400088994194;924.2144177449148;925.3615005646083;926.647873807952;921.7465197070792;923.4643906534194;924.0851556958596;926.087803513542;926.2266007883426;525.4719007397579;547.1655725019338;549.9147632117028;550.3176061683523;688.2051230828401;12244.387780611023;13806.516771912935;14255.857441425556;14853.331600077914;15145.318460669187;14166.291685415688;14187.432502699983;14188.645283867883;14214.715705685932;14254.501092461818;11255.943720281428;11622.360770157638;11669.533218671328;11743.823842642367;11864.963939913168;3518.2435776308216;3569.6430356964356;3642.1076836175307;3702.8518859245596;3781.5840257571645;111460;112422;113505;113680;116764;10777.407242601575;10859.891401085888;10870.184736144663;11009.37595220616;11554.364509951865;22713.772862271497;23188.768112318998;23318.65022024671;23326.066957321855;23358.416039599146;7659.195784442553;7687.692492300245;7718.845623087507;7735.381169506426;7989;4144.730592511477;4152.688548358885;4256.34026725858;4323.286657701444;4388.561143885586;3483.390406678872;3552.5381700379303;3557.3774589446743;3561.5013898054294;3590.676839084495;620.2618883528587;627.137685682187;636.6021236727046;650.5933791380387;653.8300041989022;649.555054787472;677.6306912732573;693.549193024528;701.1340993872564;715.4312321704258;9728;10146.137578305927;10151.898481015243;10276.332038417479;10379.792404151875;627.8587317853446;657.135866335767;674.3122015544118;697.9441644668415;719.8812195987708;4005.5193376794973;4154.584541545882;4708.882277943078;4905.482276374281;4931.5561599455505;90938;101659;101846.49076754569;103188;109909.45045274723;73672;78522.6073869627;82658.58670706608;87616;89453;67760.96717098495;76100.61949690216;78383;80244.19755802484;80848.14911105353;9562.99588543193;9577.712668619952;9590.136887680143;9618.567164477756;9655.710328690151;48616.027679445506;48925.5107448921;49393.259101112795;49745;50518.74740626274;63684.68157659182;63862.36137638564;64614.353856462716;66211;67806.66096669485;9686;11572.537098516303;11658.12564057716;11900.167053132662;12459.06557008246;12339.876601234231;12503.356038383208;12528.248305101723;12737.108402411743;12891.290978996245;10859.619913302997;11434.71413214643;11594.361598343427;11719.824202636797;11906.76186476283;10438.947805261228;11366.204365694322;11922.761544768882;11939.641810745692;12012.579559715718;11680.883191167979;11881.405929703307;11881.5841445549;12000.699982500508;12255.142140050111;8100.457571746621;9894.208463322773;9999.550020249251;10118.49407529606;10474.109700675528;9162.816743664956;9272.490013049348;9674.274429417963;9679.419234845931;9680.903190968282 02:25:12 INFO - PROCESS | 1656 | __end_tp_report 02:25:12 INFO - PROCESS | 1656 | __start_cc_report 02:25:12 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1586 02:25:12 INFO - PROCESS | 1656 | __end_cc_report 02:25:12 INFO - PROCESS | 1656 | __startTimestamp1487499912778__endTimestamp 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | ------- Summary: start ------- 02:25:12 INFO - PROCESS | 1656 | Number of tests: 6 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5743.03 Median:5962.34 stddev:655.62 (11.0%) stddev-sans-first:623.74 02:25:12 INFO - PROCESS | 1656 | Values: 3090.8 3329.1 3338.8 3352.9 3370.1 5583.7 5661.4 5688.7 5693.6 5700.1 5648.5 5654.2 5755.3 5757.0 5757.9 5202.6 5212.1 5219.3 5235.2 5284.3 5122.3 5136.5 5153.9 5307.2 5326.2 5166.7 5179.5 5193.9 5245.4 5256.4 5253.5 5261.5 5269.6 5287.5 5321.5 5080.2 5151.5 5208.8 5226.3 5241.9 5561.2 5571.4 5606.7 5642.0 5662.4 6177.8 6215.4 6217.1 6221.6 6231.3 6195.8 6257.6 6261.9 6264.7 6269.2 4669.7 5619.9 5670.5 5815.1 5839.1 6267.0 6325.1 6357.1 6360.6 6373.0 6178.9 6188.8 6189.2 6190.9 6216.8 6140.0 6168.3 6198.5 6212.5 6231.9 6133.5 6187.3 6187.6 6231.0 6236.4 6207.7 6217.8 6221.7 6226.9 6228.5 4907.1 4988.7 5040.1 5042.8 5056.8 4395.2 4411.8 4446.2 4449.2 4478.0 5893.9 5915.1 5925.3 5950.0 5962.3 6115.1 6121.9 6129.9 6165.5 6218.9 5811.5 5837.2 5888.3 5892.3 5930.8 5339.7 5373.8 5378.8 5453.3 5454.8 6298.3 6310.9 6322.1 6444.8 6467.3 6257.4 6259.6 6270.2 6274.4 6283.9 6159.1 6420.2 6427.1 6430.3 6438.7 6049.0 6118.7 6131.8 6154.4 6208.0 6186.6 6232.0 6232.3 6238.9 6252.6 5003.9 6102.3 6166.8 6180.2 6191.3 5914.2 5950.6 6096.4 6102.7 6108.5 6030.9 6065.2 6065.3 6066.8 6081.0 5029.9 6159.6 6165.4 6183.6 6187.1 5735.1 5845.1 5876.5 5879.2 5996.7 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:67414.17 Median:37681.06 stddev:143200.30 (380.0%) stddev-sans-first:143513.78 02:25:12 INFO - PROCESS | 1656 | Values: 460.5 491.1 505.0 507.8 547.0 30559.8 36600.8 40489.0 42009.2 44123.8 43421.3 43944.0 43976.0 44019.0 44023.6 8354.2 9283.8 9450.5 9458.0 9468.1 8372.1 11233.8 11446.6 11495.5 11698.8 11429.9 11488.1 11498.5 11504.0 11532.8 8399.2 11451.9 11493.9 11502.9 11508.3 8434.8 11139.9 11411.7 11420.3 11648.1 40622.8 41028.8 41034.6 41064.0 41130.8 3941.6 3953.7 3980.2 3984.2 4005.6 29647.3 29683.1 29708.1 30545.5 30674.0 3079.4 3144.6 3224.9 3324.1 3325.8 452620.0 453619.0 454545.0 455253.0 456664.0 62855.0 63108.0 63211.0 63252.7 63305.4 63442.0 63496.0 63515.7 63586.0 63674.0 15119.4 15999.2 16521.0 16866.3 16916.3 11724.5 11987.5 12828.9 12897.4 12897.6 14909.5 15001.2 15039.3 15061.5 15081.8 4918.5 5791.1 6345.6 6435.0 6468.6 806.4 868.5 872.6 876.5 896.8 29154.9 29495.4 29569.6 30603.1 30626.8 798.7 941.9 1079.3 1162.8 1174.4 14508.9 14838.1 14851.9 15593.6 15595.7 626565.0 631677.0 632767.0 632935.0 633157.0 61666.7 62001.4 62012.1 62024.1 62116.7 1411.3 1442.4 1459.2 1462.3 1464.4 27818.9 28891.0 29159.0 29360.9 29922.6 50626.5 51046.0 51047.0 51151.0 51549.2 507574.0 508642.0 509984.0 509991.0 510548.0 38972.6 39321.8 39721.0 39727.6 40093.6 45845.8 46284.8 47006.0 47011.3 47077.5 35289.5 35438.6 35855.0 37157.3 38204.9 35360.5 35395.6 36628.3 36784.8 36827.4 35158.5 35637.8 36101.6 36149.6 36334.9 26634.6 31659.8 32022.8 32510.0 32533.0 23921.6 24257.4 24448.4 24528.8 24996.4 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:41275.30 Median:24542.51 stddev:120613.93 (491.4%) stddev-sans-first:120913.14 02:25:12 INFO - PROCESS | 1656 | Values: 350.6 376.5 380.6 387.7 411.9 14262.0 15223.6 17751.5 20756.0 20975.4 20253.7 21092.9 22044.8 22375.4 22422.1 5204.5 5243.7 5257.7 5262.4 5972.0 5838.6 5956.7 5967.1 5968.2 5975.8 3891.4 4093.1 4798.9 5823.0 6065.2 5582.4 6082.5 6096.1 6108.1 6114.8 5701.6 5815.7 5820.8 5828.8 5833.0 13231.0 15324.6 20584.8 25635.0 26033.6 2645.8 2804.3 2819.5 2875.4 2974.3 15757.2 16708.7 17018.7 17820.4 17913.2 1941.4 1975.3 1984.3 1989.9 1999.7 123782.0 162926.2 164551.2 174665.0 176021.0 19576.5 24174.0 24310.1 24774.9 24778.3 42775.7 42789.0 43617.1 44051.6 44063.8 9487.3 11120.3 11261.9 11681.4 11702.6 9208.9 9283.2 9302.4 9351.7 9768.5 10992.7 11066.8 11097.3 11154.7 11168.0 3674.9 3857.0 3883.9 4150.6 4251.5 984.4 1008.6 1017.7 1030.2 1053.5 20795.8 21122.5 21270.7 21275.7 21494.9 913.9 985.6 1021.5 1062.2 1065.4 10634.6 10898.2 10966.3 11022.7 11029.1 705894.0 714431.0 714546.0 731121.0 747646.0 107667.0 109442.0 127218.0 159936.0 163591.2 959.8 987.5 1024.6 1073.1 1083.2 18427.0 18611.7 19412.6 19487.3 19498.9 52999.7 53199.0 53923.0 54732.7 60899.8 66886.3 73919.9 78369.0 79634.0 82427.6 6633.0 6936.6 7582.9 7696.5 7745.1 12271.5 13284.1 13305.3 13606.0 13644.8 5676.2 6321.5 11162.9 11288.2 11777.8 8636.9 10614.2 11073.2 11466.7 11920.8 11652.9 11744.0 11946.7 12050.4 12089.6 7478.2 7565.3 7675.9 7896.1 8736.1 9798.8 10265.1 11305.0 11566.5 11710.2 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5416.19 Median:5199.63 stddev:2967.14 (57.1%) stddev-sans-first:2959.17 02:25:12 INFO - PROCESS | 1656 | Values: 1279.8 1356.2 1449.2 1464.2 1467.1 7965.8 8417.8 8421.0 8421.4 8430.5 7409.3 7660.8 7666.3 7974.2 8138.2 2304.8 2351.9 2352.1 2352.6 2353.7 2267.7 2302.8 2328.4 2368.0 2373.8 2030.3 2109.0 2248.3 2317.3 2336.0 2317.6 2326.3 2328.4 2330.6 2333.0 2270.8 2323.7 2346.7 2349.7 2360.4 8308.0 8334.3 8348.7 8398.1 8402.4 5054.7 5135.6 5141.4 5176.1 5223.1 3233.0 3260.5 3316.8 3487.0 3534.2 1163.6 1209.9 1213.7 1259.8 1261.6 10747.2 10827.7 10883.9 10903.7 10917.4 4489.2 4683.6 4732.8 4756.1 4770.5 9503.7 9511.6 9512.7 9515.5 9523.8 5269.7 5275.3 5278.9 5279.7 5300.1 4287.9 4293.2 4654.7 4734.6 4791.2 3815.4 3865.0 3978.2 3986.2 3989.7 1247.7 1258.2 1266.4 1274.4 1285.1 870.3 887.8 888.6 889.4 915.8 5385.3 5568.1 5605.3 5614.7 5663.9 564.8 570.7 574.0 577.7 586.7 3631.2 3632.8 3696.7 3745.1 3764.7 9485.3 9869.2 9885.6 9970.4 10116.7 10000.2 10014.6 10017.6 10017.7 10029.2 7424.2 7666.3 7757.5 7839.5 7868.2 5576.1 5611.9 5642.0 5740.0 5804.1 8812.7 8992.1 9173.5 9313.1 9343.7 8719.4 9287.3 9386.9 9464.8 9473.2 6660.3 6893.0 7106.3 7207.2 7217.7 6665.7 7730.8 8048.8 8056.9 8068.0 7234.7 7361.1 7388.5 7424.3 7446.4 7160.9 7186.3 7274.5 7298.4 7302.0 4895.5 6453.3 6455.5 6488.1 6488.2 4446.0 5008.5 5059.8 5087.4 5097.6 4612.7 4840.4 5024.6 5039.8 5169.5 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4326.33 Median:4719.95 stddev:1260.33 (26.7%) stddev-sans-first:1227.29 02:25:12 INFO - PROCESS | 1656 | Values: 310.3 351.9 362.2 371.3 375.0 4134.9 4226.9 4776.5 5046.0 5141.6 4219.3 4940.3 4960.0 5042.6 5060.7 3428.7 4016.9 4036.4 4040.3 4051.5 3238.0 3598.1 3790.4 4064.0 4083.2 3873.0 3990.8 4074.6 4128.2 4135.7 3121.6 3496.6 4043.9 4051.5 4084.0 3489.7 3642.9 3658.9 3676.7 3702.9 4352.5 4552.7 4699.4 4976.5 5054.2 4630.7 4668.0 4690.0 4742.5 4787.9 4729.3 5315.0 5402.9 5424.9 5433.7 3881.3 4001.8 4022.6 4032.7 4052.5 4955.2 5413.6 5588.9 5688.8 5689.9 4074.8 4082.9 4090.5 4095.8 4118.9 3951.0 4108.4 4112.3 4158.9 4171.8 4638.7 4640.7 4646.3 4650.4 4718.9 4565.8 5424.1 5468.8 5476.2 5477.9 1084.7 1214.0 1297.5 1340.0 1360.7 840.9 931.4 946.8 968.5 972.8 4007.7 4732.4 4747.1 4747.8 4763.0 4488.5 4885.0 4930.6 4974.3 5264.9 4051.9 4594.3 4616.4 4690.6 4720.5 2733.9 2741.9 2747.0 2749.5 2757.1 4502.7 4512.8 5126.8 5335.7 5426.7 4648.4 4719.4 5248.4 5310.1 5316.3 4615.9 4858.5 5189.7 5348.5 5379.8 4464.0 4923.2 4965.0 5167.4 5177.5 5495.6 5504.9 5532.6 5572.5 5582.0 4457.7 4637.8 5270.0 5767.9 5772.1 3236.9 3439.3 3677.9 3732.9 3789.3 4617.6 5529.4 5536.7 5538.3 5554.9 4804.4 4831.8 5168.9 5469.7 5534.6 4973.7 5370.4 5481.1 5487.3 5495.5 4873.0 4900.9 5001.8 5114.0 5194.6 5039.7 5135.8 5372.8 5375.3 5386.6 4143.3 5096.0 5267.6 5268.4 5269.7 02:25:12 INFO - PROCESS | 1656 | 02:25:12 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20040.46 Median:4548.72 stddev:29456.15 (647.6%) stddev-sans-first:29503.02 02:25:12 INFO - PROCESS | 1656 | Values: 709.5 728.1 763.2 823.8 832.7 14655.6 15637.2 15661.0 15685.9 15704.1 14456.6 14463.6 14466.3 14613.0 14641.9 675.0 701.0 849.7 863.8 868.8 831.5 856.0 860.2 865.5 866.8 921.6 922.9 924.2 925.4 926.6 921.7 923.5 924.1 926.1 926.2 525.5 547.2 549.9 550.3 688.2 12244.4 13806.5 14255.9 14853.3 15145.3 14166.3 14187.4 14188.6 14214.7 14254.5 11255.9 11622.4 11669.5 11743.8 11865.0 3518.2 3569.6 3642.1 3702.9 3781.6 111460.0 112422.0 113505.0 113680.0 116764.0 10777.4 10859.9 10870.2 11009.4 11554.4 22713.8 23188.8 23318.7 23326.1 23358.4 7659.2 7687.7 7718.8 7735.4 7989.0 4144.7 4152.7 4256.3 4323.3 4388.6 3483.4 3552.5 3557.4 3561.5 3590.7 620.3 627.1 636.6 650.6 653.8 649.6 677.6 693.5 701.1 715.4 9728.0 10146.1 10151.9 10276.3 10379.8 627.9 657.1 674.3 697.9 719.9 4005.5 4154.6 4708.9 4905.5 4931.6 90938.0 101659.0 101846.5 103188.0 109909.5 73672.0 78522.6 82658.6 87616.0 89453.0 67761.0 76100.6 78383.0 80244.2 80848.1 9563.0 9577.7 9590.1 9618.6 9655.7 48616.0 48925.5 49393.3 49745.0 50518.7 63684.7 63862.4 64614.4 66211.0 67806.7 9686.0 11572.5 11658.1 11900.2 12459.1 12339.9 12503.4 12528.2 12737.1 12891.3 10859.6 11434.7 11594.4 11719.8 11906.8 10438.9 11366.2 11922.8 11939.6 12012.6 11680.9 11881.4 11881.6 12000.7 12255.1 8100.5 9894.2 9999.6 10118.5 10474.1 9162.8 9272.5 9674.3 9679.4 9680.9 02:25:12 INFO - PROCESS | 1656 | -------- Summary: end -------- 02:25:12 INFO - PROCESS | 1656 | 02:25:13 INFO - TEST-INFO | 1656: exit 0 02:25:13 INFO - TEST-OK | dromaeo_css | took 1120830ms 02:25:13 INFO - TEST-START | kraken 02:25:13 INFO - operating with platform_type : mac_ 02:25:13 INFO - Initialising browser for kraken test... 02:25:13 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpDjPQQd/profile http://localhost:49247/getInfo.html) 02:25:15 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 02:25:15 INFO - PROCESS | 1662 | colorDepth:24 02:25:15 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 02:25:15 INFO - PROCESS | 1662 | __metrics 02:25:15 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:25:15 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:16 INFO - TEST-INFO | 1662: exit 0 02:25:16 INFO - Browser initialized. 02:25:16 INFO - Running cycle 1/1 for kraken test... 02:25:16 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpDjPQQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:28 INFO - PROCESS | 1664 | RSS: Main: 213721088 02:25:28 INFO - PROCESS | 1664 | 02:25:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:32 INFO - PROCESS | 1664 | RSS: Main: 266625024 02:25:32 INFO - PROCESS | 1664 | 02:25:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 02:25:35 INFO - PROCESS | 1664 | RSS: Main: 275206144 02:25:35 INFO - PROCESS | 1664 | 02:25:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 02:25:39 INFO - PROCESS | 1664 | RSS: Main: 373940224 02:25:39 INFO - PROCESS | 1664 | 02:25:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 02:25:41 INFO - PROCESS | 1664 | RSS: Main: 276062208 02:25:41 INFO - PROCESS | 1664 | 02:25:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:44 INFO - PROCESS | 1664 | RSS: Main: 277876736 02:25:44 INFO - PROCESS | 1664 | 02:25:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:47 INFO - PROCESS | 1664 | RSS: Main: 317861888 02:25:47 INFO - PROCESS | 1664 | 02:25:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:51 INFO - PROCESS | 1664 | RSS: Main: 320401408 02:25:51 INFO - PROCESS | 1664 | 02:25:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 02:25:54 INFO - PROCESS | 1664 | RSS: Main: 315322368 02:25:54 INFO - PROCESS | 1664 | 02:25:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:25:56 INFO - PROCESS | 1664 | RSS: Main: 293998592 02:25:56 INFO - PROCESS | 1664 | 02:25:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:25:59 INFO - PROCESS | 1664 | RSS: Main: 297320448 02:25:59 INFO - PROCESS | 1664 | 02:26:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:02 INFO - PROCESS | 1664 | RSS: Main: 299577344 02:26:02 INFO - PROCESS | 1664 | 02:26:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:05 INFO - PROCESS | 1664 | RSS: Main: 317718528 02:26:05 INFO - PROCESS | 1664 | 02:26:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:09 INFO - PROCESS | 1664 | RSS: Main: 311037952 02:26:09 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 02:26:11 INFO - PROCESS | 1664 | RSS: Main: 355700736 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | __start_tp_report 02:26:11 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:26:11 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:26:11 INFO - PROCESS | 1664 | |i|pagename|runs| 02:26:11 INFO - PROCESS | 1664 | |0;ai-astar;115;115;114;114;113;114;115;114;113;115 02:26:11 INFO - PROCESS | 1664 | |1;audio-beat-detection;137;109;110;147;109;112;110;110;128;109 02:26:11 INFO - PROCESS | 1664 | |2;audio-dft;188;183;185;188;184;182;187;182;182;182 02:26:11 INFO - PROCESS | 1664 | |3;audio-fft;80;59;59;89;63;60;73;83;97;74 02:26:11 INFO - PROCESS | 1664 | |4;audio-oscillator;91;70;87;70;68;71;82;67;69;82 02:26:11 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;89;88;90;87;87;86;89;86;88;88 02:26:11 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;95;96;98;96;96;97;97;95;96 02:26:11 INFO - PROCESS | 1664 | |7;imaging-desaturate;85;85;93;87;84;87;87;89;132;85 02:26:11 INFO - PROCESS | 1664 | |8;json-parse-financial;56;53;53;54;56;55;56;56;56;57 02:26:11 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;63;72;73;72;93;69;69;69;69;70 02:26:11 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;83;84;83;84;83;83;85;87;88;85 02:26:11 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;137;143;148;146;137;139;137;139;183;149 02:26:11 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;172;165;169;169;167;169;170;164;166;176 02:26:11 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;66;66;67;66;65;66;65;65;64;65 02:26:11 INFO - PROCESS | 1664 | __end_tp_report 02:26:11 INFO - PROCESS | 1664 | __start_cc_report 02:26:11 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2084 02:26:11 INFO - PROCESS | 1664 | __end_cc_report 02:26:11 INFO - PROCESS | 1664 | __startTimestamp1487499971378__endTimestamp 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:26:11 INFO - PROCESS | 1664 | Number of tests: 14 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 02:26:11 INFO - PROCESS | 1664 | Values: 115.0 115.0 114.0 114.0 113.0 114.0 115.0 114.0 113.0 115.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:111.00 stddev:14.04 (12.6%) stddev-sans-first:13.11 02:26:11 INFO - PROCESS | 1664 | Values: 137.0 109.0 110.0 147.0 109.0 112.0 110.0 110.0 128.0 109.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:2.54 (1.4%) stddev-sans-first:2.32 02:26:11 INFO - PROCESS | 1664 | Values: 188.0 183.0 185.0 188.0 184.0 182.0 187.0 182.0 182.0 182.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:73.70 Median:77.00 stddev:13.49 (17.5%) stddev-sans-first:14.12 02:26:11 INFO - PROCESS | 1664 | Values: 80.0 59.0 59.0 89.0 63.0 60.0 73.0 83.0 97.0 74.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.50 stddev:8.87 (11.6%) stddev-sans-first:7.48 02:26:11 INFO - PROCESS | 1664 | Values: 91.0 70.0 87.0 70.0 68.0 71.0 82.0 67.0 69.0 82.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 02:26:11 INFO - PROCESS | 1664 | Values: 89.0 88.0 90.0 87.0 87.0 86.0 89.0 86.0 88.0 88.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 02:26:11 INFO - PROCESS | 1664 | Values: 96.0 95.0 96.0 98.0 96.0 96.0 97.0 97.0 95.0 96.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:87.00 stddev:14.50 (16.7%) stddev-sans-first:15.19 02:26:11 INFO - PROCESS | 1664 | Values: 85.0 85.0 93.0 87.0 84.0 87.0 87.0 89.0 132.0 85.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.40 (2.5%) stddev-sans-first:1.45 02:26:11 INFO - PROCESS | 1664 | Values: 56.0 53.0 53.0 54.0 56.0 55.0 56.0 56.0 56.0 57.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.00 stddev:7.91 (11.1%) stddev-sans-first:7.70 02:26:11 INFO - PROCESS | 1664 | Values: 63.0 72.0 73.0 72.0 93.0 69.0 69.0 69.0 69.0 70.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.78 (2.1%) stddev-sans-first:1.80 02:26:11 INFO - PROCESS | 1664 | Values: 83.0 84.0 83.0 84.0 83.0 83.0 85.0 87.0 88.0 85.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:144.50 stddev:13.87 (9.6%) stddev-sans-first:14.34 02:26:11 INFO - PROCESS | 1664 | Values: 137.0 143.0 148.0 146.0 137.0 139.0 137.0 139.0 183.0 149.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:3.53 (2.1%) stddev-sans-first:3.54 02:26:11 INFO - PROCESS | 1664 | Values: 172.0 165.0 169.0 169.0 167.0 169.0 170.0 164.0 166.0 176.0 02:26:11 INFO - PROCESS | 1664 | 02:26:11 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 02:26:11 INFO - PROCESS | 1664 | Values: 66.0 66.0 67.0 66.0 65.0 66.0 65.0 65.0 64.0 65.0 02:26:11 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:26:11 INFO - PROCESS | 1664 | 02:26:12 INFO - TEST-INFO | 1664: exit 0 02:26:12 INFO - TEST-OK | kraken | took 58798ms 02:26:12 INFO - SUITE-END | took 1179s 02:26:12 INFO - Completed test suite (00:19:39) 02:26:12 INFO - javascript benchmark 02:26:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.7636945221907, 3329.0678609989213, 3338.8497517611704, 3352.865885364584, 3370.090075679565, 5583.748731307091, 5661.433856614337, 5688.744006519706, 5693.572982026344, 5700.1449782532645, 5648.4633959773855, 5654.236678048463, 5755.25181726376, 5756.971215143918, 5757.856053598652, 5202.635815492917, 5212.087884620195, 5219.295395121667, 5235.1885457753915, 5284.313039304885, 5122.257272695476, 5136.460671629462, 5153.871153221162, 5307.177387504924, 5326.227696983954, 5166.689998600077, 5179.482051794828, 5193.948060519403, 5245.423003469616, 5256.369235691704, 5253.500917412878, 5261.500157485052, 5269.6311258211945, 5287.471252874701, 5321.467853214686, 5080.161773307437, 5151.5106064923775, 5208.817691380821, 5226.346706661668, 5241.9213711794355, 5561.193626924114, 5571.415001424833, 5606.691631960241, 5641.971790141064, 5662.405447428002, 6177.752889884399, 6215.440610345046, 6217.129601855744, 6221.626702397825, 6231.314555398948, 6195.7521699131985, 6257.593256438363, 6261.8747625047245, 6264.686765661744, 6269.185005949197, 4669.673122881366, 5619.915701264485, 5670.489655930904, 5815.127730840408, 5839.0949402842625, 6267.0286105653695, 6325.114483972247, 6357.141785858942, 6360.618362898241, 6372.968135159294, 6178.938210617926, 6188.81433556994, 6189.195404597373, 6190.907136392958, 6216.844578885473, 6139.995903338765, 6168.25980882297, 6198.535109866778, 6212.534059945522, 6231.875362492725, 6133.457080270768, 6187.288461826857, 6187.597806142587, 6231.034189700604, 6236.376362363727, 6207.6585787781205, 6217.751289948352, 6221.720022598994, 6226.875462490725, 6228.47058000066, 4907.09218794517, 4988.6757360771435, 5040.067587496325, 5042.823501177441, 5056.772445239973, 4395.208862404734, 4411.7794110295, 4446.177457170434, 4449.243628583149, 4477.977610111994, 5893.852653683606, 5915.142304365843, 5925.288965324189, 5950.0, 5962.34414214436, 6115.118650813463, 6121.908171377433, 6129.908988904127, 6165.475934545524, 6218.906716399258, 5811.476967072984, 5837.182794408786, 5888.293404791452, 5892.322382925932, 5930.7924222652, 5339.706316152571, 5373.7581808818695, 5378.78484860609, 5453.345598528202, 5454.809081682201, 6298.275698294755, 6310.873782524415, 6322.114903913548, 6444.806655800334, 6467.320931302145, 6257.374262573706, 6259.561830671809, 6270.153529273673, 6274.372562743689, 6283.937160628335, 6159.1069294951085, 6420.1974753155855, 6427.1002059710745, 6430.2926678066315, 6438.7102580384935, 6049.0, 6118.710550942667, 6131.804871722127, 6154.446099851035, 6208.00671892495, 6186.566940314135, 6231.9688401557705, 6232.283287422005, 6238.906416403667, 6252.562320637694, 5003.874128321098, 6102.328743838263, 6166.845828854314, 6180.165677633642, 6191.318954914866, 5914.172015917861, 5950.613210141327, 6096.420840020191, 6102.694865256631, 6108.463491842691, 6030.939690603038, 6065.181200537871, 6065.272167339947, 6066.817995460143, 6081.0, 5029.899402012013, 6159.599626024294, 6165.383461653799, 6183.598066125687, 6187.133801267916, 5735.11105778605, 5845.1232315153065, 5876.471117599436, 5879.235699359056, 5996.67018313997], "value": 5700.451169809177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.4520620461652, 491.08657896312855, 504.9596032317415, 507.79434329096716, 547.0071819647342, 30559.847200763994, 36600.81699591502, 40489.0, 42009.15981680364, 44123.77938110313, 43421.34867976975, 43944.0, 43976.0, 44019.0, 44023.559764402344, 8354.24811766941, 9283.81432371354, 9450.480223587734, 9458.00690927453, 9468.053194680546, 8372.079071302152, 11233.775324493505, 11446.599369022086, 11495.540178392854, 11698.766024679502, 11429.942850285737, 11488.13838962077, 11498.482568284406, 11504.0, 11532.769344613103, 8399.244068033906, 11451.885481145207, 11493.885061149365, 11502.942485287562, 11508.309501429942, 8434.831303373898, 11139.944300278528, 11411.714707132389, 11420.257683250562, 11648.126390520745, 40622.796886015676, 41028.79485602583, 41034.58965410337, 41064.0, 41130.79434602838, 3941.6182061899976, 3953.6639385652256, 3980.223856348013, 3984.183242435294, 4005.5794141615293, 29647.258818529495, 29683.109506714834, 29708.108756737332, 30545.541816872767, 30674.0, 3079.3687294104657, 3144.5912031435996, 3224.8548815303366, 3324.0526449961885, 3325.7671962962604, 452620.0, 453619.0, 454545.0, 455253.0, 456664.0, 62855.0, 63108.0, 63211.0, 63252.683736581945, 63305.366946329945, 63442.0483692745, 63496.0, 63515.6824215876, 63586.0, 63673.95097465826, 15119.412461691583, 15999.200039998186, 16521.0, 16866.325346985985, 16916.323347066227, 11724.531018759155, 11987.460564274628, 12828.93585532085, 12897.35513224335, 12897.613071607866, 14909.478168264059, 15001.174935378658, 15039.323230454656, 15061.47284845047, 15081.849181508045, 4918.532739389752, 5791.0734282514595, 6345.620392352867, 6435.0, 6468.579542329828, 806.4435539477741, 868.5092922498768, 872.6378552900602, 876.4522173641474, 896.789254525186, 29154.85422572916, 29495.410091798472, 29569.55645665317, 30603.081907542808, 30626.846865765976, 798.6805277888891, 941.868138460616, 1079.3362082319475, 1162.8313894485252, 1174.3893175548667, 14508.927455362656, 14838.109713417014, 14851.851481485046, 15593.610159746097, 15595.688086238211, 626565.0, 631677.0, 632767.0, 632935.0, 633157.0, 61666.69166654138, 62001.37998620046, 62012.069818952754, 62024.06963895545, 62116.689416552625, 1411.2661416063795, 1442.386985531145, 1459.2484870291596, 1462.2688655672164, 1464.3556834992569, 27818.860905695343, 28891.0, 29159.0, 29360.944733869277, 29922.551161732157, 50626.49373506218, 51046.0, 51047.0, 51151.0, 51549.226761597856, 507574.0, 508642.0, 509984.0, 509991.0, 510548.0, 38972.6102738969, 39321.80339098286, 39721.0, 39727.60272397355, 40093.59906401015, 45845.77077114593, 46284.7685761569, 47006.0, 47011.29483057689, 47077.529224707316, 35289.47065794066, 35438.64561354354, 35855.0, 37157.25685486329, 38204.85385438441, 35360.469592956644, 35395.64604353924, 36628.267434651694, 36784.81607591945, 36827.447588285664, 35158.47262291119, 35637.82181089078, 36101.638983609824, 36149.63850361568, 36334.90995270146, 26634.600480993187, 31659.84170079135, 32022.77104057076, 32510.0, 32533.0, 23921.641175382036, 24257.401028405548, 24448.388790280384, 24528.754712452646, 24996.37509062288], "value": 20003.34659363259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.5512943432407, 376.476697390627, 380.5851621732313, 387.73246459942646, 411.94644696189494, 14262.0, 15223.619409514768, 17751.467455976326, 20756.0, 20975.378077740283, 20253.69619455706, 21092.894535527303, 22044.779552204473, 22375.440613984658, 22422.103115875387, 5204.531592156705, 5243.659162154458, 5257.7108259045735, 5262.368515778093, 5972.0, 5838.591298609099, 5956.70216489176, 5967.104934259853, 5968.194293770351, 5975.790847320344, 3891.416287556861, 4093.0585965228015, 4798.920242945344, 5823.0, 6065.211522502091, 5582.413846546095, 6082.482988945922, 6096.085587161917, 6108.053251746009, 6114.847128821771, 5701.57238207132, 5815.73829177688, 5820.82537523875, 5828.825135245949, 5832.9708351457975, 13231.0, 15324.616884577863, 20584.79415205844, 25634.974601015936, 26033.609495857578, 2645.8412495250345, 2804.3129433288773, 2819.492491351556, 2875.43928933858, 2974.2861713188895, 15757.212139392985, 16708.74936875948, 17018.65962680752, 17820.376286829898, 17913.19390627425, 1941.369055057112, 1975.2790231565518, 1984.2955750708436, 1989.9403017909485, 1999.7400337955974, 123782.0, 162926.1853690736, 164551.17724411542, 174665.0, 176021.0, 19576.510587235432, 24174.0, 24310.149144779847, 24774.876125619256, 24778.25665230046, 42775.71672849819, 42789.0, 43617.12765744731, 44051.559484405385, 44063.77968110139, 9487.335886488017, 11120.277181983145, 11261.943690281496, 11681.396497776828, 11702.590409335802, 9208.90791092094, 9283.210927071139, 9302.395344302598, 9351.672691455766, 9768.51157442125, 10992.725181870357, 11066.833997490045, 11097.33415995043, 11154.721131971603, 11167.994880460798, 3674.8975307407673, 3856.9614303857165, 3883.8834834954996, 4150.605692459211, 4251.489821221411, 984.4191926763101, 1008.5713571731984, 1017.6794309792392, 1030.1861529391847, 1053.5048527192207, 20795.792042079687, 21122.471938201666, 21270.680939785914, 21275.680864787042, 21494.89252553727, 913.8987520038471, 985.5663508056432, 1021.4688362051692, 1062.2458054781036, 1065.3767545985531, 10634.627788027537, 10898.232894428094, 10966.342019478856, 11022.669319920415, 11029.062529685067, 705894.0, 714431.0, 714546.0, 731121.0, 747646.0, 107667.0, 109442.0, 127218.0, 159936.0, 163591.18204408902, 959.8080383923243, 987.5259875259771, 1024.574801457387, 1073.0717928991367, 1083.230906056693, 18427.0, 18611.72082418792, 19412.611747765248, 19487.317943871898, 19498.902505487382, 52999.73500132475, 53199.0, 53923.0, 54732.72633636806, 60899.78200436055, 66886.33113668801, 73919.8912016331, 78369.0, 79634.0, 82427.5878620603, 6632.966835165793, 6936.618485983319, 7582.886256706264, 7696.461247712607, 7745.148033716174, 12271.509139634314, 13284.136531125447, 13305.334733263491, 13606.0, 13644.795328069888, 5676.233708449472, 6321.494280457644, 11162.944185279022, 11288.153388495732, 11777.823332650189, 8636.913630863612, 10614.203934704774, 11073.224874259047, 11466.656000320003, 11920.821187682019, 11652.883471165518, 11744.0, 11946.701332466759, 12050.397480126134, 12089.637310880687, 7478.214787447458, 7565.2812982766545, 7675.884861726967, 7896.09194942589, 8736.126387361468, 9798.755031123994, 10265.12746416563, 11305.0, 11566.537338506701, 11710.238834475731], "value": 10891.768837787859, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.756846199222, 1356.159181307589, 1449.2463918762244, 1464.2166440954093, 1467.1270593996576, 7965.800854978628, 8417.83164336713, 8420.957895210515, 8421.368397370206, 8430.494170349783, 7409.259074092588, 7660.770176894688, 7666.34836038936, 7974.242446967529, 8138.186181381859, 2304.8156147508157, 2351.905923763047, 2352.12971200656, 2352.647102934565, 2353.670486131943, 2267.716535433071, 2302.8157747380255, 2328.359701082199, 2367.95264094718, 2373.786359227669, 2030.2995466564012, 2109.0, 2248.325502349297, 2317.327974887289, 2336.042222688698, 2317.6060069788177, 2326.31373744744, 2328.406256404623, 2330.603797354454, 2332.953340933172, 2270.818334533233, 2323.6514522821544, 2346.6831977682964, 2349.6592994015773, 2360.362702070431, 8308.0, 8334.291585215264, 8348.749537513884, 8398.076211616717, 8402.411831171821, 5054.671446355975, 5135.563477104451, 5141.434442211354, 5176.120059589879, 5223.13818219997, 3232.983835080833, 3260.543523906655, 3316.8341582920757, 3486.9651303486894, 3534.2401383702627, 1163.5811108001112, 1209.8911098001133, 1213.6723084767152, 1259.7732408166526, 1261.627819793154, 10747.19396045292, 10827.729306767314, 10883.945580272128, 10903.727406814814, 10917.39954302513, 4489.19194544985, 4683.555062269147, 4732.763361831895, 4756.072565849626, 4770.546798054179, 9503.66737164196, 9511.57197926095, 9512.667056652985, 9515.524223788783, 9523.809523809485, 5269.683818970874, 5275.287836142148, 5278.868028299246, 5279.656822306538, 5300.09898317287, 4287.885149861058, 4293.2272191005295, 4654.720716757005, 4734.573888349996, 4791.185498465269, 3815.389537673959, 3864.961350386516, 3978.1844721831953, 3986.1828325193264, 3989.740666856645, 1247.6756043428775, 1258.182181581979, 1266.4174479739238, 1274.388293619068, 1285.0747461827468, 870.2689740617911, 887.7958069644018, 888.5512816027993, 889.4174315823146, 915.7756349694234, 5385.3268341457315, 5568.136938774496, 5605.299337582802, 5614.69119198448, 5663.923854467638, 564.7797359029981, 570.6576054367347, 573.9913901291484, 577.6967092276504, 586.718375179916, 3631.219287853124, 3632.800195989193, 3696.667299943018, 3745.0637340664834, 3764.7176461765475, 9485.288603354777, 9869.161121304769, 9885.555150018266, 9970.401775893324, 10116.747081323027, 10000.199984001263, 10014.599416023277, 10017.599296028224, 10017.749556261006, 10029.247806414549, 7424.183339832614, 7666.348360389429, 7757.53454792703, 7839.529628222325, 7868.173841746649, 5576.107822748503, 5611.859703507445, 5642.0, 5739.971300143639, 5804.100364443518, 8812.735617931472, 8992.100789920956, 9173.495457749888, 9313.068693130905, 9343.719688409086, 8719.38964272495, 9287.257019438564, 9386.906130938603, 9464.810703785748, 9473.24214062887, 6660.300668429745, 6892.965535172292, 7106.289371062852, 7207.243239459991, 7217.747378841926, 6665.733370665119, 7730.806729831799, 8048.758537243892, 8056.879146812686, 8068.031836179696, 7234.74678386254, 7361.079865016873, 7388.519746216479, 7424.331810137113, 7446.441516886147, 7160.928390716026, 7186.281371862772, 7274.454415918933, 7298.416126709957, 7302.0142280791415, 4895.46149923501, 6453.257875344208, 6455.483561315177, 6488.124103246001, 6488.221413430419, 4445.955540444684, 5008.5492305691205, 5059.822906198266, 5087.364079490064, 5097.643164978416, 4612.654050946126, 4840.370751802243, 5024.598032157492, 5039.823606173766, 5169.457206993362], "value": 4356.143415361702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.30336893673706, 351.8891549162014, 362.23206801580653, 371.33716316375273, 374.9962500374997, 4134.917301653969, 4226.852060177886, 4776.522347765226, 5046.0, 5141.614378921578, 4219.346001369785, 4940.283658869462, 4960.0, 5042.647014708972, 5060.734816295926, 3428.742844286676, 4016.9355120892988, 4036.414719865618, 4040.2525532776385, 4051.453053837731, 3237.983810080946, 3598.1004748812798, 3790.3656958413912, 4063.9593604063875, 4083.1629515949157, 3872.961270387288, 3990.840366385341, 4074.6129117733767, 4128.174365126972, 4135.710500264968, 3121.562981182636, 3496.5629296337956, 4043.858464953742, 4051.513818341803, 4084.0, 3489.6859282664427, 3642.8889188797407, 3658.8657516170074, 3676.650718181795, 3702.8518859245596, 4352.496240526375, 4552.749598772066, 4699.389079419653, 4976.477469865648, 5054.191329387317, 4630.693455086768, 4667.976660116712, 4690.0, 4742.5298157570915, 4787.928181077286, 4729.337892694991, 5314.973425132888, 5402.892407056544, 5424.891502169974, 5433.7283135843445, 3881.3401721707096, 4001.8199181036925, 4022.557518672944, 4032.717709760318, 4052.4529188559463, 4955.231939049453, 5413.593980451482, 5588.888222235532, 5688.800891968761, 5689.862027594498, 4074.7555146691293, 4082.897927551835, 4090.466075221792, 4095.7542547447247, 4118.897027574335, 3950.9802450987563, 4108.383742438598, 4112.321466957978, 4158.9376159357025, 4171.791410429527, 4638.652101092432, 4640.721556706609, 4646.25659894422, 4650.395448591661, 4718.8584342469785, 4565.771711414416, 5424.1321388577635, 5468.7539060742365, 5476.205950137208, 5477.863053423696, 1084.6854412220525, 1213.9757204855853, 1297.5134324628264, 1340.0, 1360.7346567419258, 840.8990921089509, 931.3527098666498, 946.7727745341068, 968.4770224079059, 972.8492083726892, 4007.7156021067713, 4732.432108146975, 4747.0537079797805, 4747.8100875965265, 4762.9761851191215, 4488.461384633865, 4885.0, 4930.559373110262, 4974.328465657162, 5264.920691258283, 4051.8784436466954, 4594.333821595917, 4616.422947131608, 4690.64820138491, 4720.480747117815, 2733.904313349023, 2741.8629068546493, 2747.049594787723, 2749.505089083984, 2757.076379412879, 4502.684812063124, 4512.796924138422, 5126.846459546647, 5335.67985920846, 5426.67439953604, 4648.372469716613, 4719.4100737407825, 5248.370195576479, 5310.097283461821, 5316.255724198615, 4615.861524154281, 4858.489858564941, 5189.662671926313, 5348.475684429919, 5379.811706590329, 4463.977680111579, 4923.236898280772, 4964.96756440926, 5167.405748338989, 5177.508136727005, 5495.5878309127775, 5504.889902201853, 5532.557395408277, 5572.4706152915405, 5582.0, 4457.665675074447, 4637.76811159434, 5270.0, 5767.8558036049435, 5772.134179873053, 3236.9352612948082, 3439.3465241604017, 3677.8528858845348, 3732.869349572752, 3789.2610940866266, 4617.561331673485, 5529.364123125892, 5536.7231638417115, 5538.335399752055, 5554.861128471821, 4804.42346918372, 4831.782569784438, 5168.896622067613, 5469.699166545878, 5534.640248383842, 4973.651844370859, 5370.409254982027, 5481.123020316731, 5487.341519017744, 5495.450454954473, 4872.9512704872495, 4900.932226252274, 5001.849944501525, 5113.974430127825, 5194.558462530727, 5039.748012599429, 5135.768890399866, 5372.7582258797665, 5375.3280839895015, 5386.59600529954, 4143.316352801754, 5096.0, 5267.631265811357, 5268.394134674408, 5269.683818970874], "value": 3945.3798615734463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.531709072012, 728.0644371982004, 763.2253262938119, 823.8352329534093, 832.6794184239068, 14655.633609159777, 15637.21813909303, 15661.0, 15685.921570392145, 15704.057756534601, 14456.5663030109, 14463.638409039779, 14466.349014294356, 14613.0, 14641.92679036606, 674.9898751518731, 701.0, 849.7153453593038, 863.7624653220352, 868.7741187291318, 831.4886344897905, 855.9657613695476, 860.1613426908746, 865.4504389712546, 866.800635853754, 921.6497730862296, 922.9400088994194, 924.2144177449148, 925.3615005646083, 926.647873807952, 921.7465197070792, 923.4643906534194, 924.0851556958596, 926.087803513542, 926.2266007883426, 525.4719007397579, 547.1655725019338, 549.9147632117028, 550.3176061683523, 688.2051230828401, 12244.387780611023, 13806.516771912935, 14255.857441425556, 14853.331600077914, 15145.318460669187, 14166.291685415688, 14187.432502699983, 14188.645283867883, 14214.715705685932, 14254.501092461818, 11255.943720281428, 11622.360770157638, 11669.533218671328, 11743.823842642367, 11864.963939913168, 3518.2435776308216, 3569.6430356964356, 3642.1076836175307, 3702.8518859245596, 3781.5840257571645, 111460.0, 112422.0, 113505.0, 113680.0, 116764.0, 10777.407242601575, 10859.891401085888, 10870.184736144663, 11009.37595220616, 11554.364509951865, 22713.772862271497, 23188.768112318998, 23318.65022024671, 23326.066957321855, 23358.416039599146, 7659.195784442553, 7687.692492300245, 7718.845623087507, 7735.381169506426, 7989.0, 4144.730592511477, 4152.688548358885, 4256.34026725858, 4323.286657701444, 4388.561143885586, 3483.390406678872, 3552.5381700379303, 3557.3774589446743, 3561.5013898054294, 3590.676839084495, 620.2618883528587, 627.137685682187, 636.6021236727046, 650.5933791380387, 653.8300041989022, 649.555054787472, 677.6306912732573, 693.549193024528, 701.1340993872564, 715.4312321704258, 9728.0, 10146.137578305927, 10151.898481015243, 10276.332038417479, 10379.792404151875, 627.8587317853446, 657.135866335767, 674.3122015544118, 697.9441644668415, 719.8812195987708, 4005.5193376794973, 4154.584541545882, 4708.882277943078, 4905.482276374281, 4931.5561599455505, 90938.0, 101659.0, 101846.49076754569, 103188.0, 109909.45045274723, 73672.0, 78522.6073869627, 82658.58670706608, 87616.0, 89453.0, 67760.96717098495, 76100.61949690216, 78383.0, 80244.19755802484, 80848.14911105353, 9562.99588543193, 9577.712668619952, 9590.136887680143, 9618.567164477756, 9655.710328690151, 48616.027679445506, 48925.5107448921, 49393.259101112795, 49745.0, 50518.74740626274, 63684.68157659182, 63862.36137638564, 64614.353856462716, 66211.0, 67806.66096669485, 9686.0, 11572.537098516303, 11658.12564057716, 11900.167053132662, 12459.06557008246, 12339.876601234231, 12503.356038383208, 12528.248305101723, 12737.108402411743, 12891.290978996245, 10859.619913302997, 11434.71413214643, 11594.361598343427, 11719.824202636797, 11906.76186476283, 10438.947805261228, 11366.204365694322, 11922.761544768882, 11939.641810745692, 12012.579559715718, 11680.883191167979, 11881.405929703307, 11881.5841445549, 12000.699982500508, 12255.142140050111, 8100.457571746621, 9894.208463322773, 9999.550020249251, 10118.49407529606, 10474.109700675528, 9162.816743664956, 9272.490013049348, 9674.274429417963, 9679.419234845931, 9680.903190968282], "value": 7252.827987784238, "unit": "score"}], "name": "dromaeo_css", "value": 7327.852988756294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 110.0, 147.0, 109.0, 112.0, 110.0, 110.0, 128.0, 109.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 185.0, 188.0, 184.0, 182.0, 187.0, 182.0, 182.0, 182.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 89.0, 63.0, 60.0, 73.0, 83.0, 97.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 70.0, 68.0, 71.0, 82.0, 67.0, 69.0, 82.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 87.0, 87.0, 86.0, 89.0, 86.0, 88.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 93.0, 87.0, 84.0, 87.0, 87.0, 89.0, 132.0, 85.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 73.0, 72.0, 93.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 83.0, 83.0, 85.0, 87.0, 88.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 148.0, 146.0, 137.0, 139.0, 137.0, 139.0, 183.0, 149.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 169.0, 169.0, 167.0, 169.0, 170.0, 164.0, 166.0, 176.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1433.0, "alertThreshold": 2.0}]} 02:26:12 INFO - Return code: 0 02:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:12 ERROR - # TBPL SUCCESS # 02:26:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:12 INFO - 2017-02-19 02:26:12.681 screenresolution[1668:14184] starting screenresolution argv=screenresolution get 02:26:12 INFO - 2017-02-19 02:26:12.684 screenresolution[1668:14184] Display 0: 1600x1200x32@60 02:26:12 INFO - 2017-02-19 02:26:12.690 screenresolution[1669:14187] starting screenresolution argv=screenresolution list 02:26:12 INFO - Available Modes on Display 0 02:26:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:12 INFO - Intel Iris: 02:26:12 INFO - Chipset Model: Intel Iris 02:26:12 INFO - Type: GPU 02:26:12 INFO - Bus: Built-In 02:26:12 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:12 INFO - Vendor: Intel (0x8086) 02:26:12 INFO - Device ID: 0x0a2e 02:26:12 INFO - Revision ID: 0x0009 02:26:12 INFO - Displays: 02:26:12 INFO - Display: 02:26:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:12 INFO - Display Serial Number: 1600x1200 60 02:26:12 INFO - Main Display: Yes 02:26:12 INFO - Mirror: Off 02:26:12 INFO - Online: Yes 02:26:12 INFO - Rotation: Supported 02:26:12 INFO - Return code: 0 02:26:12 INFO - Running post-action listener: _resource_record_post_action 02:26:12 INFO - [mozharness: 2017-02-19 10:26:12.927713Z] Finished run-tests step (success) 02:26:12 INFO - Running post-run listener: _resource_record_post_run 02:26:12 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 31554560; Write bytes: 511235584; Read time: 194; Write time: 1601 02:26:12 INFO - TinderboxPrint: CPU usage
53.5% 02:26:12 INFO - TinderboxPrint: I/O read bytes / time
31,554,560 / 194 02:26:12 INFO - TinderboxPrint: I/O write bytes / time
511,235,584 / 1,601 02:26:12 INFO - TinderboxPrint: CPU idle
2,233.9 (46.5%) 02:26:12 INFO - TinderboxPrint: CPU system
957.1 (19.9%) 02:26:12 INFO - TinderboxPrint: CPU user
1,614.6 (33.6%) 02:26:12 INFO - TinderboxPrint: Swap in / out
234,876,928 / 0 02:26:12 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201343488; Write bytes: 200871424; Read time: 15741; Write time: 440 02:26:13 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29658112; Write bytes: 299673600; Read time: 178; Write time: 1126 02:26:13 INFO - Running post-run listener: _upload_blobber_files 02:26:13 INFO - Blob upload gear active. 02:26:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:13 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 02:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:15 INFO - (blobuploader) - INFO - Done attempting. 02:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:16 INFO - (blobuploader) - INFO - Done attempting. 02:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:17 INFO - (blobuploader) - INFO - Done attempting. 02:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:19 INFO - (blobuploader) - INFO - Done attempting. 02:26:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:19 INFO - Return code: 0 02:26:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23911f46da34e6a0090e47cbb5856ba43ee72fab8830498a92a1c5698f078d3d3d222bf226b66b88347e52dbe4b331f0cbbe62f679a4ecb294d28d2c0d3b3637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba428598f9c2774733776b65a310bf38756f1c04b2fa4f80987cc33321b6ff31d18c1c83d0d5230abce096cb53845a2a37685d141c6c4cc532a7e21d0ae9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dcb6acc5332ddcd6dea6ccf435bcf09f6b1542ee979a21114ec6a191722e92a78cdef12cb07656280f15cea8f2a8e0f7a9f1d1e2c1d14042435dd0335da70ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757f52bb9a2ef24f0a84c1cfc7a30db2fdf352f6bdaf7b850ca58d0c20f6129710431a85d5d393dec48a090d4f0e5fb415e29cc4e9ab6d92ecdac969a63dbc"} 02:26:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:19 INFO - Contents: 02:26:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23911f46da34e6a0090e47cbb5856ba43ee72fab8830498a92a1c5698f078d3d3d222bf226b66b88347e52dbe4b331f0cbbe62f679a4ecb294d28d2c0d3b3637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba428598f9c2774733776b65a310bf38756f1c04b2fa4f80987cc33321b6ff31d18c1c83d0d5230abce096cb53845a2a37685d141c6c4cc532a7e21d0ae9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dcb6acc5332ddcd6dea6ccf435bcf09f6b1542ee979a21114ec6a191722e92a78cdef12cb07656280f15cea8f2a8e0f7a9f1d1e2c1d14042435dd0335da70ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757f52bb9a2ef24f0a84c1cfc7a30db2fdf352f6bdaf7b850ca58d0c20f6129710431a85d5d393dec48a090d4f0e5fb415e29cc4e9ab6d92ecdac969a63dbc"} 02:26:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:19 INFO - Copying logs to upload dir... 02:26:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.901770 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-02-19 02:26:19.809938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-19 02:26:19.813101) ========= 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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23911f46da34e6a0090e47cbb5856ba43ee72fab8830498a92a1c5698f078d3d3d222bf226b66b88347e52dbe4b331f0cbbe62f679a4ecb294d28d2c0d3b3637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba428598f9c2774733776b65a310bf38756f1c04b2fa4f80987cc33321b6ff31d18c1c83d0d5230abce096cb53845a2a37685d141c6c4cc532a7e21d0ae9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dcb6acc5332ddcd6dea6ccf435bcf09f6b1542ee979a21114ec6a191722e92a78cdef12cb07656280f15cea8f2a8e0f7a9f1d1e2c1d14042435dd0335da70ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757f52bb9a2ef24f0a84c1cfc7a30db2fdf352f6bdaf7b850ca58d0c20f6129710431a85d5d393dec48a090d4f0e5fb415e29cc4e9ab6d92ecdac969a63dbc"} build_url:https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010373 build_url: 'https://queue.taskcluster.net/v1/task/S7KY0hiGRyW6_G5KSG2Z8w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23911f46da34e6a0090e47cbb5856ba43ee72fab8830498a92a1c5698f078d3d3d222bf226b66b88347e52dbe4b331f0cbbe62f679a4ecb294d28d2c0d3b3637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba428598f9c2774733776b65a310bf38756f1c04b2fa4f80987cc33321b6ff31d18c1c83d0d5230abce096cb53845a2a37685d141c6c4cc532a7e21d0ae9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dcb6acc5332ddcd6dea6ccf435bcf09f6b1542ee979a21114ec6a191722e92a78cdef12cb07656280f15cea8f2a8e0f7a9f1d1e2c1d14042435dd0335da70ed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757f52bb9a2ef24f0a84c1cfc7a30db2fdf352f6bdaf7b850ca58d0c20f6129710431a85d5d393dec48a090d4f0e5fb415e29cc4e9ab6d92ecdac969a63dbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-19 02:26:19.847348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:26:19.847718) ========= 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.l9qsxdKOZJ/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.w0Kf2OtUes/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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.005285 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-19 02:26:19.896471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-19 02:26:19.896808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-19 02:26:19.897159) ========= ========= Total master_lag: 0.27 =========