builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1491124119.46 results: success (0) buildid: 20170402004002 builduid: 3f471643fc814268b9e1960e2ba80817 revision: 260ad3e3f8970a637c8acef0b83fde9da19d1044 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:39.460642) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:39.461178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:39.461472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:39.489504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:39.489921) ========= 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.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-02 02:08:39-- 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% 9.02M=0.001s 2017-04-02 02:08:40 (9.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.638311 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:40.161662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:40.161999) ========= 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.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.028230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:40.216087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:40.216438) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 260ad3e3f8970a637c8acef0b83fde9da19d1044 --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 260ad3e3f8970a637c8acef0b83fde9da19d1044 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-02 02:08:40,291 truncating revision to first 12 chars 2017-04-02 02:08:40,291 Setting DEBUG logging. 2017-04-02 02:08:40,291 attempt 1/10 2017-04-02 02:08:40,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/260ad3e3f897?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 02:08:40,957 unpacking tar archive at: mozilla-aurora-260ad3e3f897/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:41.177205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:41.177488) ========= script_repo_revision: 260ad3e3f8970a637c8acef0b83fde9da19d1044 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:41.177892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:41.178167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 02:08:41.198497) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-02 02:08:41.198796) ========= /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.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:08:41 INFO - MultiFileLogger online at 20170402 02:08:41 in /builds/slave/test 02:08:41 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:08:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:41 INFO - {'append_to_log': False, 02:08:41 INFO - 'base_work_dir': '/builds/slave/test', 02:08:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:08:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:41 INFO - 'branch': 'Mozilla-Aurora', 02:08:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:41 INFO - 'config_files': ('talos/mac_config.py',), 02:08:41 INFO - 'default_actions': ('clobber', 02:08:41 INFO - 'read-buildbot-config', 02:08:41 INFO - 'download-and-extract', 02:08:41 INFO - 'populate-webroot', 02:08:41 INFO - 'create-virtualenv', 02:08:41 INFO - 'install', 02:08:41 INFO - 'run-tests'), 02:08:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:41 INFO - 'download_minidump_stackwalk': True, 02:08:41 INFO - 'download_symbols': 'ondemand', 02:08:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:41 INFO - 'gecko_profile': False, 02:08:41 INFO - 'gecko_profile_interval': 0, 02:08:41 INFO - 'installer_path': 'installer.exe', 02:08:41 INFO - 'log_level': 'info', 02:08:41 INFO - 'log_name': 'talos', 02:08:41 INFO - 'log_to_console': True, 02:08:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:08:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:08:41 INFO - 'opt_config_files': (), 02:08:41 INFO - 'pip_index': False, 02:08:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:41 INFO - 'cmd': ('bash', 02:08:41 INFO - '-c', 02:08:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:41 INFO - 'enabled': True, 02:08:41 INFO - 'halt_on_failure': False, 02:08:41 INFO - 'name': 'check_screen_resolution'},), 02:08:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:41 INFO - 'cmd': ('bash', 02:08:41 INFO - '-c', 02:08:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:41 INFO - 'enabled': True, 02:08:41 INFO - 'halt_on_failure': False, 02:08:41 INFO - 'name': 'check_screen_resolution'},), 02:08:41 INFO - 'run_cmd_checks_enabled': True, 02:08:41 INFO - 'suite': 'dromaeojs', 02:08:41 INFO - 'system_bits': '32', 02:08:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:41 INFO - 'title': 't-yosemite-r7-0060', 02:08:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:41 INFO - 'use_talos_json': True, 02:08:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:41 INFO - 'work_dir': 'build'} 02:08:41 INFO - [mozharness: 2017-04-02 09:08:41.383647Z] Running clobber step. 02:08:41 INFO - Running pre-action listener: _resource_record_pre_action 02:08:41 INFO - Running main action method: clobber 02:08:41 INFO - rmtree: /builds/slave/test/build 02:08:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:43 INFO - Running post-action listener: _resource_record_post_action 02:08:43 INFO - [mozharness: 2017-04-02 09:08:43.994133Z] Finished clobber step (success) 02:08:43 INFO - [mozharness: 2017-04-02 09:08:43.994279Z] Running read-buildbot-config step. 02:08:43 INFO - Running pre-action listener: _resource_record_pre_action 02:08:43 INFO - Running main action method: read_buildbot_config 02:08:43 INFO - Using buildbot properties: 02:08:43 INFO - { 02:08:43 INFO - "project": "", 02:08:43 INFO - "product": "firefox", 02:08:43 INFO - "script_repo_revision": "production", 02:08:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:08:43 INFO - "repository": "", 02:08:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:08:43 INFO - "buildid": "20170402004002", 02:08:43 INFO - "stage_platform": "macosx64", 02:08:43 INFO - "basedir": "/builds/slave/test", 02:08:43 INFO - "nightly_build": "True", 02:08:43 INFO - "buildnumber": 77, 02:08:43 INFO - "slavename": "t-yosemite-r7-0060", 02:08:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:08:43 INFO - "platform": "yosemite_r7", 02:08:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:08:43 INFO - "branch": "mozilla-aurora", 02:08:43 INFO - "repo_path": "releases/mozilla-aurora", 02:08:43 INFO - "revision": "260ad3e3f8970a637c8acef0b83fde9da19d1044", 02:08:43 INFO - "pgo_build": "False", 02:08:43 INFO - "builduid": "3f471643fc814268b9e1960e2ba80817", 02:08:43 INFO - "slavebuilddir": "test" 02:08:43 INFO - } 02:08:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:08:43 INFO - Running post-action listener: _resource_record_post_action 02:08:43 INFO - [mozharness: 2017-04-02 09:08:43.997889Z] Finished read-buildbot-config step (success) 02:08:43 INFO - [mozharness: 2017-04-02 09:08:43.998024Z] Running download-and-extract step. 02:08:43 INFO - Running pre-action listener: _resource_record_pre_action 02:08:43 INFO - Running main action method: download_and_extract 02:08:43 INFO - mkdir: /builds/slave/test/build/tests 02:08:43 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:08:43 INFO - trying https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:08:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:08:44 INFO - Downloaded 1199 bytes. 02:08:44 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:08:44 INFO - Using the following test package requirements: 02:08:44 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:08:44 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:08:44 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:08:44 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'jsshell-mac.zip'], 02:08:44 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:08:44 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:08:44 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:08:44 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:08:44 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:08:44 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:08:44 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:08:44 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:08:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:08:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:08:46 INFO - Expected file size: 51789383 02:08:46 INFO - Obtained file size: 51789383 02:09:02 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:09:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:09:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:09:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:09:04 INFO - Expected file size: 51789383 02:09:04 INFO - Obtained file size: 51789383 02:09:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:09:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:09:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:09:20 INFO - Expected file size: 14404438 02:09:20 INFO - Obtained file size: 14404438 02:09:21 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:09:21 INFO - trying https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:09:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:09:23 INFO - Downloaded 74751721 bytes. 02:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:09:23 INFO - mkdir: /builds/slave/test/properties 02:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:23 INFO - Contents: 02:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:09:23 INFO - Running post-action listener: _resource_record_post_action 02:09:23 INFO - Running post-action listener: set_extra_try_arguments 02:09:23 INFO - [mozharness: 2017-04-02 09:09:23.869417Z] Finished download-and-extract step (success) 02:09:23 INFO - [mozharness: 2017-04-02 09:09:23.869572Z] Running populate-webroot step. 02:09:23 INFO - Running pre-action listener: _resource_record_pre_action 02:09:23 INFO - Running main action method: populate_webroot 02:09:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:23 INFO - '--tppagecycles', 02:09:23 INFO - '7'], 02:09:23 INFO - 'tests': ['tsvgm']}}, 02:09:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:09:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:09:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['damp', 'tps']}, 02:09:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'tests': ['damp', 'tps']}, 02:09:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['dromaeo_dom']}, 02:09:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['basic_compositor_video']}, 02:09:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:09:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['a11yr', 02:09:23 INFO - 'ts_paint', 02:09:23 INFO - 'tpaint', 02:09:23 INFO - 'sessionrestore', 02:09:23 INFO - 'sessionrestore_no_auto_restore', 02:09:23 INFO - 'tabpaint']}, 02:09:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['tsvgx', 02:09:23 INFO - 'tsvgr_opacity', 02:09:23 INFO - 'tart', 02:09:23 INFO - 'tscrollx', 02:09:23 INFO - 'cart', 02:09:23 INFO - 'tsvg_static']}, 02:09:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:09:23 INFO - 'tsvgr_opacity', 02:09:23 INFO - 'tart', 02:09:23 INFO - 'tscrollx', 02:09:23 INFO - 'cart', 02:09:23 INFO - 'tsvg_static']}, 02:09:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'talos_options': ['--disable-e10s'], 02:09:23 INFO - 'tests': ['tp5o']}, 02:09:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:09:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'talos_options': ['--disable-e10s', 02:09:23 INFO - '--xperf_path', 02:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:23 INFO - 'tests': ['tp5n']}, 02:09:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:09:23 INFO - 'talos_options': ['--xperf_path', 02:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:23 INFO - 'tests': ['tp5n']}}, 02:09:23 INFO - 'talos.zip': {'path': '', 02:09:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:23 INFO - Running post-action listener: _resource_record_post_action 02:09:23 INFO - [mozharness: 2017-04-02 09:09:23.888756Z] Finished populate-webroot step (success) 02:09:23 INFO - [mozharness: 2017-04-02 09:09:23.888870Z] Running create-virtualenv step. 02:09:23 INFO - Running pre-action listener: _resource_record_pre_action 02:09:23 INFO - Running main action method: create_virtualenv 02:09:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:23 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:09:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:24 INFO - Using real prefix '/tools/python27' 02:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:27 INFO - Installing pip.................done. 02:09:27 INFO - Return code: 0 02:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:09:27 INFO - Reading from file tmpfile_stdout 02:09:27 INFO - Output received: 02:09:27 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:09:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:27 INFO - 'HOME': '/Users/cltbld', 02:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:27 INFO - 'LOGNAME': 'cltbld', 02:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:27 INFO - 'MOZ_NO_REMOTE': '1', 02:09:27 INFO - 'NO_EM_RESTART': '1', 02:09:27 INFO - 'PAGER': '/bin/cat', 02:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:27 INFO - 'PWD': '/builds/slave/test', 02:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:27 INFO - 'SHELL': '/bin/bash', 02:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:27 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:27 INFO - 'USER': 'cltbld', 02:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:27 INFO - 'XPC_FLAGS': '0x0', 02:09:27 INFO - 'XPC_SERVICE_NAME': '0', 02:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:28 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:09:28 INFO - Cleaning up... 02:09:28 INFO - Return code: 0 02:09:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:28 INFO - 'HOME': '/Users/cltbld', 02:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:28 INFO - 'LOGNAME': 'cltbld', 02:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:28 INFO - 'MOZ_NO_REMOTE': '1', 02:09:28 INFO - 'NO_EM_RESTART': '1', 02:09:28 INFO - 'PAGER': '/bin/cat', 02:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:28 INFO - 'PWD': '/builds/slave/test', 02:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:28 INFO - 'SHELL': '/bin/bash', 02:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:28 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:28 INFO - 'USER': 'cltbld', 02:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:28 INFO - 'XPC_FLAGS': '0x0', 02:09:28 INFO - 'XPC_SERVICE_NAME': '0', 02:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:28 INFO - Downloading/unpacking psutil>=3.1.1 02:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:32 INFO - Installing collected packages: psutil 02:09:32 INFO - Running setup.py install for psutil 02:09:32 INFO - building 'psutil._psutil_osx' extension 02:09:32 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:09:33 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:09:33 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:09:33 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:09:33 INFO - building 'psutil._psutil_posix' extension 02:09:33 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:09:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:09:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:09:33 INFO - ^ 02:09:33 INFO - 1 warning generated. 02:09:33 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:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:33 INFO - Successfully installed psutil 02:09:33 INFO - Cleaning up... 02:09:33 INFO - Return code: 0 02:09:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:09:33 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:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:33 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:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:33 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:33 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:09:33 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:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:33 INFO - 'HOME': '/Users/cltbld', 02:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:33 INFO - 'LOGNAME': 'cltbld', 02:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:33 INFO - 'MOZ_NO_REMOTE': '1', 02:09:33 INFO - 'NO_EM_RESTART': '1', 02:09:33 INFO - 'PAGER': '/bin/cat', 02:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:33 INFO - 'PWD': '/builds/slave/test', 02:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:33 INFO - 'SHELL': '/bin/bash', 02:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:33 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:33 INFO - 'USER': 'cltbld', 02:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:33 INFO - 'XPC_FLAGS': '0x0', 02:09:33 INFO - 'XPC_SERVICE_NAME': '0', 02:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:09:36 INFO - Installing collected packages: mozsystemmonitor 02:09:36 INFO - Running setup.py install for mozsystemmonitor 02:09:36 INFO - Successfully installed mozsystemmonitor 02:09:36 INFO - Cleaning up... 02:09:36 INFO - Return code: 0 02:09:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:09: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:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:36 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:36 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:09:36 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:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:36 INFO - 'HOME': '/Users/cltbld', 02:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:36 INFO - 'LOGNAME': 'cltbld', 02:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:36 INFO - 'MOZ_NO_REMOTE': '1', 02:09:36 INFO - 'NO_EM_RESTART': '1', 02:09:36 INFO - 'PAGER': '/bin/cat', 02:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:36 INFO - 'PWD': '/builds/slave/test', 02:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:36 INFO - 'SHELL': '/bin/bash', 02:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:36 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:36 INFO - 'USER': 'cltbld', 02:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:36 INFO - 'XPC_FLAGS': '0x0', 02:09:36 INFO - 'XPC_SERVICE_NAME': '0', 02:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:37 INFO - Downloading/unpacking jsonschema==2.5.1 02:09: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:09: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:09: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:09: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:09: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:09: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:09:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:40 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:40 INFO - warning: no files found matching '*.txt' 02:09:40 INFO - no previously-included directories found matching 'build' 02:09:40 INFO - no previously-included directories found matching 'dist' 02:09:40 INFO - no previously-included directories found matching '.git*' 02:09:40 INFO - Installing collected packages: jsonschema, functools32 02:09:40 INFO - Running setup.py install for functools32 02:09:40 INFO - warning: no files found matching '*.txt' 02:09:40 INFO - no previously-included directories found matching 'build' 02:09:40 INFO - no previously-included directories found matching 'dist' 02:09:40 INFO - no previously-included directories found matching '.git*' 02:09:40 INFO - Successfully installed jsonschema functools32 02:09:40 INFO - Cleaning up... 02:09:40 INFO - Return code: 0 02:09:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:40 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:09:40 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:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:40 INFO - 'HOME': '/Users/cltbld', 02:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:40 INFO - 'LOGNAME': 'cltbld', 02:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:40 INFO - 'MOZ_NO_REMOTE': '1', 02:09:40 INFO - 'NO_EM_RESTART': '1', 02:09:40 INFO - 'PAGER': '/bin/cat', 02:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:40 INFO - 'PWD': '/builds/slave/test', 02:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:40 INFO - 'SHELL': '/bin/bash', 02:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:40 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:40 INFO - 'USER': 'cltbld', 02:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:40 INFO - 'XPC_FLAGS': '0x0', 02:09:40 INFO - 'XPC_SERVICE_NAME': '0', 02:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:09:40 INFO - Cleaning up... 02:09:40 INFO - Return code: 0 02:09:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:40 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:09:40 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:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:40 INFO - 'HOME': '/Users/cltbld', 02:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:40 INFO - 'LOGNAME': 'cltbld', 02:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:40 INFO - 'MOZ_NO_REMOTE': '1', 02:09:40 INFO - 'NO_EM_RESTART': '1', 02:09:40 INFO - 'PAGER': '/bin/cat', 02:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:40 INFO - 'PWD': '/builds/slave/test', 02:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:40 INFO - 'SHELL': '/bin/bash', 02:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:40 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:40 INFO - 'USER': 'cltbld', 02:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:40 INFO - 'XPC_FLAGS': '0x0', 02:09:40 INFO - 'XPC_SERVICE_NAME': '0', 02:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:41 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:09:41 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:09:41 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:09:41 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:09:41 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:09:41 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:09:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09: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:09: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:09: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:09: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:09: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:09: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:09:45 INFO - Downloading docopt-0.6.1.tar.gz 02:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:45 INFO - Running setup.py install for blobuploader 02:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:45 INFO - Running setup.py install for requests 02:09:45 INFO - Running setup.py install for docopt 02:09:45 INFO - Successfully installed blobuploader requests docopt 02:09:45 INFO - Cleaning up... 02:09:46 INFO - Return code: 0 02:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:46 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:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:46 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:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:46 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:46 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:09:46 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:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:46 INFO - 'HOME': '/Users/cltbld', 02:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:46 INFO - 'LOGNAME': 'cltbld', 02:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:46 INFO - 'MOZ_NO_REMOTE': '1', 02:09:46 INFO - 'NO_EM_RESTART': '1', 02:09:46 INFO - 'PAGER': '/bin/cat', 02:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:46 INFO - 'PWD': '/builds/slave/test', 02:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:46 INFO - 'SHELL': '/bin/bash', 02:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:46 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:46 INFO - 'USER': 'cltbld', 02:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:46 INFO - 'XPC_FLAGS': '0x0', 02:09:46 INFO - 'XPC_SERVICE_NAME': '0', 02:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-UJKtZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-hEbof_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-aPy5mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-504Nyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-xf4fG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-GfQofA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-DIrwcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-oG60HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-J5wumq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-5setBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ctbi80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-z67BzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-g41QYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-h3DP8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-QuaiEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-6KAN6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-kAmTry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:48 INFO - Running setup.py install for manifestparser 02:09:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:48 INFO - Running setup.py install for mozcrash 02:09:48 INFO - Running setup.py install for mozdebug 02:09:48 INFO - Running setup.py install for mozdevice 02:09:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:48 INFO - Running setup.py install for mozfile 02:09:48 INFO - Running setup.py install for mozhttpd 02:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Running setup.py install for mozinfo 02:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Running setup.py install for mozInstall 02:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Running setup.py install for mozleak 02:09:49 INFO - Running setup.py install for mozlog 02:09:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Running setup.py install for moznetwork 02:09:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:49 INFO - Running setup.py install for mozprocess 02:09:49 INFO - Running setup.py install for mozprofile 02:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:50 INFO - Running setup.py install for mozrunner 02:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:50 INFO - Running setup.py install for mozscreenshot 02:09:50 INFO - Running setup.py install for moztest 02:09:50 INFO - Running setup.py install for mozversion 02:09:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:50 INFO - Cleaning up... 02:09:50 INFO - Return code: 0 02:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:50 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:09:50 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:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:50 INFO - 'HOME': '/Users/cltbld', 02:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:50 INFO - 'LOGNAME': 'cltbld', 02:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:50 INFO - 'MOZ_NO_REMOTE': '1', 02:09:50 INFO - 'NO_EM_RESTART': '1', 02:09:50 INFO - 'PAGER': '/bin/cat', 02:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:50 INFO - 'PWD': '/builds/slave/test', 02:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:50 INFO - 'SHELL': '/bin/bash', 02:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:50 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:50 INFO - 'USER': 'cltbld', 02:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:50 INFO - 'XPC_FLAGS': '0x0', 02:09:50 INFO - 'XPC_SERVICE_NAME': '0', 02:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-I9GhOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-wVEL0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-KnhMQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-77pbFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-8YgzMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-7Z5g44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-YXmIyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-mMHoXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-2nHbMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:51 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:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-8vuXtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-JwiibT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-5Cyrex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-B4Y25g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-T5EBmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-1k_92c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-nRPK5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-r2agq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:55 INFO - Downloading blessings-1.6.tar.gz 02:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:55 INFO - Installing collected packages: blessings 02:09:55 INFO - Running setup.py install for blessings 02:09:55 INFO - Successfully installed blessings 02:09:55 INFO - Cleaning up... 02:09:55 INFO - Return code: 0 02:09:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:56 INFO - Reading from file tmpfile_stdout 02:09:56 INFO - Current package versions: 02:09:56 INFO - blessings == 1.6 02:09:56 INFO - blobuploader == 1.2.4 02:09:56 INFO - docopt == 0.6.1 02:09:56 INFO - functools32 == 3.2.3-2 02:09:56 INFO - jsonschema == 2.5.1 02:09:56 INFO - manifestparser == 1.1 02:09:56 INFO - mozInstall == 1.12 02:09:56 INFO - mozcrash == 1.0 02:09:56 INFO - mozdebug == 0.1 02:09:56 INFO - mozdevice == 0.49 02:09:56 INFO - mozfile == 1.2 02:09:56 INFO - mozhttpd == 0.7 02:09:56 INFO - mozinfo == 0.9 02:09:56 INFO - mozleak == 0.1 02:09:56 INFO - mozlog == 3.4 02:09:56 INFO - moznetwork == 0.27 02:09:56 INFO - mozprocess == 0.25 02:09:56 INFO - mozprofile == 0.28 02:09:56 INFO - mozrunner == 6.13 02:09:56 INFO - mozscreenshot == 0.1 02:09:56 INFO - mozsystemmonitor == 0.3 02:09:56 INFO - moztest == 0.8 02:09:56 INFO - mozversion == 1.4 02:09:56 INFO - psutil == 3.1.1 02:09:56 INFO - requests == 1.2.3 02:09:56 INFO - wsgiref == 0.1.2 02:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:56 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:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:56 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:09:56 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:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:56 INFO - 'HOME': '/Users/cltbld', 02:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:56 INFO - 'LOGNAME': 'cltbld', 02:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:56 INFO - 'MOZ_NO_REMOTE': '1', 02:09:56 INFO - 'NO_EM_RESTART': '1', 02:09:56 INFO - 'PAGER': '/bin/cat', 02:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:56 INFO - 'PWD': '/builds/slave/test', 02:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:56 INFO - 'SHELL': '/bin/bash', 02:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:56 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:56 INFO - 'USER': 'cltbld', 02:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:56 INFO - 'XPC_FLAGS': '0x0', 02:09:56 INFO - 'XPC_SERVICE_NAME': '0', 02:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 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:09:56 INFO - Cleaning up... 02:09:56 INFO - Return code: 0 02:09:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09:56 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:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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 0x10e2f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef94e2fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, '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.stNyjSvVMq/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.RF3yYItxHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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:09:56 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:09:56 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:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:56 INFO - 'HOME': '/Users/cltbld', 02:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:56 INFO - 'LOGNAME': 'cltbld', 02:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:56 INFO - 'MOZ_NO_REMOTE': '1', 02:09:56 INFO - 'NO_EM_RESTART': '1', 02:09:56 INFO - 'PAGER': '/bin/cat', 02:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:56 INFO - 'PWD': '/builds/slave/test', 02:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:56 INFO - 'SHELL': '/bin/bash', 02:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:09:56 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:56 INFO - 'USER': 'cltbld', 02:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:56 INFO - 'XPC_FLAGS': '0x0', 02:09:56 INFO - 'XPC_SERVICE_NAME': '0', 02:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:09:56 INFO - Cleaning up... 02:09:56 INFO - Return code: 0 02:09:56 INFO - Running post-action listener: _resource_record_post_action 02:09:56 INFO - Running post-action listener: _start_resource_monitoring 02:09:56 INFO - Starting resource monitoring. 02:09:56 INFO - [mozharness: 2017-04-02 09:09:56.701184Z] Finished create-virtualenv step (success) 02:09:56 INFO - [mozharness: 2017-04-02 09:09:56.702192Z] Running install step. 02:09:56 INFO - Running pre-action listener: _resource_record_pre_action 02:09:56 INFO - Running main action method: install 02:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:56 INFO - Reading from file tmpfile_stdout 02:09:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:57 INFO - Reading from file tmpfile_stdout 02:09:57 INFO - Output received: 02:09:57 INFO - Usage: mozinstall [options] installer 02:09:57 INFO - Options: 02:09:57 INFO - -h, --help show this help message and exit 02:09:57 INFO - -d DEST, --destination=DEST 02:09:57 INFO - Directory to install application into. [default: 02:09:57 INFO - "/builds/slave/test"] 02:09:57 INFO - --app=APP Application being installed. [default: firefox] 02:09:57 INFO - mkdir: /builds/slave/test/build/application 02:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:10:17 INFO - Reading from file tmpfile_stdout 02:10:17 INFO - Output received: 02:10:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:10:17 INFO - Running post-action listener: _resource_record_post_action 02:10:17 INFO - [mozharness: 2017-04-02 09:10:17.182974Z] Finished install step (success) 02:10:17 INFO - [mozharness: 2017-04-02 09:10:17.183132Z] Running run-tests step. 02:10:17 INFO - Running pre-action listener: _resource_record_pre_action 02:10:17 INFO - Running main action method: run_tests 02:10:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:10:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:10:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:10:17 INFO - 2017-04-02 02:10:17.198 screenresolution[1648:18414] starting screenresolution argv=screenresolution get 02:10:17 INFO - 2017-04-02 02:10:17.200 screenresolution[1648:18414] Display 0: 1600x1200x32@60 02:10:17 INFO - 2017-04-02 02:10:17.206 screenresolution[1649:18416] starting screenresolution argv=screenresolution list 02:10:17 INFO - Available Modes on Display 0 02:10:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:10:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:10:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:10:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:10:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:10:17 INFO - Intel Iris: 02:10:17 INFO - Chipset Model: Intel Iris 02:10:17 INFO - Type: GPU 02:10:17 INFO - Bus: Built-In 02:10:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:10:17 INFO - Vendor: Intel (0x8086) 02:10:17 INFO - Device ID: 0x0a2e 02:10:17 INFO - Revision ID: 0x0009 02:10:17 INFO - Displays: 02:10:17 INFO - Display: 02:10:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:10:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:10:17 INFO - Display Serial Number: 1600x1200 60 02:10:17 INFO - Main Display: Yes 02:10:17 INFO - Mirror: Off 02:10:17 INFO - Online: Yes 02:10:17 INFO - Rotation: Supported 02:10:17 INFO - Return code: 0 02:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:17 INFO - Python 2.7.3 02:10:17 INFO - Return code: 0 02:10:17 INFO - grabbing minidump binary from tooltool 02:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:17 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 0x10e0d6d30>, '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 0x10dffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0cbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:17 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:10:17 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:10:17 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:10:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:17 INFO - Return code: 0 02:10:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:10:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:17 INFO - ENV: RUST_BACKTRACE is now 1 02:10:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:10:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:17 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/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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:10:17 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/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.stNyjSvVMq/Render', 02:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:17 INFO - 'HOME': '/Users/cltbld', 02:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:17 INFO - 'LOGNAME': 'cltbld', 02:10:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:17 INFO - 'MOZ_NO_REMOTE': '1', 02:10:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:17 INFO - 'NO_EM_RESTART': '1', 02:10:17 INFO - 'PAGER': '/bin/cat', 02:10:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:17 INFO - 'PWD': '/builds/slave/test', 02:10:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:17 INFO - 'RUST_BACKTRACE': '1', 02:10:17 INFO - 'SHELL': '/bin/bash', 02:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF3yYItxHV/Listeners', 02:10:17 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 02:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:17 INFO - 'USER': 'cltbld', 02:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:17 INFO - 'XPC_FLAGS': '0x0', 02:10:17 INFO - 'XPC_SERVICE_NAME': '0', 02:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:17 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/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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:10:17 INFO - mozversion application_buildid: 20170402004002 02:10:17 INFO - mozversion application_changeset: 260ad3e3f8970a637c8acef0b83fde9da19d1044 02:10:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:10:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:17 INFO - mozversion application_name: Firefox 02:10:17 INFO - mozversion application_remotingname: firefox-dev 02:10:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:10:17 INFO - mozversion application_vendor: Mozilla 02:10:17 INFO - mozversion application_version: 54.0a2 02:10:17 INFO - mozversion platform_buildid: 20170402004002 02:10:17 INFO - mozversion platform_changeset: 260ad3e3f8970a637c8acef0b83fde9da19d1044 02:10:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:10:17 INFO - mozversion platform_version: 54.0a2 02:10:17 INFO - using testdate: 1491124217 02:10:17 INFO - actual date: 1491124217 02:10:17 INFO - starting webserver on 'localhost:49243' 02:10:17 INFO - SUITE-START | Running 2 tests 02:10:17 INFO - TEST-START | dromaeo_css 02:10:17 INFO - operating with platform_type : mac_ 02:10:17 INFO - Initialising browser for dromaeo_css test... 02:10:17 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpa15ZQK/profile http://localhost:49243/getInfo.html) 02:10:20 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 02:10:20 INFO - PROCESS | 1659 | colorDepth:24 02:10:20 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 02:10:20 INFO - PROCESS | 1659 | __metrics 02:10:20 INFO - PROCESS | 1659 | 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:10:20 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:10:21 INFO - TEST-INFO | 1659: exit 0 02:10:21 INFO - Browser initialized. 02:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpa15ZQK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:33 INFO - PROCESS | 1663 | RSS: Main: 214978560 02:10:33 INFO - PROCESS | 1663 | 02:13:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 02:13:39 INFO - PROCESS | 1663 | RSS: Main: 381145088 02:13:39 INFO - PROCESS | 1663 | 02:15:23 INFO - PROCESS | 1663 | ************************* 02:15:23 INFO - PROCESS | 1663 | A coding exception was thrown and uncaught in a Task. 02:15:23 INFO - PROCESS | 1663 | 02:15:23 ERROR - PROCESS | 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:15:23 INFO - PROCESS | 1663 | Full stack: 02:15:23 INFO - PROCESS | 1663 | ************************* 02:16:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 02:16:43 INFO - PROCESS | 1663 | RSS: Main: 350482432 02:16:43 INFO - PROCESS | 1663 | 02:19:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 02:19:46 INFO - PROCESS | 1663 | RSS: Main: 346791936 02:19:46 INFO - PROCESS | 1663 | 02:22:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 02:22:49 INFO - PROCESS | 1663 | RSS: Main: 321212416 02:22:49 INFO - PROCESS | 1663 | 02:25:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 02:25:54 INFO - PROCESS | 1663 | RSS: Main: 316026880 02:25:54 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 02:28:57 INFO - PROCESS | 1663 | RSS: Main: 440819712 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | __start_tp_report 02:28:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 02:28:57 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 02:28:57 INFO - PROCESS | 1663 | |i|pagename|runs| 02:28:57 INFO - PROCESS | 1663 | |0;dojo.html;3353.6646335366468;3364.848581813819;3377.1725927147836;3382.374260761758;3408.676175763303;5828.912566311504;5854.912176317359;5860.384659610743;5876.1185822126645;5903;5652.236948012017;5895.35151133375;5898.587098903078;5901.114832775086;5904.0553511438175;5272.551833094191;5276.261323414725;5303.071962406563;5353.571714262869;5412.783488660449;5228.8692782680355;5229.790808367661;5259.2899958505495;5390.487903649167;5402.108652072403;5301.840944771663;5309.681419114865;5321.175217841222;5323.893522129555;5326.174442961347;5302;5321;5321.760520776575;5324.946750532484;5335.519803217729;5135.871603209912;5259.474052594748;5263.184206447969;5274.2879711238875;5291.86770330741;5824.679642619654;5825.475707186331;5831.416858314177;5832.88334233313;5837.241158649391;6282.717277722468;6305.464035556983;6323.810285691437;6324.7470101195895;6326.43062124411;6303.149074874879;6319.462845658079;6322.146510221107;6329.430351268408;6334.778282760128;5775.913361299584;5944.5838791284195;5958.880822383571;5981.252343457068;6012.18835457212;6308.684565771693;6312.179416675803;6319.55763096588;6323.146375239376;6335.429811317003;6129.817282374534;6131.132004888128;6218.284897236786;6283.937160628427;6331.746730130835;6331.810045698637;6341.492680585542;6341.587796793286;6350.714217860207;6356.650384228912;6348.143000694847;6361.8727625448155;6380.106785050097;6388.233411990498;6388.744450221939;6084.60450070744;6145;6293.527985401113;6299.370062993756;6367.745290188341;5073.34046573943;5080.314157588678;5083.364579427572;5097.64316497849;5102.897942041139;4488.5511448855505;4509;4521.615662668644;4522.29904364824;4546.840860569864;5699.487046165782;5705.315362156568;5765.769369225184;5888.941110588925;5899.498542623839;6290;6321.873562528724;6331.525135614847;6339.746410143634;6359.618422894641;5842.620229685057;5847.239858818326;5860.765569377262;5879.735411906475;5907.7046147692445;5396.649217800909;5437.157240627709;5558.749856256478;5562.805301814417;5572.749226284745;6225.28409232944;6328.746850125944;6341.302456729848;6375.617462952052;6389.840253993687;6315.210598675166;6330.082138090043;6335.841603959938;6341.682915854281;6353.428191462791;6193.071039344134;6399.7440102395385;6403.903941440789;6406.775762848278;6416;6184.196054513064;6291.716872740646;6325.177726895658;6367.204099487564;6367.395097465734;6312.179416675986;6328.873422531616;6329.145565348619;6333.429991300805;6342.7145778441;6100;6264.154339164154;6299.559030867796;6309.747610095545;6319.052142178526;6050.909236361546;6089.238845144357;6089.725962331617;6117.066276512034;6119.296280927751;6105.389461053859;6125.693715314305;6130.080487926846;6130.5402094842175;6134.294556125924;6263.592866463848;6280.1207830902795;6287.937120628735;6292.182016337847;6306.306306306211;6051.697415129138;6127.877442451215;6130.785422510191;6142;6152.692365381624 02:28:57 INFO - PROCESS | 1663 | |1;ext.html;697.6686074114796;738.5347231244315;803.8633432316508;874.0691163910435;881.2333270055053;27397.863010684945;27785.444291114167;39349.80325098378;40127.19745605093;40174.397384039265;40569.78290651278;40774;40811.57159499418;40836.97907552313;40861;8958.820823583541;9113.225375843029;9116.498592577405;9117.0427105154;9123.771905702344;7289.635518224094;7436.40508759298;8991.235744961687;10788.892111078907;11035.613753518628;10950.39772812495;10999.670009899715;11005.1746119041;11027.779444411108;11034.724131896726;10938;10939;10962.616308429246;10966.287191332578;10970.890291097066;7128.25153358895;7270.672819723125;9977.75055623608;10635.149188064936;10693.19801014927;38662.420063699064;38962.22075558501;39096;39103.60896391028;39183;3320.8007519548664;3807.5240594925635;3823.254465379252;3835.789031603261;3858.7684738915755;27264;28144.718552814415;29125.85437072801;29222.85388573065;29345.41309173826;3025.183200535865;3099.9845000775076;3130.7651926105405;3222.2910959588853;3264.6245681746664;315684;320020;320211.3989430061;322945;323745;52142.739286303324;52158.47841521612;52220.73889630604;52225.95548089093;52314.47685523172;54435.45564544383;54465.1830222547;54484.182737258976;54534;54581.63545911384;14341.85658143426;14495.420183192766;14504.34730437133;14536.345864436125;14543;12553.12128151039;12574.371281435891;12598.307093109783;12603.621891343275;12628.621141365773;10602.734931626772;10808.89191108079;11016.779664406668;11039;11063.114950803916;4372.934405983913;4783.162946484421;4799.704079898478;5038.874028149326;5145.790739176291;1071.4053700196466;1086.375334182848;1098.9890101099047;1107.645553422897;1150.539784086372;27105.322366940985;27663.446731065265;27668.861655691995;27770.861145694143;27975;1142.5315620595516;1150.9827352589718;1157.9652610421701;1194.510250797169;1200.3338147328143;13950.651233719036;14129.434822606981;14279.214643194517;14300.499482518062;14571.562853114423;480817;485068;489223;489974;490129;48113.75943120332;48140.7045225025;48209.758951205724;48250;48258.27612585814;1375.1336657905456;1414.3140576820233;1418.8368337641302;1419.7941298511657;1425.60795781161;25982.61026084648;26602.86698566572;26928;27132.864335678194;27152.864235678695;40262;40283;40319.79040628786;40328.17702760896;40396.596034039285;422723;423808;423829;424690;424768;28533;28607.856960715897;28618.713812861606;28628.570571441862;28633.856830715715;27326.180214593594;36136.81931590325;36240.637593623724;37155.442668360534;37443.43834842425;23670.24583356172;27137.72862271352;28056.71943280541;28509.857450712614;29158.56262156112;26644.200673979813;27071.86464067667;27151.59272610952;27331;27475.763590638868;28246;32166.41500437146;32526.698932042455;32921;33241.33517329688;21092;28320.43359132847;29103.563446547894;29104.5447727617;29191;22668.319950401514;22672.65991010169;23061.423464413525;23237.88381058084;23367.61169630428 02:28:57 INFO - PROCESS | 1663 | |2;jquery.html;390.6171951487544;409.72138945517054;421.47736806360115;436.4500729081358;446.83467117166634;14332.355044023017;16904.661906761856;20630.1747930083;21470.463238419048;21696.674549881765;18137.455876323733;21035.789642103573;21389.35831925045;21984.8900755496;22051.558968820613;6620.66896655169;6802.761903333359;6843.794686159398;6853.828654283658;6931.480138989571;7195.89206161908;7259.056322678044;7267.672954717024;7289.343959043685;7291.7447889323885;7059.9647001764915;7264.27357264272;7267.963660181692;7280.4903656744045;7342.412606991428;6745.561538500031;7340.339369456748;7382.741604043859;7394.223606521292;7444.255574442566;6157.568970172089;7154.034205382311;7154.642267886585;7165.9283407165785;7175.103112110986;23913.04347826085;24459;25415.745842541706;25924.870375648003;26173.083942062127;2800.957985630217;2824.6186764786903;2828.61813655156;2841.4033053058884;2887.5379939209834;12542;15420.537383878502;15475.071495710294;15497.915145939789;16267.837321626868;1758.1033672826823;1996.4310171601169;2014.597080583889;2104.4107649858065;2116.7248257726396;134448;151089.24455377762;162342.37657623392;163560;165965;12229.449674764657;18671.626567468575;19478.707819382722;19671.803281966997;19701.802981969995;26609.73390266111;28523.001694940576;29539.556906646416;29896.40207195844;29965.400691986037;8132.2680958714;9585.952070239604;10152.898471015344;10198.18414526836;10213.540390682288;8416.3266938646;8421.95789021051;8438.789030274169;8579.013413457533;8602.569871506525;7649.655765490566;9119.948011697315;9214.815703685888;9304.767380815398;9340.085282517068;3320.900372988814;3844.5386553613184;3899.4150877368056;3902.6145718269604;3902.6487616114687;1005.8491226316111;1025.707673313102;1027.1269420992096;1042.864427624404;1067.7223921780394;18068.819311806976;20013.899930500254;20311.593768124556;20678.966051697356;20917.686234706493;1017.9491025448698;1026.5585798106886;1044.3055368180228;1047.8428235764695;1074.7635520185547;9171.991080981086;10570.101541368917;10833.566657333777;10862.565497380174;10988.945055274673;616442;636101;793051;797792;800963;104777;110194;129753;134087;137601;1239.4174737873186;1274.343712987812;1283.434210263477;1295.7861952777876;1301.342821874947;15801.68396632084;18910.243590256236;19368;19629.214831406585;19637.70543441878;60380;61053;61133;61356;62553.68723156355;83654;84336.73494897458;85534;86391.5680421619;87108.56445717732;10721.356718596597;10935.562577497129;11033.33799971972;11183.72040698989;11399.259048161843;12205.633830985085;12313.44589493457;12448.937755311166;12468.002559795013;12506.437210325375;10446.425446600206;10578.947105264424;10742.355458672504;11050.115990720884;11173.72065698364;9969.202463802734;10469.738256543647;10584.84122738175;10733.892661073602;10734.83897741519;11495.080393568327;11549;11774.705632358917;11807.940960295144;11862.051035917279;10689.30519516229;11336.206465547333;11423.771524569296;11630.476628551905;11749.471273792871;10973.615923442641;11052.613158539412;11216.495257713259;11339.262947908359;11355.943220284176 02:28:57 INFO - PROCESS | 1663 | |3;mootools.html;1502.4666243483564;1503.6917431926456;1536.2472388529616;1566.0525382143803;1571.5049759325807;10456.268061235716;11039.558417663295;11042.668719938394;11043.282186657872;11043.83434248487;10437.791244175112;10738.892611073887;10885.020348168664;10922.726931826708;10939.45302734862;2285.6800047993293;2315.2128276386024;2324.4421338878633;2330.2659662206433;2332.183735692511;2225.265662331427;2292.713410823647;2297.7127859017623;2304.0783686525356;2308.2152068296778;2249.5388445368662;2266.852654577447;2291.4844160064017;2293.0369244917174;2302.1712183613886;2210.347947355534;2280.304507125326;2280.9201677941273;2282.0643536150264;2284.2690339091496;2273.30664147435;2284.8400611957168;2286.6455699366456;2287.7712228777154;2290.061074959275;10901;10959.50682219302;10968.890311096866;10982.615608453745;10983.901609839033;5216.504432078947;5373.570114390839;5376.731163441812;5376.838694839161;5388.78444862205;3102.5811515445575;3206.9839650801596;3333.3666603345528;3354.6477619849807;3355.3792548378383;1223.816427535868;1240.2558464921065;1794.4078454110243;1834.7431359609666;1921.625283069802;13391.933040334736;14855.405783768636;15278.770818437732;15307.617309567238;15359.999999999889;3735.364987952055;4263.957360426356;4323.113761678848;4433.645308375322;4449.933251001237;11381.601643942422;11413.828792568118;11419;11434.02810761078;11444.94277528607;5254;5319.547838433699;5329.280547126088;5329.520343169133;5331.920021199685;4723.409573803275;4946.455889852114;4946.604271658259;4964.131277026506;5036.0179764946215;3566.964330356663;3599.4420864766003;3630.8003059831435;3683.594804571495;3694.445833124999;943.6084025129632;947.303731757158;957.3777044920857;958.075457183821;961.274237950357;773.3697036914897;775.8448310337955;829.3323874281141;830.3938125168661;850.1668365002332;6478.643674597848;6506.804795856132;6562.77030303937;6590.373914478117;6645.867082658319;823.625250511016;941.9873635841361;967.3760424526141;999.3953658036928;1020.0411613083678;3759.5112635357777;4102.3026085565525;4334.653227741773;4361.302191649321;4488.506264310923;10688.679339619825;14056.367463464168;14189.929050354682;14215.573532794033;14288.499902503363;11876.88123118775;12038.939805301092;12492.437840297209;14118.576442706735;14160;8504.617292221865;8785.253253473398;8913.55432228386;9774.413535187912;9939.50302484873;6616.338366163538;6684.4318232950745;6697.966510167418;6789.830254243683;6954.235034146341;11787.11596630239;11934.761304774029;12146.514139434325;12365.629031129081;12455.377231138587;12287.44706488228;12315;12455.190412623151;12480.126391152895;12544.372781361079;9064.864027039468;9390.624375025196;9398.34211605181;9400.200982916254;9402.43585384879;9620.663276785279;10212.438315892698;10254;10254.025867542572;10264.897351026693;8471.364647651328;8508.361872859436;8603.655853765778;8724.345674074342;8724.825503489768;8417.663293468193;8482.57587120629;8489.872651910102;8611.8708219378;8689.739307820775;7665.923340766521;7760.611969401394;7879.724209652634;7896.605169741375;7905.446618736633;5756.4169853289;5765.654060756368;5863.736131874161;5911.3201981772645;5978;4956.702597844141;5828.213191219301;5880.676562789087;5890.381509941394;5908.7045647718305 02:28:57 INFO - PROCESS | 1663 | |4;prototype.html;346.25900572774265;375.7801686013682;376.9981150094249;382.269864558693;382.55432421229267;4947;5009.273655319977;5031.295618613392;5033.773480193391;5048.697078175312;3775.5658099318584;4380.978095109528;4792.993471371007;4839.668496695455;4871.807686541053;3520.507129001948;3628.9455658165148;3702.075360465229;3875.534935807707;3877.247154520294;4163.770992595406;4165.458490396244;4174.77038762868;4179.014967890258;4213.831446742142;3994.9001274968214;4028.8992775180564;4112.9717570607345;4166.0834616384345;4201.214483844369;2995.955060674092;3710.2208536207427;3875.7093218008763;4053.5743746906446;4069.287874621959;3295.3903527847424;3342.181165614416;3794.4118661607217;3796.487474191004;3825.221272108455;4504.909901801979;4739.753269010739;4828.275758636198;4832.8401183716005;4850.6362022848425;3946.6645335146545;4528.120829855606;4655.767211639404;4781.378420805273;4847.442544107437;4477.350784136282;4645.581897629229;5038.596912247048;5061;5337.877341755078;3766.7928263945473;3997.161305799336;4141.544430112715;4176.749395036308;4229.154169166149;4532.818687252473;5238.554722848562;5586.636868603528;5608.924697861777;5610.270664813589;3836.55879573847;4141.860988228201;4143.81352839123;4229.577042295808;4305.225059489259;3791.829367678461;4315.07225946423;4419.270820314677;4421.40311058003;4426.601605855489;3950.957762522899;4298.76356800379;4328.653707703376;4603.4015577975315;4686.078707729815;4834.154023045953;4893.804247830119;5121.487851214849;5268.998890210848;5360.758765855546;1328.2760895312078;1388.6250712307822;1499.932503037366;1500.3473489032306;1513.9175489525041;1064.2443864856039;1137.6757624077097;1142.6000899685043;1144.6108323170163;1172.7009612548916;4471.709338893027;4893.730844803499;4900.035478535506;4913.361263035782;4932.594210649948;4644.883877903079;4814.687045342112;4858.6356023297685;4974.681709347026;5431;4191.64371028466;4526.8189272428735;4796.448408433005;4840.515948405202;4915.582175515121;2479.528889510987;2838.836077208376;2851.9020177231914;2873.103751523984;2886.3794284228993;5009.974950125299;5647.317524175984;5681.318241811009;5689.829305120853;5717.341436232089;4866.8076321301505;5001.7499125043605;5352.866178345573;5536.557075433956;5685.630434021776;4684.789184486638;5291.232771248147;5592.496675299242;5624.71876406178;5627;5321.893562128658;5323.281357016908;5467.769751805812;5496.780128794803;5502.504774570148;4895.853124406273;4991.875203119951;5020.874478138076;5371.516563509303;5461.569601527282;4618.191816432044;5014.473480284518;5267.891943753204;5322.806316210243;5361.4370491099435;4088.8329185531716;4328.394024836588;4451.287793952952;4587.188060715932;4644.23519062754;4604.930926036179;4854.83008094715;5460.822470809754;5512.3660779010925;5535.612507124623;4526.574129149308;5165.586753059671;5293.9205911910585;5309.814156504503;5349.545288650508;5306.761195746123;5335.573154147736;5338.866528336823;5353.2505449237915;5360.597955153457;4769.856904292877;5008.749562521933;5026.90845130235;5254.290670759398;5263.473652634706;4487.955120448753;4986.227134794112;5291.550218231339;5369.818639899216;5562.3881373048125;5018.322526459027;5190.821388781916;5194.870103257646;5361.571074313967;5385.165299378603 02:28:57 INFO - PROCESS | 1663 | |5;yui.html;722.1622917415799;736.9705211791526;777.129614831389;827.4497459189639;836.5399030533205;15049.623759406006;15847.683046339094;15864.444744433933;15867.682646347066;15892.920535397336;14365.066270692423;14373.137611743277;14395;14468.493602723907;14504.709905801905;923.949182794946;928.4939707859199;941.1764705882352;955.7037318431273;961.9470929098896;939.3283802081545;959.2134449751206;959.3524371049549;960.7213907966682;960.9135177833994;1010.9646162384319;1011.9392836429801;1013.2350075692879;1013.9746506337364;1014.2393205096178;1002.909738123565;1003.5584342889106;1005.7385079879211;1007.1841808135433;1007.410664761112;748.5583505731645;748.9625518724042;749;749.5689978262467;749.9100107987076;15323.770143447857;15432.996855204376;15464.536063917987;15964.521064368088;16197;13960.022798404116;14045.64885877851;14068.388274029108;14199.290035498287;14322.498712545012;11312.6040588579;11683.474243658971;11757.35334556599;11842.703932401673;11871.940640296743;3706.721995850295;3721.292954338667;3722.1253005543676;3725.8137093145233;3811.6378944000276;102546;107464;108231.45884270607;110148;111059;10221.744456388502;10331.225158113171;10659.253852230424;11006.064484518905;11275.436228188557;21008.894955525124;21165.68251476229;21308;21494.78505214928;21583.46041348979;7599.164091949881;7658;7665.3101220889275;7741.5742134183165;7798.1811909749795;3740.401535754266;4233.407322974786;4253.149370125987;4396.406485124531;4498.6626003049905;2904.1868276882506;3137.200013996462;3168.778185526991;3207.759418043656;3592.515010473605;627.2065836716557;629.7229219143562;638.0811631250983;644.7678835619173;647.2104033079635;661.573285231033;663.9933600664028;695.5305169010898;699.2972063076576;715.4669771020519;10205.795884082278;10322.48387580618;10446.738831529121;10604.628837990633;10758.46207689628;586.2730214533947;598.4015984015984;663.4360793325635;700.345177259254;705.7635692043223;4897.755112244374;5082.517160869711;5085.084684756779;5094.949050509522;5113.284140220372;100079;102182.97817021883;102912.48543757234;103737.48131259295;105484;61254.74163997068;69539.65230173917;74906;81415;89328;70423.64788176026;73033.6348318255;73400.63299683575;73725.6313718428;74394;10498.107660848913;10730.463476826284;10918.781624367628;11339.376334301693;11355.659330220107;46940.53059469361;47658.808529785645;48185.75907120442;48195.39669429745;50150;64865.35134648593;67198.66400667965;67594.66202669151;68064;68525.65737171282;11194.824543423148;12218.877811221773;12529.436175372313;12773.744525109632;12898.226106433644;13143.34283285851;13991.58025259244;14393.9280303602;14920.925395372953;15432.537023889301;12937.029722770641;13657.248851312876;13941;14209.431622735388;14401.63995900111;13673.31633418345;13708.657283567592;13755.656108597364;13922.721545569235;14015.929920350332;12587.24476531411;13630;13633.182009079486;13641;13952.302384880919;8956.417832840845;9403.059694030815;9702.36934599277;9811.803763924825;9976.401415915068;9969.601215951281;10376.37741735468;10380;10964.835527467254;11292.661220163409 02:28:57 INFO - PROCESS | 1663 | __end_tp_report 02:28:57 INFO - PROCESS | 1663 | __start_cc_report 02:28:57 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1716 02:28:57 INFO - PROCESS | 1663 | __end_cc_report 02:28:57 INFO - PROCESS | 1663 | __startTimestamp1491125337877__endTimestamp 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | ------- Summary: start ------- 02:28:57 INFO - PROCESS | 1663 | Number of tests: 6 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5852.88 Median:6117.07 stddev:644.46 (10.5%) stddev-sans-first:615.89 02:28:57 INFO - PROCESS | 1663 | Values: 3353.7 3364.8 3377.2 3382.4 3408.7 5828.9 5854.9 5860.4 5876.1 5903.0 5652.2 5895.4 5898.6 5901.1 5904.1 5272.6 5276.3 5303.1 5353.6 5412.8 5228.9 5229.8 5259.3 5390.5 5402.1 5301.8 5309.7 5321.2 5323.9 5326.2 5302.0 5321.0 5321.8 5324.9 5335.5 5135.9 5259.5 5263.2 5274.3 5291.9 5824.7 5825.5 5831.4 5832.9 5837.2 6282.7 6305.5 6323.8 6324.7 6326.4 6303.1 6319.5 6322.1 6329.4 6334.8 5775.9 5944.6 5958.9 5981.3 6012.2 6308.7 6312.2 6319.6 6323.1 6335.4 6129.8 6131.1 6218.3 6283.9 6331.7 6331.8 6341.5 6341.6 6350.7 6356.7 6348.1 6361.9 6380.1 6388.2 6388.7 6084.6 6145.0 6293.5 6299.4 6367.7 5073.3 5080.3 5083.4 5097.6 5102.9 4488.6 4509.0 4521.6 4522.3 4546.8 5699.5 5705.3 5765.8 5888.9 5899.5 6290.0 6321.9 6331.5 6339.7 6359.6 5842.6 5847.2 5860.8 5879.7 5907.7 5396.6 5437.2 5558.7 5562.8 5572.7 6225.3 6328.7 6341.3 6375.6 6389.8 6315.2 6330.1 6335.8 6341.7 6353.4 6193.1 6399.7 6403.9 6406.8 6416.0 6184.2 6291.7 6325.2 6367.2 6367.4 6312.2 6328.9 6329.1 6333.4 6342.7 6100.0 6264.2 6299.6 6309.7 6319.1 6050.9 6089.2 6089.7 6117.1 6119.3 6105.4 6125.7 6130.1 6130.5 6134.3 6263.6 6280.1 6287.9 6292.2 6306.3 6051.7 6127.9 6130.8 6142.0 6152.7 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:53953.02 Median:29206.93 stddev:110658.22 (378.9%) stddev-sans-first:110896.41 02:28:57 INFO - PROCESS | 1663 | Values: 697.7 738.5 803.9 874.1 881.2 27397.9 27785.4 39349.8 40127.2 40174.4 40569.8 40774.0 40811.6 40837.0 40861.0 8958.8 9113.2 9116.5 9117.0 9123.8 7289.6 7436.4 8991.2 10788.9 11035.6 10950.4 10999.7 11005.2 11027.8 11034.7 10938.0 10939.0 10962.6 10966.3 10970.9 7128.3 7270.7 9977.8 10635.1 10693.2 38662.4 38962.2 39096.0 39103.6 39183.0 3320.8 3807.5 3823.3 3835.8 3858.8 27264.0 28144.7 29125.9 29222.9 29345.4 3025.2 3100.0 3130.8 3222.3 3264.6 315684.0 320020.0 320211.4 322945.0 323745.0 52142.7 52158.5 52220.7 52226.0 52314.5 54435.5 54465.2 54484.2 54534.0 54581.6 14341.9 14495.4 14504.3 14536.3 14543.0 12553.1 12574.4 12598.3 12603.6 12628.6 10602.7 10808.9 11016.8 11039.0 11063.1 4372.9 4783.2 4799.7 5038.9 5145.8 1071.4 1086.4 1099.0 1107.6 1150.5 27105.3 27663.4 27668.9 27770.9 27975.0 1142.5 1151.0 1158.0 1194.5 1200.3 13950.7 14129.4 14279.2 14300.5 14571.6 480817.0 485068.0 489223.0 489974.0 490129.0 48113.8 48140.7 48209.8 48250.0 48258.3 1375.1 1414.3 1418.8 1419.8 1425.6 25982.6 26602.9 26928.0 27132.9 27152.9 40262.0 40283.0 40319.8 40328.2 40396.6 422723.0 423808.0 423829.0 424690.0 424768.0 28533.0 28607.9 28618.7 28628.6 28633.9 27326.2 36136.8 36240.6 37155.4 37443.4 23670.2 27137.7 28056.7 28509.9 29158.6 26644.2 27071.9 27151.6 27331.0 27475.8 28246.0 32166.4 32526.7 32921.0 33241.3 21092.0 28320.4 29103.6 29104.5 29191.0 22668.3 22672.7 23061.4 23237.9 23367.6 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:41235.43 Median:20654.57 stddev:122013.41 (590.7%) stddev-sans-first:122317.14 02:28:57 INFO - PROCESS | 1663 | Values: 390.6 409.7 421.5 436.5 446.8 14332.4 16904.7 20630.2 21470.5 21696.7 18137.5 21035.8 21389.4 21984.9 22051.6 6620.7 6802.8 6843.8 6853.8 6931.5 7195.9 7259.1 7267.7 7289.3 7291.7 7060.0 7264.3 7268.0 7280.5 7342.4 6745.6 7340.3 7382.7 7394.2 7444.3 6157.6 7154.0 7154.6 7165.9 7175.1 23913.0 24459.0 25415.7 25924.9 26173.1 2801.0 2824.6 2828.6 2841.4 2887.5 12542.0 15420.5 15475.1 15497.9 16267.8 1758.1 1996.4 2014.6 2104.4 2116.7 134448.0 151089.2 162342.4 163560.0 165965.0 12229.4 18671.6 19478.7 19671.8 19701.8 26609.7 28523.0 29539.6 29896.4 29965.4 8132.3 9586.0 10152.9 10198.2 10213.5 8416.3 8422.0 8438.8 8579.0 8602.6 7649.7 9119.9 9214.8 9304.8 9340.1 3320.9 3844.5 3899.4 3902.6 3902.6 1005.8 1025.7 1027.1 1042.9 1067.7 18068.8 20013.9 20311.6 20679.0 20917.7 1017.9 1026.6 1044.3 1047.8 1074.8 9172.0 10570.1 10833.6 10862.6 10988.9 616442.0 636101.0 793051.0 797792.0 800963.0 104777.0 110194.0 129753.0 134087.0 137601.0 1239.4 1274.3 1283.4 1295.8 1301.3 15801.7 18910.2 19368.0 19629.2 19637.7 60380.0 61053.0 61133.0 61356.0 62553.7 83654.0 84336.7 85534.0 86391.6 87108.6 10721.4 10935.6 11033.3 11183.7 11399.3 12205.6 12313.4 12448.9 12468.0 12506.4 10446.4 10578.9 10742.4 11050.1 11173.7 9969.2 10469.7 10584.8 10733.9 10734.8 11495.1 11549.0 11774.7 11807.9 11862.1 10689.3 11336.2 11423.8 11630.5 11749.5 10973.6 11052.6 11216.5 11339.3 11355.9 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6571.98 Median:3583.20 stddev:4155.72 (116.0%) stddev-sans-first:4149.92 02:28:57 INFO - PROCESS | 1663 | Values: 1502.5 1503.7 1536.2 1566.1 1571.5 10456.3 11039.6 11042.7 11043.3 11043.8 10437.8 10738.9 10885.0 10922.7 10939.5 2285.7 2315.2 2324.4 2330.3 2332.2 2225.3 2292.7 2297.7 2304.1 2308.2 2249.5 2266.9 2291.5 2293.0 2302.2 2210.3 2280.3 2280.9 2282.1 2284.3 2273.3 2284.8 2286.6 2287.8 2290.1 10901.0 10959.5 10968.9 10982.6 10983.9 5216.5 5373.6 5376.7 5376.8 5388.8 3102.6 3207.0 3333.4 3354.6 3355.4 1223.8 1240.3 1794.4 1834.7 1921.6 13391.9 14855.4 15278.8 15307.6 15360.0 3735.4 4264.0 4323.1 4433.6 4449.9 11381.6 11413.8 11419.0 11434.0 11444.9 5254.0 5319.5 5329.3 5329.5 5331.9 4723.4 4946.5 4946.6 4964.1 5036.0 3567.0 3599.4 3630.8 3683.6 3694.4 943.6 947.3 957.4 958.1 961.3 773.4 775.8 829.3 830.4 850.2 6478.6 6506.8 6562.8 6590.4 6645.9 823.6 942.0 967.4 999.4 1020.0 3759.5 4102.3 4334.7 4361.3 4488.5 10688.7 14056.4 14189.9 14215.6 14288.5 11876.9 12038.9 12492.4 14118.6 14160.0 8504.6 8785.3 8913.6 9774.4 9939.5 6616.3 6684.4 6698.0 6789.8 6954.2 11787.1 11934.8 12146.5 12365.6 12455.4 12287.4 12315.0 12455.2 12480.1 12544.4 9064.9 9390.6 9398.3 9400.2 9402.4 9620.7 10212.4 10254.0 10254.0 10264.9 8471.4 8508.4 8603.7 8724.3 8724.8 8417.7 8482.6 8489.9 8611.9 8689.7 7665.9 7760.6 7879.7 7896.6 7905.4 5756.4 5765.7 5863.7 5911.3 5978.0 4956.7 5828.2 5880.7 5890.4 5908.7 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4387.00 Median:4787.19 stddev:1225.50 (25.6%) stddev-sans-first:1190.81 02:28:57 INFO - PROCESS | 1663 | Values: 346.3 375.8 377.0 382.3 382.6 4947.0 5009.3 5031.3 5033.8 5048.7 3775.6 4381.0 4793.0 4839.7 4871.8 3520.5 3628.9 3702.1 3875.5 3877.2 4163.8 4165.5 4174.8 4179.0 4213.8 3994.9 4028.9 4113.0 4166.1 4201.2 2996.0 3710.2 3875.7 4053.6 4069.3 3295.4 3342.2 3794.4 3796.5 3825.2 4504.9 4739.8 4828.3 4832.8 4850.6 3946.7 4528.1 4655.8 4781.4 4847.4 4477.4 4645.6 5038.6 5061.0 5337.9 3766.8 3997.2 4141.5 4176.7 4229.2 4532.8 5238.6 5586.6 5608.9 5610.3 3836.6 4141.9 4143.8 4229.6 4305.2 3791.8 4315.1 4419.3 4421.4 4426.6 3951.0 4298.8 4328.7 4603.4 4686.1 4834.2 4893.8 5121.5 5269.0 5360.8 1328.3 1388.6 1499.9 1500.3 1513.9 1064.2 1137.7 1142.6 1144.6 1172.7 4471.7 4893.7 4900.0 4913.4 4932.6 4644.9 4814.7 4858.6 4974.7 5431.0 4191.6 4526.8 4796.4 4840.5 4915.6 2479.5 2838.8 2851.9 2873.1 2886.4 5010.0 5647.3 5681.3 5689.8 5717.3 4866.8 5001.7 5352.9 5536.6 5685.6 4684.8 5291.2 5592.5 5624.7 5627.0 5321.9 5323.3 5467.8 5496.8 5502.5 4895.9 4991.9 5020.9 5371.5 5461.6 4618.2 5014.5 5267.9 5322.8 5361.4 4088.8 4328.4 4451.3 4587.2 4644.2 4604.9 4854.8 5460.8 5512.4 5535.6 4526.6 5165.6 5293.9 5309.8 5349.5 5306.8 5335.6 5338.9 5353.3 5360.6 4769.9 5008.7 5026.9 5254.3 5263.5 4488.0 4986.2 5291.6 5369.8 5562.4 5018.3 5190.8 5194.9 5361.6 5385.2 02:28:57 INFO - PROCESS | 1663 | 02:28:57 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19970.07 Median:21236.84 stddev:28421.75 (133.8%) stddev-sans-first:28464.74 02:28:57 INFO - PROCESS | 1663 | Values: 722.2 737.0 777.1 827.4 836.5 15049.6 15847.7 15864.4 15867.7 15892.9 14365.1 14373.1 14395.0 14468.5 14504.7 923.9 928.5 941.2 955.7 961.9 939.3 959.2 959.4 960.7 960.9 1011.0 1011.9 1013.2 1014.0 1014.2 1002.9 1003.6 1005.7 1007.2 1007.4 748.6 749.0 749.0 749.6 749.9 15323.8 15433.0 15464.5 15964.5 16197.0 13960.0 14045.6 14068.4 14199.3 14322.5 11312.6 11683.5 11757.4 11842.7 11871.9 3706.7 3721.3 3722.1 3725.8 3811.6 102546.0 107464.0 108231.5 110148.0 111059.0 10221.7 10331.2 10659.3 11006.1 11275.4 21008.9 21165.7 21308.0 21494.8 21583.5 7599.2 7658.0 7665.3 7741.6 7798.2 3740.4 4233.4 4253.1 4396.4 4498.7 2904.2 3137.2 3168.8 3207.8 3592.5 627.2 629.7 638.1 644.8 647.2 661.6 664.0 695.5 699.3 715.5 10205.8 10322.5 10446.7 10604.6 10758.5 586.3 598.4 663.4 700.3 705.8 4897.8 5082.5 5085.1 5094.9 5113.3 100079.0 102183.0 102912.5 103737.5 105484.0 61254.7 69539.7 74906.0 81415.0 89328.0 70423.6 73033.6 73400.6 73725.6 74394.0 10498.1 10730.5 10918.8 11339.4 11355.7 46940.5 47658.8 48185.8 48195.4 50150.0 64865.4 67198.7 67594.7 68064.0 68525.7 11194.8 12218.9 12529.4 12773.7 12898.2 13143.3 13991.6 14393.9 14920.9 15432.5 12937.0 13657.2 13941.0 14209.4 14401.6 13673.3 13708.7 13755.7 13922.7 14015.9 12587.2 13630.0 13633.2 13641.0 13952.3 8956.4 9403.1 9702.4 9811.8 9976.4 9969.6 10376.4 10380.0 10964.8 11292.7 02:28:57 INFO - PROCESS | 1663 | -------- Summary: end -------- 02:28:57 INFO - PROCESS | 1663 | 02:28:58 INFO - TEST-INFO | 1663: exit 0 02:28:58 INFO - TEST-OK | dromaeo_css | took 1120817ms 02:28:58 INFO - TEST-START | kraken 02:28:58 INFO - operating with platform_type : mac_ 02:28:58 INFO - Initialising browser for kraken test... 02:28:58 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpmR2DBP/profile http://localhost:49243/getInfo.html) 02:29:00 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 02:29:00 INFO - PROCESS | 1667 | colorDepth:24 02:29:00 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 02:29:00 INFO - PROCESS | 1667 | __metrics 02:29:01 INFO - PROCESS | 1667 | 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:29:01 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:01 INFO - TEST-INFO | 1667: exit 0 02:29:01 INFO - Browser initialized. 02:29:01 INFO - Running cycle 1/1 for kraken test... 02:29:01 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpmR2DBP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:14 INFO - PROCESS | 1669 | RSS: Main: 215105536 02:29:14 INFO - PROCESS | 1669 | 02:29:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:17 INFO - PROCESS | 1669 | RSS: Main: 268087296 02:29:17 INFO - PROCESS | 1669 | 02:29:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 02:29:20 INFO - PROCESS | 1669 | RSS: Main: 278925312 02:29:20 INFO - PROCESS | 1669 | 02:29:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 02:29:24 INFO - PROCESS | 1669 | RSS: Main: 376696832 02:29:24 INFO - PROCESS | 1669 | 02:29:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 02:29:27 INFO - PROCESS | 1669 | RSS: Main: 278908928 02:29:27 INFO - PROCESS | 1669 | 02:29:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:30 INFO - PROCESS | 1669 | RSS: Main: 280629248 02:29:30 INFO - PROCESS | 1669 | 02:29:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:33 INFO - PROCESS | 1669 | RSS: Main: 320200704 02:29:33 INFO - PROCESS | 1669 | 02:29:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:37 INFO - PROCESS | 1669 | RSS: Main: 321470464 02:29:37 INFO - PROCESS | 1669 | 02:29:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 02:29:40 INFO - PROCESS | 1669 | RSS: Main: 319164416 02:29:40 INFO - PROCESS | 1669 | 02:29:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:43 INFO - PROCESS | 1669 | RSS: Main: 294924288 02:29:43 INFO - PROCESS | 1669 | 02:29:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:45 INFO - PROCESS | 1669 | RSS: Main: 301047808 02:29:45 INFO - PROCESS | 1669 | 02:29:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:48 INFO - PROCESS | 1669 | RSS: Main: 302915584 02:29:48 INFO - PROCESS | 1669 | 02:29:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:52 INFO - PROCESS | 1669 | RSS: Main: 319823872 02:29:52 INFO - PROCESS | 1669 | 02:29:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:55 INFO - PROCESS | 1669 | RSS: Main: 313622528 02:29:55 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 02:29:57 INFO - PROCESS | 1669 | RSS: Main: 358129664 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | __start_tp_report 02:29:57 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 02:29:57 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 02:29:57 INFO - PROCESS | 1669 | |i|pagename|runs| 02:29:57 INFO - PROCESS | 1669 | |0;ai-astar;118;117;116;115;116;115;113;117;115;116 02:29:57 INFO - PROCESS | 1669 | |1;audio-beat-detection;170;136;107;142;110;108;120;111;130;106 02:29:57 INFO - PROCESS | 1669 | |2;audio-dft;185;185;185;184;186;186;199;216;186;185 02:29:57 INFO - PROCESS | 1669 | |3;audio-fft;81;62;62;90;63;60;61;59;75;61 02:29:57 INFO - PROCESS | 1669 | |4;audio-oscillator;87;69;88;71;69;67;82;69;67;83 02:29:57 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;89;89;89;90;88;89;89;90;133 02:29:57 INFO - PROCESS | 1669 | |6;imaging-darkroom;97;95;96;98;96;101;96;116;149;95 02:29:57 INFO - PROCESS | 1669 | |7;imaging-desaturate;87;86;84;86;86;89;84;84;83;86 02:29:57 INFO - PROCESS | 1669 | |8;json-parse-financial;62;58;60;60;63;63;64;63;64;66 02:29:57 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;58;64;61;60;65;79;80;81;57 02:29:57 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;83;85;85;83;81;82;92;97;98;80 02:29:57 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;139;137;137;138;136;143;147;139;196;168 02:29:57 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;164;167;174;191;164;164;164;162;164;166 02:29:57 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;65;65;66;66;66;65;65;65;64;64 02:29:57 INFO - PROCESS | 1669 | __end_tp_report 02:29:57 INFO - PROCESS | 1669 | __start_cc_report 02:29:57 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2111 02:29:57 INFO - PROCESS | 1669 | __end_cc_report 02:29:57 INFO - PROCESS | 1669 | __startTimestamp1491125397915__endTimestamp 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | ------- Summary: start ------- 02:29:57 INFO - PROCESS | 1669 | Number of tests: 14 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:1.40 (1.2%) stddev-sans-first:1.24 02:29:57 INFO - PROCESS | 1669 | Values: 118.0 117.0 116.0 115.0 116.0 115.0 113.0 117.0 115.0 116.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:125.00 stddev:20.74 (16.6%) stddev-sans-first:13.78 02:29:57 INFO - PROCESS | 1669 | Values: 170.0 136.0 107.0 142.0 110.0 108.0 120.0 111.0 130.0 106.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:189.70 Median:186.00 stddev:10.22 (5.5%) stddev-sans-first:10.70 02:29:57 INFO - PROCESS | 1669 | Values: 185.0 185.0 185.0 184.0 186.0 186.0 199.0 216.0 186.0 185.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:67.40 Median:62.50 stddev:10.74 (17.2%) stddev-sans-first:10.20 02:29:57 INFO - PROCESS | 1669 | Values: 81.0 62.0 62.0 90.0 63.0 60.0 61.0 59.0 75.0 61.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.50 stddev:8.68 (11.3%) stddev-sans-first:8.08 02:29:57 INFO - PROCESS | 1669 | Values: 87.0 69.0 88.0 71.0 69.0 67.0 82.0 69.0 67.0 83.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:89.00 stddev:13.89 (15.6%) stddev-sans-first:14.64 02:29:57 INFO - PROCESS | 1669 | Values: 89.0 89.0 89.0 89.0 90.0 88.0 89.0 89.0 90.0 133.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:103.90 Median:96.00 stddev:17.05 (17.8%) stddev-sans-first:17.90 02:29:57 INFO - PROCESS | 1669 | Values: 97.0 95.0 96.0 98.0 96.0 101.0 96.0 116.0 149.0 95.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.78 (2.1%) stddev-sans-first:1.80 02:29:57 INFO - PROCESS | 1669 | Values: 87.0 86.0 84.0 86.0 86.0 89.0 84.0 84.0 83.0 86.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:2.36 (3.7%) stddev-sans-first:2.50 02:29:57 INFO - PROCESS | 1669 | Values: 62.0 58.0 60.0 60.0 63.0 63.0 64.0 63.0 64.0 66.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:64.50 stddev:9.45 (14.7%) stddev-sans-first:9.92 02:29:57 INFO - PROCESS | 1669 | Values: 63.0 58.0 64.0 61.0 60.0 65.0 79.0 80.0 81.0 57.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:6.62 (7.8%) stddev-sans-first:6.89 02:29:57 INFO - PROCESS | 1669 | Values: 83.0 85.0 85.0 83.0 81.0 82.0 92.0 97.0 98.0 80.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:141.00 stddev:19.37 (13.7%) stddev-sans-first:20.27 02:29:57 INFO - PROCESS | 1669 | Values: 139.0 137.0 137.0 138.0 136.0 143.0 147.0 139.0 196.0 168.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:165.00 stddev:8.73 (5.3%) stddev-sans-first:9.14 02:29:57 INFO - PROCESS | 1669 | Values: 164.0 167.0 174.0 191.0 164.0 164.0 164.0 162.0 164.0 166.0 02:29:57 INFO - PROCESS | 1669 | 02:29:57 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 02:29:57 INFO - PROCESS | 1669 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 64.0 64.0 02:29:57 INFO - PROCESS | 1669 | -------- Summary: end -------- 02:29:57 INFO - PROCESS | 1669 | 02:29:58 INFO - TEST-INFO | 1669: exit 0 02:29:58 INFO - TEST-OK | kraken | took 60249ms 02:29:58 INFO - SUITE-END | took 1181s 02:29:59 INFO - Completed test suite (00:19:41) 02:29:59 INFO - javascript benchmark 02:29:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7512.7036698363345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.6646335366468, 3364.848581813819, 3377.1725927147836, 3382.374260761758, 3408.676175763303, 5828.912566311504, 5854.912176317359, 5860.384659610743, 5876.1185822126645, 5903.0, 5652.236948012017, 5895.35151133375, 5898.587098903078, 5901.114832775086, 5904.0553511438175, 5272.551833094191, 5276.261323414725, 5303.071962406563, 5353.571714262869, 5412.783488660449, 5228.8692782680355, 5229.790808367661, 5259.2899958505495, 5390.487903649167, 5402.108652072403, 5301.840944771663, 5309.681419114865, 5321.175217841222, 5323.893522129555, 5326.174442961347, 5302.0, 5321.0, 5321.760520776575, 5324.946750532484, 5335.519803217729, 5135.871603209912, 5259.474052594748, 5263.184206447969, 5274.2879711238875, 5291.86770330741, 5824.679642619654, 5825.475707186331, 5831.416858314177, 5832.88334233313, 5837.241158649391, 6282.717277722468, 6305.464035556983, 6323.810285691437, 6324.7470101195895, 6326.43062124411, 6303.149074874879, 6319.462845658079, 6322.146510221107, 6329.430351268408, 6334.778282760128, 5775.913361299584, 5944.5838791284195, 5958.880822383571, 5981.252343457068, 6012.18835457212, 6308.684565771693, 6312.179416675803, 6319.55763096588, 6323.146375239376, 6335.429811317003, 6129.817282374534, 6131.132004888128, 6218.284897236786, 6283.937160628427, 6331.746730130835, 6331.810045698637, 6341.492680585542, 6341.587796793286, 6350.714217860207, 6356.650384228912, 6348.143000694847, 6361.8727625448155, 6380.106785050097, 6388.233411990498, 6388.744450221939, 6084.60450070744, 6145.0, 6293.527985401113, 6299.370062993756, 6367.745290188341, 5073.34046573943, 5080.314157588678, 5083.364579427572, 5097.64316497849, 5102.897942041139, 4488.5511448855505, 4509.0, 4521.615662668644, 4522.29904364824, 4546.840860569864, 5699.487046165782, 5705.315362156568, 5765.769369225184, 5888.941110588925, 5899.498542623839, 6290.0, 6321.873562528724, 6331.525135614847, 6339.746410143634, 6359.618422894641, 5842.620229685057, 5847.239858818326, 5860.765569377262, 5879.735411906475, 5907.7046147692445, 5396.649217800909, 5437.157240627709, 5558.749856256478, 5562.805301814417, 5572.749226284745, 6225.28409232944, 6328.746850125944, 6341.302456729848, 6375.617462952052, 6389.840253993687, 6315.210598675166, 6330.082138090043, 6335.841603959938, 6341.682915854281, 6353.428191462791, 6193.071039344134, 6399.7440102395385, 6403.903941440789, 6406.775762848278, 6416.0, 6184.196054513064, 6291.716872740646, 6325.177726895658, 6367.204099487564, 6367.395097465734, 6312.179416675986, 6328.873422531616, 6329.145565348619, 6333.429991300805, 6342.7145778441, 6100.0, 6264.154339164154, 6299.559030867796, 6309.747610095545, 6319.052142178526, 6050.909236361546, 6089.238845144357, 6089.725962331617, 6117.066276512034, 6119.296280927751, 6105.389461053859, 6125.693715314305, 6130.080487926846, 6130.5402094842175, 6134.294556125924, 6263.592866463848, 6280.1207830902795, 6287.937120628735, 6292.182016337847, 6306.306306306211, 6051.697415129138, 6127.877442451215, 6130.785422510191, 6142.0, 6152.692365381624], "value": 5810.515086584823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.6686074114796, 738.5347231244315, 803.8633432316508, 874.0691163910435, 881.2333270055053, 27397.863010684945, 27785.444291114167, 39349.80325098378, 40127.19745605093, 40174.397384039265, 40569.78290651278, 40774.0, 40811.57159499418, 40836.97907552313, 40861.0, 8958.820823583541, 9113.225375843029, 9116.498592577405, 9117.0427105154, 9123.771905702344, 7289.635518224094, 7436.40508759298, 8991.235744961687, 10788.892111078907, 11035.613753518628, 10950.39772812495, 10999.670009899715, 11005.1746119041, 11027.779444411108, 11034.724131896726, 10938.0, 10939.0, 10962.616308429246, 10966.287191332578, 10970.890291097066, 7128.25153358895, 7270.672819723125, 9977.75055623608, 10635.149188064936, 10693.19801014927, 38662.420063699064, 38962.22075558501, 39096.0, 39103.60896391028, 39183.0, 3320.8007519548664, 3807.5240594925635, 3823.254465379252, 3835.789031603261, 3858.7684738915755, 27264.0, 28144.718552814415, 29125.85437072801, 29222.85388573065, 29345.41309173826, 3025.183200535865, 3099.9845000775076, 3130.7651926105405, 3222.2910959588853, 3264.6245681746664, 315684.0, 320020.0, 320211.3989430061, 322945.0, 323745.0, 52142.739286303324, 52158.47841521612, 52220.73889630604, 52225.95548089093, 52314.47685523172, 54435.45564544383, 54465.1830222547, 54484.182737258976, 54534.0, 54581.63545911384, 14341.85658143426, 14495.420183192766, 14504.34730437133, 14536.345864436125, 14543.0, 12553.12128151039, 12574.371281435891, 12598.307093109783, 12603.621891343275, 12628.621141365773, 10602.734931626772, 10808.89191108079, 11016.779664406668, 11039.0, 11063.114950803916, 4372.934405983913, 4783.162946484421, 4799.704079898478, 5038.874028149326, 5145.790739176291, 1071.4053700196466, 1086.375334182848, 1098.9890101099047, 1107.645553422897, 1150.539784086372, 27105.322366940985, 27663.446731065265, 27668.861655691995, 27770.861145694143, 27975.0, 1142.5315620595516, 1150.9827352589718, 1157.9652610421701, 1194.510250797169, 1200.3338147328143, 13950.651233719036, 14129.434822606981, 14279.214643194517, 14300.499482518062, 14571.562853114423, 480817.0, 485068.0, 489223.0, 489974.0, 490129.0, 48113.75943120332, 48140.7045225025, 48209.758951205724, 48250.0, 48258.27612585814, 1375.1336657905456, 1414.3140576820233, 1418.8368337641302, 1419.7941298511657, 1425.60795781161, 25982.61026084648, 26602.86698566572, 26928.0, 27132.864335678194, 27152.864235678695, 40262.0, 40283.0, 40319.79040628786, 40328.17702760896, 40396.596034039285, 422723.0, 423808.0, 423829.0, 424690.0, 424768.0, 28533.0, 28607.856960715897, 28618.713812861606, 28628.570571441862, 28633.856830715715, 27326.180214593594, 36136.81931590325, 36240.637593623724, 37155.442668360534, 37443.43834842425, 23670.24583356172, 27137.72862271352, 28056.71943280541, 28509.857450712614, 29158.56262156112, 26644.200673979813, 27071.86464067667, 27151.59272610952, 27331.0, 27475.763590638868, 28246.0, 32166.41500437146, 32526.698932042455, 32921.0, 33241.33517329688, 21092.0, 28320.43359132847, 29103.563446547894, 29104.5447727617, 29191.0, 22668.319950401514, 22672.65991010169, 23061.423464413525, 23237.88381058084, 23367.61169630428], "value": 17936.246026365116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.6171951487544, 409.72138945517054, 421.47736806360115, 436.4500729081358, 446.83467117166634, 14332.355044023017, 16904.661906761856, 20630.1747930083, 21470.463238419048, 21696.674549881765, 18137.455876323733, 21035.789642103573, 21389.35831925045, 21984.8900755496, 22051.558968820613, 6620.66896655169, 6802.761903333359, 6843.794686159398, 6853.828654283658, 6931.480138989571, 7195.89206161908, 7259.056322678044, 7267.672954717024, 7289.343959043685, 7291.7447889323885, 7059.9647001764915, 7264.27357264272, 7267.963660181692, 7280.4903656744045, 7342.412606991428, 6745.561538500031, 7340.339369456748, 7382.741604043859, 7394.223606521292, 7444.255574442566, 6157.568970172089, 7154.034205382311, 7154.642267886585, 7165.9283407165785, 7175.103112110986, 23913.04347826085, 24459.0, 25415.745842541706, 25924.870375648003, 26173.083942062127, 2800.957985630217, 2824.6186764786903, 2828.61813655156, 2841.4033053058884, 2887.5379939209834, 12542.0, 15420.537383878502, 15475.071495710294, 15497.915145939789, 16267.837321626868, 1758.1033672826823, 1996.4310171601169, 2014.597080583889, 2104.4107649858065, 2116.7248257726396, 134448.0, 151089.24455377762, 162342.37657623392, 163560.0, 165965.0, 12229.449674764657, 18671.626567468575, 19478.707819382722, 19671.803281966997, 19701.802981969995, 26609.73390266111, 28523.001694940576, 29539.556906646416, 29896.40207195844, 29965.400691986037, 8132.2680958714, 9585.952070239604, 10152.898471015344, 10198.18414526836, 10213.540390682288, 8416.3266938646, 8421.95789021051, 8438.789030274169, 8579.013413457533, 8602.569871506525, 7649.655765490566, 9119.948011697315, 9214.815703685888, 9304.767380815398, 9340.085282517068, 3320.900372988814, 3844.5386553613184, 3899.4150877368056, 3902.6145718269604, 3902.6487616114687, 1005.8491226316111, 1025.707673313102, 1027.1269420992096, 1042.864427624404, 1067.7223921780394, 18068.819311806976, 20013.899930500254, 20311.593768124556, 20678.966051697356, 20917.686234706493, 1017.9491025448698, 1026.5585798106886, 1044.3055368180228, 1047.8428235764695, 1074.7635520185547, 9171.991080981086, 10570.101541368917, 10833.566657333777, 10862.565497380174, 10988.945055274673, 616442.0, 636101.0, 793051.0, 797792.0, 800963.0, 104777.0, 110194.0, 129753.0, 134087.0, 137601.0, 1239.4174737873186, 1274.343712987812, 1283.434210263477, 1295.7861952777876, 1301.342821874947, 15801.68396632084, 18910.243590256236, 19368.0, 19629.214831406585, 19637.70543441878, 60380.0, 61053.0, 61133.0, 61356.0, 62553.68723156355, 83654.0, 84336.73494897458, 85534.0, 86391.5680421619, 87108.56445717732, 10721.356718596597, 10935.562577497129, 11033.33799971972, 11183.72040698989, 11399.259048161843, 12205.633830985085, 12313.44589493457, 12448.937755311166, 12468.002559795013, 12506.437210325375, 10446.425446600206, 10578.947105264424, 10742.355458672504, 11050.115990720884, 11173.72065698364, 9969.202463802734, 10469.738256543647, 10584.84122738175, 10733.892661073602, 10734.83897741519, 11495.080393568327, 11549.0, 11774.705632358917, 11807.940960295144, 11862.051035917279, 10689.30519516229, 11336.206465547333, 11423.771524569296, 11630.476628551905, 11749.471273792871, 10973.615923442641, 11052.613158539412, 11216.495257713259, 11339.262947908359, 11355.943220284176], "value": 11314.937115463781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.4666243483564, 1503.6917431926456, 1536.2472388529616, 1566.0525382143803, 1571.5049759325807, 10456.268061235716, 11039.558417663295, 11042.668719938394, 11043.282186657872, 11043.83434248487, 10437.791244175112, 10738.892611073887, 10885.020348168664, 10922.726931826708, 10939.45302734862, 2285.6800047993293, 2315.2128276386024, 2324.4421338878633, 2330.2659662206433, 2332.183735692511, 2225.265662331427, 2292.713410823647, 2297.7127859017623, 2304.0783686525356, 2308.2152068296778, 2249.5388445368662, 2266.852654577447, 2291.4844160064017, 2293.0369244917174, 2302.1712183613886, 2210.347947355534, 2280.304507125326, 2280.9201677941273, 2282.0643536150264, 2284.2690339091496, 2273.30664147435, 2284.8400611957168, 2286.6455699366456, 2287.7712228777154, 2290.061074959275, 10901.0, 10959.50682219302, 10968.890311096866, 10982.615608453745, 10983.901609839033, 5216.504432078947, 5373.570114390839, 5376.731163441812, 5376.838694839161, 5388.78444862205, 3102.5811515445575, 3206.9839650801596, 3333.3666603345528, 3354.6477619849807, 3355.3792548378383, 1223.816427535868, 1240.2558464921065, 1794.4078454110243, 1834.7431359609666, 1921.625283069802, 13391.933040334736, 14855.405783768636, 15278.770818437732, 15307.617309567238, 15359.999999999889, 3735.364987952055, 4263.957360426356, 4323.113761678848, 4433.645308375322, 4449.933251001237, 11381.601643942422, 11413.828792568118, 11419.0, 11434.02810761078, 11444.94277528607, 5254.0, 5319.547838433699, 5329.280547126088, 5329.520343169133, 5331.920021199685, 4723.409573803275, 4946.455889852114, 4946.604271658259, 4964.131277026506, 5036.0179764946215, 3566.964330356663, 3599.4420864766003, 3630.8003059831435, 3683.594804571495, 3694.445833124999, 943.6084025129632, 947.303731757158, 957.3777044920857, 958.075457183821, 961.274237950357, 773.3697036914897, 775.8448310337955, 829.3323874281141, 830.3938125168661, 850.1668365002332, 6478.643674597848, 6506.804795856132, 6562.77030303937, 6590.373914478117, 6645.867082658319, 823.625250511016, 941.9873635841361, 967.3760424526141, 999.3953658036928, 1020.0411613083678, 3759.5112635357777, 4102.3026085565525, 4334.653227741773, 4361.302191649321, 4488.506264310923, 10688.679339619825, 14056.367463464168, 14189.929050354682, 14215.573532794033, 14288.499902503363, 11876.88123118775, 12038.939805301092, 12492.437840297209, 14118.576442706735, 14160.0, 8504.617292221865, 8785.253253473398, 8913.55432228386, 9774.413535187912, 9939.50302484873, 6616.338366163538, 6684.4318232950745, 6697.966510167418, 6789.830254243683, 6954.235034146341, 11787.11596630239, 11934.761304774029, 12146.514139434325, 12365.629031129081, 12455.377231138587, 12287.44706488228, 12315.0, 12455.190412623151, 12480.126391152895, 12544.372781361079, 9064.864027039468, 9390.624375025196, 9398.34211605181, 9400.200982916254, 9402.43585384879, 9620.663276785279, 10212.438315892698, 10254.0, 10254.025867542572, 10264.897351026693, 8471.364647651328, 8508.361872859436, 8603.655853765778, 8724.345674074342, 8724.825503489768, 8417.663293468193, 8482.57587120629, 8489.872651910102, 8611.8708219378, 8689.739307820775, 7665.923340766521, 7760.611969401394, 7879.724209652634, 7896.605169741375, 7905.446618736633, 5756.4169853289, 5765.654060756368, 5863.736131874161, 5911.3201981772645, 5978.0, 4956.702597844141, 5828.213191219301, 5880.676562789087, 5890.381509941394, 5908.7045647718305], "value": 4997.409884672167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.25900572774265, 375.7801686013682, 376.9981150094249, 382.269864558693, 382.55432421229267, 4947.0, 5009.273655319977, 5031.295618613392, 5033.773480193391, 5048.697078175312, 3775.5658099318584, 4380.978095109528, 4792.993471371007, 4839.668496695455, 4871.807686541053, 3520.507129001948, 3628.9455658165148, 3702.075360465229, 3875.534935807707, 3877.247154520294, 4163.770992595406, 4165.458490396244, 4174.77038762868, 4179.014967890258, 4213.831446742142, 3994.9001274968214, 4028.8992775180564, 4112.9717570607345, 4166.0834616384345, 4201.214483844369, 2995.955060674092, 3710.2208536207427, 3875.7093218008763, 4053.5743746906446, 4069.287874621959, 3295.3903527847424, 3342.181165614416, 3794.4118661607217, 3796.487474191004, 3825.221272108455, 4504.909901801979, 4739.753269010739, 4828.275758636198, 4832.8401183716005, 4850.6362022848425, 3946.6645335146545, 4528.120829855606, 4655.767211639404, 4781.378420805273, 4847.442544107437, 4477.350784136282, 4645.581897629229, 5038.596912247048, 5061.0, 5337.877341755078, 3766.7928263945473, 3997.161305799336, 4141.544430112715, 4176.749395036308, 4229.154169166149, 4532.818687252473, 5238.554722848562, 5586.636868603528, 5608.924697861777, 5610.270664813589, 3836.55879573847, 4141.860988228201, 4143.81352839123, 4229.577042295808, 4305.225059489259, 3791.829367678461, 4315.07225946423, 4419.270820314677, 4421.40311058003, 4426.601605855489, 3950.957762522899, 4298.76356800379, 4328.653707703376, 4603.4015577975315, 4686.078707729815, 4834.154023045953, 4893.804247830119, 5121.487851214849, 5268.998890210848, 5360.758765855546, 1328.2760895312078, 1388.6250712307822, 1499.932503037366, 1500.3473489032306, 1513.9175489525041, 1064.2443864856039, 1137.6757624077097, 1142.6000899685043, 1144.6108323170163, 1172.7009612548916, 4471.709338893027, 4893.730844803499, 4900.035478535506, 4913.361263035782, 4932.594210649948, 4644.883877903079, 4814.687045342112, 4858.6356023297685, 4974.681709347026, 5431.0, 4191.64371028466, 4526.8189272428735, 4796.448408433005, 4840.515948405202, 4915.582175515121, 2479.528889510987, 2838.836077208376, 2851.9020177231914, 2873.103751523984, 2886.3794284228993, 5009.974950125299, 5647.317524175984, 5681.318241811009, 5689.829305120853, 5717.341436232089, 4866.8076321301505, 5001.7499125043605, 5352.866178345573, 5536.557075433956, 5685.630434021776, 4684.789184486638, 5291.232771248147, 5592.496675299242, 5624.71876406178, 5627.0, 5321.893562128658, 5323.281357016908, 5467.769751805812, 5496.780128794803, 5502.504774570148, 4895.853124406273, 4991.875203119951, 5020.874478138076, 5371.516563509303, 5461.569601527282, 4618.191816432044, 5014.473480284518, 5267.891943753204, 5322.806316210243, 5361.4370491099435, 4088.8329185531716, 4328.394024836588, 4451.287793952952, 4587.188060715932, 4644.23519062754, 4604.930926036179, 4854.83008094715, 5460.822470809754, 5512.3660779010925, 5535.612507124623, 4526.574129149308, 5165.586753059671, 5293.9205911910585, 5309.814156504503, 5349.545288650508, 5306.761195746123, 5335.573154147736, 5338.866528336823, 5353.2505449237915, 5360.597955153457, 4769.856904292877, 5008.749562521933, 5026.90845130235, 5254.290670759398, 5263.473652634706, 4487.955120448753, 4986.227134794112, 5291.550218231339, 5369.818639899216, 5562.3881373048125, 5018.322526459027, 5190.821388781916, 5194.870103257646, 5361.571074313967, 5385.165299378603], "value": 4034.557658025976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.1622917415799, 736.9705211791526, 777.129614831389, 827.4497459189639, 836.5399030533205, 15049.623759406006, 15847.683046339094, 15864.444744433933, 15867.682646347066, 15892.920535397336, 14365.066270692423, 14373.137611743277, 14395.0, 14468.493602723907, 14504.709905801905, 923.949182794946, 928.4939707859199, 941.1764705882352, 955.7037318431273, 961.9470929098896, 939.3283802081545, 959.2134449751206, 959.3524371049549, 960.7213907966682, 960.9135177833994, 1010.9646162384319, 1011.9392836429801, 1013.2350075692879, 1013.9746506337364, 1014.2393205096178, 1002.909738123565, 1003.5584342889106, 1005.7385079879211, 1007.1841808135433, 1007.410664761112, 748.5583505731645, 748.9625518724042, 749.0, 749.5689978262467, 749.9100107987076, 15323.770143447857, 15432.996855204376, 15464.536063917987, 15964.521064368088, 16197.0, 13960.022798404116, 14045.64885877851, 14068.388274029108, 14199.290035498287, 14322.498712545012, 11312.6040588579, 11683.474243658971, 11757.35334556599, 11842.703932401673, 11871.940640296743, 3706.721995850295, 3721.292954338667, 3722.1253005543676, 3725.8137093145233, 3811.6378944000276, 102546.0, 107464.0, 108231.45884270607, 110148.0, 111059.0, 10221.744456388502, 10331.225158113171, 10659.253852230424, 11006.064484518905, 11275.436228188557, 21008.894955525124, 21165.68251476229, 21308.0, 21494.78505214928, 21583.46041348979, 7599.164091949881, 7658.0, 7665.3101220889275, 7741.5742134183165, 7798.1811909749795, 3740.401535754266, 4233.407322974786, 4253.149370125987, 4396.406485124531, 4498.6626003049905, 2904.1868276882506, 3137.200013996462, 3168.778185526991, 3207.759418043656, 3592.515010473605, 627.2065836716557, 629.7229219143562, 638.0811631250983, 644.7678835619173, 647.2104033079635, 661.573285231033, 663.9933600664028, 695.5305169010898, 699.2972063076576, 715.4669771020519, 10205.795884082278, 10322.48387580618, 10446.738831529121, 10604.628837990633, 10758.46207689628, 586.2730214533947, 598.4015984015984, 663.4360793325635, 700.345177259254, 705.7635692043223, 4897.755112244374, 5082.517160869711, 5085.084684756779, 5094.949050509522, 5113.284140220372, 100079.0, 102182.97817021883, 102912.48543757234, 103737.48131259295, 105484.0, 61254.74163997068, 69539.65230173917, 74906.0, 81415.0, 89328.0, 70423.64788176026, 73033.6348318255, 73400.63299683575, 73725.6313718428, 74394.0, 10498.107660848913, 10730.463476826284, 10918.781624367628, 11339.376334301693, 11355.659330220107, 46940.53059469361, 47658.808529785645, 48185.75907120442, 48195.39669429745, 50150.0, 64865.35134648593, 67198.66400667965, 67594.66202669151, 68064.0, 68525.65737171282, 11194.824543423148, 12218.877811221773, 12529.436175372313, 12773.744525109632, 12898.226106433644, 13143.34283285851, 13991.58025259244, 14393.9280303602, 14920.925395372953, 15432.537023889301, 12937.029722770641, 13657.248851312876, 13941.0, 14209.431622735388, 14401.63995900111, 13673.31633418345, 13708.657283567592, 13755.656108597364, 13922.721545569235, 14015.929920350332, 12587.24476531411, 13630.0, 13633.182009079486, 13641.0, 13952.302384880919, 8956.417832840845, 9403.059694030815, 9702.36934599277, 9811.803763924825, 9976.401415915068, 9969.601215951281, 10376.37741735468, 10380.0, 10964.835527467254, 11292.661220163409], "value": 7561.289434904625, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 115.0, 116.0, 115.0, 113.0, 117.0, 115.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 136.0, 107.0, 142.0, 110.0, 108.0, 120.0, 111.0, 130.0, 106.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 185.0, 184.0, 186.0, 186.0, 199.0, 216.0, 186.0, 185.0], "value": 189.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 62.0, 90.0, 63.0, 60.0, 61.0, 59.0, 75.0, 61.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 88.0, 71.0, 69.0, 67.0, 82.0, 69.0, 67.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 88.0, 89.0, 89.0, 90.0, 133.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 98.0, 96.0, 101.0, 96.0, 116.0, 149.0, 95.0], "value": 103.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 86.0, 86.0, 89.0, 84.0, 84.0, 83.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 60.0, 60.0, 63.0, 63.0, 64.0, 63.0, 64.0, 66.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 58.0, 64.0, 61.0, 60.0, 65.0, 79.0, 80.0, 81.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 83.0, 81.0, 82.0, 92.0, 97.0, 98.0, 80.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 138.0, 136.0, 143.0, 147.0, 139.0, 196.0, 168.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 174.0, 191.0, 164.0, 164.0, 164.0, 162.0, 164.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}]}]} 02:29:59 INFO - Return code: 0 02:29:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:29:59 ERROR - # TBPL SUCCESS # 02:29:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:59 INFO - 2017-04-02 02:29:59.261 screenresolution[1673:20625] starting screenresolution argv=screenresolution get 02:29:59 INFO - 2017-04-02 02:29:59.264 screenresolution[1673:20625] Display 0: 1600x1200x32@60 02:29:59 INFO - 2017-04-02 02:29:59.270 screenresolution[1674:20628] starting screenresolution argv=screenresolution list 02:29:59 INFO - Available Modes on Display 0 02:29:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:59 INFO - Intel Iris: 02:29:59 INFO - Chipset Model: Intel Iris 02:29:59 INFO - Type: GPU 02:29:59 INFO - Bus: Built-In 02:29:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:59 INFO - Vendor: Intel (0x8086) 02:29:59 INFO - Device ID: 0x0a2e 02:29:59 INFO - Revision ID: 0x0009 02:29:59 INFO - Displays: 02:29:59 INFO - Display: 02:29:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:59 INFO - Display Serial Number: 1600x1200 60 02:29:59 INFO - Main Display: Yes 02:29:59 INFO - Mirror: Off 02:29:59 INFO - Online: Yes 02:29:59 INFO - Rotation: Supported 02:29:59 INFO - Return code: 0 02:29:59 INFO - Running post-action listener: _resource_record_post_action 02:29:59 INFO - [mozharness: 2017-04-02 09:29:59.504858Z] Finished run-tests step (success) 02:29:59 INFO - Running post-run listener: _resource_record_post_run 02:29:59 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32283648; Write bytes: 510306304; Read time: 306; Write time: 1821 02:29:59 INFO - TinderboxPrint: CPU usage
54.1% 02:29:59 INFO - TinderboxPrint: I/O read bytes / time
32,283,648 / 306 02:29:59 INFO - TinderboxPrint: I/O write bytes / time
510,306,304 / 1,821 02:29:59 INFO - TinderboxPrint: CPU idle
2,207.3 (45.9%) 02:29:59 INFO - TinderboxPrint: CPU system
961.3 (20.0%) 02:29:59 INFO - TinderboxPrint: CPU user
1,641.1 (34.1%) 02:29:59 INFO - TinderboxPrint: Swap in / out
236,019,712 / 0 02:29:59 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203692544; Write bytes: 201560576; Read time: 15605; Write time: 433 02:29:59 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30317568; Write bytes: 297960960; Read time: 281; Write time: 1352 02:29:59 INFO - Running post-run listener: _upload_blobber_files 02:29:59 INFO - Blob upload gear active. 02:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:59 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:29:59 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:29:59 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:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:01 INFO - (blobuploader) - INFO - Done attempting. 02:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:02 INFO - (blobuploader) - INFO - Done attempting. 02:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:02 INFO - (blobuploader) - INFO - Done attempting. 02:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:05 INFO - (blobuploader) - INFO - Done attempting. 02:30:05 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:05 INFO - Return code: 0 02:30:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13f1db6876ca37a2cd1ad5791bf00fbd0207a6d1fd5fec67fd90e5e56fdeb0d00227585718610c0ce1166be834a525f7d45f3b25ce92af72f9c18eb74c340b68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea32184917f74cc0f2ddf34f18d4f6b637a2136aab840895225c83f27d9603062c400c3762d7652c828943765bdbea1fe17f90cceb7a95cc496f523b496af9d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/292dec233aa1c9b6d41365394c9402cb43e6df85efc97edf96045a3950c5cde00bd12fcb123bf346b0d313a1f17ff6633e1ac31194f3275bb84ee281005949c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d71f89c072df937bb46f5fc7a12d493e0ba76aa05f8beb49457df9e6e5eec61788007588093c9df875c443815a6816ce662443f7158e619f169cf2b9eeab1eb"} 02:30:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:05 INFO - Contents: 02:30:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13f1db6876ca37a2cd1ad5791bf00fbd0207a6d1fd5fec67fd90e5e56fdeb0d00227585718610c0ce1166be834a525f7d45f3b25ce92af72f9c18eb74c340b68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea32184917f74cc0f2ddf34f18d4f6b637a2136aab840895225c83f27d9603062c400c3762d7652c828943765bdbea1fe17f90cceb7a95cc496f523b496af9d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/292dec233aa1c9b6d41365394c9402cb43e6df85efc97edf96045a3950c5cde00bd12fcb123bf346b0d313a1f17ff6633e1ac31194f3275bb84ee281005949c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d71f89c072df937bb46f5fc7a12d493e0ba76aa05f8beb49457df9e6e5eec61788007588093c9df875c443815a6816ce662443f7158e619f169cf2b9eeab1eb"} 02:30:05 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:05 INFO - Copying logs to upload dir... 02:30:05 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.051552 ========= master_lag: 3.26 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-02 02:30:08.507707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 02:30:08.511042) ========= 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.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/13f1db6876ca37a2cd1ad5791bf00fbd0207a6d1fd5fec67fd90e5e56fdeb0d00227585718610c0ce1166be834a525f7d45f3b25ce92af72f9c18eb74c340b68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea32184917f74cc0f2ddf34f18d4f6b637a2136aab840895225c83f27d9603062c400c3762d7652c828943765bdbea1fe17f90cceb7a95cc496f523b496af9d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/292dec233aa1c9b6d41365394c9402cb43e6df85efc97edf96045a3950c5cde00bd12fcb123bf346b0d313a1f17ff6633e1ac31194f3275bb84ee281005949c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d71f89c072df937bb46f5fc7a12d493e0ba76aa05f8beb49457df9e6e5eec61788007588093c9df875c443815a6816ce662443f7158e619f169cf2b9eeab1eb"} build_url:https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/Ubjdqo7hR_Wabm7vkKOAIA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13f1db6876ca37a2cd1ad5791bf00fbd0207a6d1fd5fec67fd90e5e56fdeb0d00227585718610c0ce1166be834a525f7d45f3b25ce92af72f9c18eb74c340b68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea32184917f74cc0f2ddf34f18d4f6b637a2136aab840895225c83f27d9603062c400c3762d7652c828943765bdbea1fe17f90cceb7a95cc496f523b496af9d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/292dec233aa1c9b6d41365394c9402cb43e6df85efc97edf96045a3950c5cde00bd12fcb123bf346b0d313a1f17ff6633e1ac31194f3275bb84ee281005949c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d71f89c072df937bb46f5fc7a12d493e0ba76aa05f8beb49457df9e6e5eec61788007588093c9df875c443815a6816ce662443f7158e619f169cf2b9eeab1eb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 02:30:08.551270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:30:08.551589) ========= 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.stNyjSvVMq/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.RF3yYItxHV/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005011 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 02:30:08.602251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 02:30:08.602770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 02:30:08.603321) ========= ========= Total master_lag: 3.41 =========