builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1490087171.47 results: success (0) buildid: 20170321004003 builduid: 8fa06d10b0a8492cbc4414893bce9afe revision: 0496e366a8f4d1393a8caba1db5f6d1f49da468d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.473249) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.474122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.474739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.502438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.503163) ========= 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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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-03-21 02:06:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2017-03-21 02:06:11 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173770 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.702527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.702856) ========= 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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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.027961 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:11.752522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 02:06:11.752849) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0496e366a8f4d1393a8caba1db5f6d1f49da468d --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 0496e366a8f4d1393a8caba1db5f6d1f49da468d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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-03-21 02:06:11,877 truncating revision to first 12 chars 2017-03-21 02:06:11,877 Setting DEBUG logging. 2017-03-21 02:06:11,877 attempt 1/10 2017-03-21 02:06:11,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0496e366a8f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 02:06:13,238 unpacking tar archive at: mozilla-aurora-0496e366a8f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.640016 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 02:06:13.420467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:13.421239) ========= script_repo_revision: 0496e366a8f4d1393a8caba1db5f6d1f49da468d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:13.422208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:13.422892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 02:06:13.444306) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 02:06:13.445357) ========= /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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:06:13 INFO - MultiFileLogger online at 20170321 02:06:13 in /builds/slave/test 02:06:13 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:06:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:13 INFO - {'append_to_log': False, 02:06:13 INFO - 'base_work_dir': '/builds/slave/test', 02:06:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:06:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:13 INFO - 'branch': 'Mozilla-Aurora', 02:06:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:13 INFO - 'config_files': ('talos/mac_config.py',), 02:06:13 INFO - 'default_actions': ('clobber', 02:06:13 INFO - 'read-buildbot-config', 02:06:13 INFO - 'download-and-extract', 02:06:13 INFO - 'populate-webroot', 02:06:13 INFO - 'create-virtualenv', 02:06:13 INFO - 'install', 02:06:13 INFO - 'run-tests'), 02:06:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:13 INFO - 'download_minidump_stackwalk': True, 02:06:13 INFO - 'download_symbols': 'ondemand', 02:06:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:13 INFO - 'gecko_profile': False, 02:06:13 INFO - 'gecko_profile_interval': 0, 02:06:13 INFO - 'installer_path': 'installer.exe', 02:06:13 INFO - 'log_level': 'info', 02:06:13 INFO - 'log_name': 'talos', 02:06:13 INFO - 'log_to_console': True, 02:06:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:06:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:06:13 INFO - 'opt_config_files': (), 02:06:13 INFO - 'pip_index': False, 02:06:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:06:13 INFO - 'cmd': ('bash', 02:06:13 INFO - '-c', 02:06:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:06:13 INFO - 'enabled': True, 02:06:13 INFO - 'halt_on_failure': False, 02:06:13 INFO - 'name': 'check_screen_resolution'},), 02:06:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:06:13 INFO - 'cmd': ('bash', 02:06:13 INFO - '-c', 02:06:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:06:13 INFO - 'enabled': True, 02:06:13 INFO - 'halt_on_failure': False, 02:06:13 INFO - 'name': 'check_screen_resolution'},), 02:06:13 INFO - 'run_cmd_checks_enabled': True, 02:06:13 INFO - 'suite': 'dromaeojs', 02:06:13 INFO - 'system_bits': '32', 02:06:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:13 INFO - 'title': 't-yosemite-r7-0138', 02:06:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:13 INFO - 'use_talos_json': True, 02:06:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:13 INFO - 'work_dir': 'build'} 02:06:13 INFO - [mozharness: 2017-03-21 09:06:13.678688Z] Running clobber step. 02:06:13 INFO - Running pre-action listener: _resource_record_pre_action 02:06:13 INFO - Running main action method: clobber 02:06:13 INFO - rmtree: /builds/slave/test/build 02:06:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:06:16 INFO - Running post-action listener: _resource_record_post_action 02:06:16 INFO - [mozharness: 2017-03-21 09:06:16.181837Z] Finished clobber step (success) 02:06:16 INFO - [mozharness: 2017-03-21 09:06:16.181971Z] Running read-buildbot-config step. 02:06:16 INFO - Running pre-action listener: _resource_record_pre_action 02:06:16 INFO - Running main action method: read_buildbot_config 02:06:16 INFO - Using buildbot properties: 02:06:16 INFO - { 02:06:16 INFO - "project": "", 02:06:16 INFO - "product": "firefox", 02:06:16 INFO - "script_repo_revision": "production", 02:06:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:06:16 INFO - "repository": "", 02:06:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:06:16 INFO - "buildid": "20170321004003", 02:06:16 INFO - "stage_platform": "macosx64", 02:06:16 INFO - "basedir": "/builds/slave/test", 02:06:16 INFO - "nightly_build": "True", 02:06:16 INFO - "buildnumber": 22, 02:06:16 INFO - "slavename": "t-yosemite-r7-0138", 02:06:16 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:06:16 INFO - "platform": "yosemite_r7", 02:06:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:06:16 INFO - "branch": "mozilla-aurora", 02:06:16 INFO - "repo_path": "releases/mozilla-aurora", 02:06:16 INFO - "revision": "0496e366a8f4d1393a8caba1db5f6d1f49da468d", 02:06:16 INFO - "pgo_build": "False", 02:06:16 INFO - "builduid": "8fa06d10b0a8492cbc4414893bce9afe", 02:06:16 INFO - "slavebuilddir": "test" 02:06:16 INFO - } 02:06:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:06:16 INFO - Running post-action listener: _resource_record_post_action 02:06:16 INFO - [mozharness: 2017-03-21 09:06:16.185340Z] Finished read-buildbot-config step (success) 02:06:16 INFO - [mozharness: 2017-03-21 09:06:16.185488Z] Running download-and-extract step. 02:06:16 INFO - Running pre-action listener: _resource_record_pre_action 02:06:16 INFO - Running main action method: download_and_extract 02:06:16 INFO - mkdir: /builds/slave/test/build/tests 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:16 INFO - trying https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:06:16 INFO - Downloading https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/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:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/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:06:17 INFO - Downloaded 1199 bytes. 02:06:17 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:06:17 INFO - Using the following test package requirements: 02:06:17 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:06:17 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:06:17 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:06:17 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'jsshell-mac.zip'], 02:06:17 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:06:17 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:06:17 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:06:17 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:06:17 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:06:17 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:06:17 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:06:17 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:06:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:06:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:06:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:06:18 INFO - Expected file size: 51781954 02:06:18 INFO - Obtained file size: 51781954 02:06:35 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:06:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:06:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:06:35 INFO - Fetch https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:06:36 INFO - Expected file size: 51781954 02:06:36 INFO - Obtained file size: 51781954 02:06:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:06:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:06:51 INFO - Fetch https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:06:52 INFO - Expected file size: 14404438 02:06:52 INFO - Obtained file size: 14404438 02:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:52 INFO - trying https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:52 INFO - Downloading https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/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:06:55 INFO - Downloaded 74751653 bytes. 02:06:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:55 INFO - mkdir: /builds/slave/test/properties 02:06:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:55 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:55 INFO - Contents: 02:06:55 INFO - build_url:https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:06:56 INFO - Running post-action listener: _resource_record_post_action 02:06:56 INFO - Running post-action listener: set_extra_try_arguments 02:06:56 INFO - [mozharness: 2017-03-21 09:06:56.111192Z] Finished download-and-extract step (success) 02:06:56 INFO - [mozharness: 2017-03-21 09:06:56.111312Z] Running populate-webroot step. 02:06:56 INFO - Running pre-action listener: _resource_record_pre_action 02:06:56 INFO - Running main action method: populate_webroot 02:06:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:56 INFO - '--tppagecycles', 02:06:56 INFO - '7'], 02:06:56 INFO - 'tests': ['tsvgm']}}, 02:06:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['damp', 'tps']}, 02:06:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'tests': ['damp', 'tps']}, 02:06:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['dromaeo_dom']}, 02:06:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['basic_compositor_video']}, 02:06:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:06:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['a11yr', 02:06:56 INFO - 'ts_paint', 02:06:56 INFO - 'tpaint', 02:06:56 INFO - 'sessionrestore', 02:06:56 INFO - 'sessionrestore_no_auto_restore', 02:06:56 INFO - 'tabpaint']}, 02:06:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['tsvgx', 02:06:56 INFO - 'tsvgr_opacity', 02:06:56 INFO - 'tart', 02:06:56 INFO - 'tscrollx', 02:06:56 INFO - 'cart', 02:06:56 INFO - 'tsvg_static']}, 02:06:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:56 INFO - 'tsvgr_opacity', 02:06:56 INFO - 'tart', 02:06:56 INFO - 'tscrollx', 02:06:56 INFO - 'cart', 02:06:56 INFO - 'tsvg_static']}, 02:06:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'talos_options': ['--disable-e10s'], 02:06:56 INFO - 'tests': ['tp5o']}, 02:06:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:06:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'talos_options': ['--disable-e10s', 02:06:56 INFO - '--xperf_path', 02:06:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:56 INFO - 'tests': ['tp5n']}, 02:06:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:06:56 INFO - 'talos_options': ['--xperf_path', 02:06:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:56 INFO - 'tests': ['tp5n']}}, 02:06:56 INFO - 'talos.zip': {'path': '', 02:06:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:56 INFO - Running post-action listener: _resource_record_post_action 02:06:56 INFO - [mozharness: 2017-03-21 09:06:56.129550Z] Finished populate-webroot step (success) 02:06:56 INFO - [mozharness: 2017-03-21 09:06:56.129662Z] Running create-virtualenv step. 02:06:56 INFO - Running pre-action listener: _resource_record_pre_action 02:06:56 INFO - Running main action method: create_virtualenv 02:06:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:06:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:56 INFO - Using real prefix '/tools/python27' 02:06:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:59 INFO - Installing pip.................done. 02:06:59 INFO - Return code: 0 02:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:07:00 INFO - Reading from file tmpfile_stdout 02:07:00 INFO - Output received: 02:07:00 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:07:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:00 INFO - 'HOME': '/Users/cltbld', 02:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:00 INFO - 'LOGNAME': 'cltbld', 02:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:00 INFO - 'MOZ_NO_REMOTE': '1', 02:07:00 INFO - 'NO_EM_RESTART': '1', 02:07:00 INFO - 'PAGER': '/bin/cat', 02:07:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:00 INFO - 'PWD': '/builds/slave/test', 02:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:00 INFO - 'SHELL': '/bin/bash', 02:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:00 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:00 INFO - 'USER': 'cltbld', 02:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:00 INFO - 'XPC_FLAGS': '0x0', 02:07:00 INFO - 'XPC_SERVICE_NAME': '0', 02:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:07:00 INFO - Cleaning up... 02:07:00 INFO - Return code: 0 02:07:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:00 INFO - 'HOME': '/Users/cltbld', 02:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:00 INFO - 'LOGNAME': 'cltbld', 02:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:00 INFO - 'MOZ_NO_REMOTE': '1', 02:07:00 INFO - 'NO_EM_RESTART': '1', 02:07:00 INFO - 'PAGER': '/bin/cat', 02:07:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:00 INFO - 'PWD': '/builds/slave/test', 02:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:00 INFO - 'SHELL': '/bin/bash', 02:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:00 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:00 INFO - 'USER': 'cltbld', 02:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:00 INFO - 'XPC_FLAGS': '0x0', 02:07:00 INFO - 'XPC_SERVICE_NAME': '0', 02:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:00 INFO - Downloading/unpacking psutil>=3.1.1 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:04 INFO - Installing collected packages: psutil 02:07:04 INFO - Running setup.py install for psutil 02:07:04 INFO - building 'psutil._psutil_osx' extension 02:07:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:07:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:07:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:07:05 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:07:05 INFO - building 'psutil._psutil_posix' extension 02:07:05 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:07:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:07:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:07:05 INFO - ^ 02:07:05 INFO - 1 warning generated. 02:07:05 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:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:05 INFO - Successfully installed psutil 02:07:05 INFO - Cleaning up... 02:07:05 INFO - Return code: 0 02:07:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:07:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:05 INFO - 'HOME': '/Users/cltbld', 02:07:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:05 INFO - 'LOGNAME': 'cltbld', 02:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:05 INFO - 'MOZ_NO_REMOTE': '1', 02:07:05 INFO - 'NO_EM_RESTART': '1', 02:07:05 INFO - 'PAGER': '/bin/cat', 02:07:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:05 INFO - 'PWD': '/builds/slave/test', 02:07:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:05 INFO - 'SHELL': '/bin/bash', 02:07:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:05 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:05 INFO - 'USER': 'cltbld', 02:07:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:05 INFO - 'XPC_FLAGS': '0x0', 02:07:05 INFO - 'XPC_SERVICE_NAME': '0', 02:07:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:07:08 INFO - Installing collected packages: mozsystemmonitor 02:07:08 INFO - Running setup.py install for mozsystemmonitor 02:07:08 INFO - Successfully installed mozsystemmonitor 02:07:08 INFO - Cleaning up... 02:07:08 INFO - Return code: 0 02:07:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:09 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:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:09 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:09 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:07:09 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:07:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:09 INFO - 'HOME': '/Users/cltbld', 02:07:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:09 INFO - 'LOGNAME': 'cltbld', 02:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:09 INFO - 'MOZ_NO_REMOTE': '1', 02:07:09 INFO - 'NO_EM_RESTART': '1', 02:07:09 INFO - 'PAGER': '/bin/cat', 02:07:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:09 INFO - 'PWD': '/builds/slave/test', 02:07:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:09 INFO - 'SHELL': '/bin/bash', 02:07:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:09 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:09 INFO - 'USER': 'cltbld', 02:07:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:09 INFO - 'XPC_FLAGS': '0x0', 02:07:09 INFO - 'XPC_SERVICE_NAME': '0', 02:07:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:09 INFO - Downloading/unpacking jsonschema==2.5.1 02:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:13 INFO - warning: no files found matching '*.txt' 02:07:13 INFO - no previously-included directories found matching 'build' 02:07:13 INFO - no previously-included directories found matching 'dist' 02:07:13 INFO - no previously-included directories found matching '.git*' 02:07:13 INFO - Installing collected packages: jsonschema, functools32 02:07:13 INFO - Running setup.py install for functools32 02:07:13 INFO - warning: no files found matching '*.txt' 02:07:13 INFO - no previously-included directories found matching 'build' 02:07:13 INFO - no previously-included directories found matching 'dist' 02:07:13 INFO - no previously-included directories found matching '.git*' 02:07:13 INFO - Successfully installed jsonschema functools32 02:07:13 INFO - Cleaning up... 02:07:13 INFO - Return code: 0 02:07:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:07:13 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:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:13 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:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:13 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:13 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:07:13 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:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:13 INFO - 'HOME': '/Users/cltbld', 02:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:13 INFO - 'LOGNAME': 'cltbld', 02:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:13 INFO - 'MOZ_NO_REMOTE': '1', 02:07:13 INFO - 'NO_EM_RESTART': '1', 02:07:13 INFO - 'PAGER': '/bin/cat', 02:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:13 INFO - 'PWD': '/builds/slave/test', 02:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:13 INFO - 'SHELL': '/bin/bash', 02:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:13 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:13 INFO - 'USER': 'cltbld', 02:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:13 INFO - 'XPC_FLAGS': '0x0', 02:07:13 INFO - 'XPC_SERVICE_NAME': '0', 02:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:07:13 INFO - Cleaning up... 02:07:13 INFO - Return code: 0 02:07:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:13 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:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:13 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:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:13 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:13 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:07:13 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:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:13 INFO - 'HOME': '/Users/cltbld', 02:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:13 INFO - 'LOGNAME': 'cltbld', 02:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:13 INFO - 'MOZ_NO_REMOTE': '1', 02:07:13 INFO - 'NO_EM_RESTART': '1', 02:07:13 INFO - 'PAGER': '/bin/cat', 02:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:13 INFO - 'PWD': '/builds/slave/test', 02:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:13 INFO - 'SHELL': '/bin/bash', 02:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:13 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:13 INFO - 'USER': 'cltbld', 02:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:13 INFO - 'XPC_FLAGS': '0x0', 02:07:13 INFO - 'XPC_SERVICE_NAME': '0', 02:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:14 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:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 INFO - Downloading docopt-0.6.1.tar.gz 02:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:18 INFO - Running setup.py install for blobuploader 02:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:18 INFO - Running setup.py install for requests 02:07:18 INFO - Running setup.py install for docopt 02:07:18 INFO - Successfully installed blobuploader requests docopt 02:07:18 INFO - Cleaning up... 02:07:18 INFO - Return code: 0 02:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:18 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:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:18 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:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:18 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:18 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:07:18 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:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:18 INFO - 'HOME': '/Users/cltbld', 02:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:18 INFO - 'LOGNAME': 'cltbld', 02:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:18 INFO - 'MOZ_NO_REMOTE': '1', 02:07:18 INFO - 'NO_EM_RESTART': '1', 02:07:18 INFO - 'PAGER': '/bin/cat', 02:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:18 INFO - 'PWD': '/builds/slave/test', 02:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:18 INFO - 'SHELL': '/bin/bash', 02:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:18 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:18 INFO - 'USER': 'cltbld', 02:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:18 INFO - 'XPC_FLAGS': '0x0', 02:07:18 INFO - 'XPC_SERVICE_NAME': '0', 02:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-6CQTcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-kTEG6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-PHwmG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-wifB0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-mL09p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-3Wam83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-LLXndL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:19 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-7ud4WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-9hMYzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-8XSR26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-mtgKPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-IsGDp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-jfreGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-9HQGUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-YTGGds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-SFQySA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:20 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-dgP22d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:20 INFO - Running setup.py install for manifestparser 02:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:21 INFO - Running setup.py install for mozcrash 02:07:21 INFO - Running setup.py install for mozdebug 02:07:21 INFO - Running setup.py install for mozdevice 02:07:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:21 INFO - Running setup.py install for mozfile 02:07:21 INFO - Running setup.py install for mozhttpd 02:07:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:21 INFO - Running setup.py install for mozinfo 02:07:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozInstall 02:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozleak 02:07:22 INFO - Running setup.py install for mozlog 02:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for moznetwork 02:07:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozprocess 02:07:22 INFO - Running setup.py install for mozprofile 02:07:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:22 INFO - Running setup.py install for mozrunner 02:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Running setup.py install for mozscreenshot 02:07:23 INFO - Running setup.py install for moztest 02:07:23 INFO - Running setup.py install for mozversion 02:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:23 INFO - Cleaning up... 02:07:23 INFO - Return code: 0 02:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:23 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:07:23 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:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:23 INFO - 'HOME': '/Users/cltbld', 02:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:23 INFO - 'LOGNAME': 'cltbld', 02:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:23 INFO - 'MOZ_NO_REMOTE': '1', 02:07:23 INFO - 'NO_EM_RESTART': '1', 02:07:23 INFO - 'PAGER': '/bin/cat', 02:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:23 INFO - 'PWD': '/builds/slave/test', 02:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:23 INFO - 'SHELL': '/bin/bash', 02:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:23 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:23 INFO - 'USER': 'cltbld', 02:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:23 INFO - 'XPC_FLAGS': '0x0', 02:07:23 INFO - 'XPC_SERVICE_NAME': '0', 02:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:23 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-R4D76c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:23 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:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:23 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-YhGNAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-JA8low-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-m_8GNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-DqVRHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-A_VItZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-8Wu1AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-gayKwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-73COQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-a89Dl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:24 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-AAJb1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:24 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:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-cJl0sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:25 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:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-tDv7rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:25 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:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-JZsycU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:25 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:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-a8C6WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:25 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:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-IbwRZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:25 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:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:25 INFO - Running setup.py (path:/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/pip-57BEK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:28 INFO - Downloading blessings-1.6.tar.gz 02:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:28 INFO - Installing collected packages: blessings 02:07:28 INFO - Running setup.py install for blessings 02:07:28 INFO - Successfully installed blessings 02:07:28 INFO - Cleaning up... 02:07:28 INFO - Return code: 0 02:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:28 INFO - Reading from file tmpfile_stdout 02:07:28 INFO - Current package versions: 02:07:28 INFO - blessings == 1.6 02:07:28 INFO - blobuploader == 1.2.4 02:07:28 INFO - docopt == 0.6.1 02:07:28 INFO - functools32 == 3.2.3-2 02:07:28 INFO - jsonschema == 2.5.1 02:07:28 INFO - manifestparser == 1.1 02:07:28 INFO - mozInstall == 1.12 02:07:28 INFO - mozcrash == 1.0 02:07:28 INFO - mozdebug == 0.1 02:07:28 INFO - mozdevice == 0.49 02:07:28 INFO - mozfile == 1.2 02:07:28 INFO - mozhttpd == 0.7 02:07:28 INFO - mozinfo == 0.9 02:07:28 INFO - mozleak == 0.1 02:07:28 INFO - mozlog == 3.4 02:07:28 INFO - moznetwork == 0.27 02:07:28 INFO - mozprocess == 0.25 02:07:28 INFO - mozprofile == 0.28 02:07:28 INFO - mozrunner == 6.13 02:07:28 INFO - mozscreenshot == 0.1 02:07:28 INFO - mozsystemmonitor == 0.3 02:07:28 INFO - moztest == 0.8 02:07:28 INFO - mozversion == 1.4 02:07:28 INFO - psutil == 3.1.1 02:07:28 INFO - requests == 1.2.3 02:07:28 INFO - wsgiref == 0.1.2 02:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:28 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:28 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:07:28 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:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:28 INFO - 'HOME': '/Users/cltbld', 02:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:28 INFO - 'LOGNAME': 'cltbld', 02:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:28 INFO - 'MOZ_NO_REMOTE': '1', 02:07:28 INFO - 'NO_EM_RESTART': '1', 02:07:28 INFO - 'PAGER': '/bin/cat', 02:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:28 INFO - 'PWD': '/builds/slave/test', 02:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:28 INFO - 'SHELL': '/bin/bash', 02:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:28 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:28 INFO - 'USER': 'cltbld', 02:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:28 INFO - 'XPC_FLAGS': '0x0', 02:07:28 INFO - 'XPC_SERVICE_NAME': '0', 02:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 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:07:29 INFO - Cleaning up... 02:07:29 INFO - Return code: 0 02:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:29 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:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:29 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:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:29 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 0x10ded1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98095538e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, '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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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:07:29 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:07:29 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:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:29 INFO - 'HOME': '/Users/cltbld', 02:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:29 INFO - 'LOGNAME': 'cltbld', 02:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:29 INFO - 'MOZ_NO_REMOTE': '1', 02:07:29 INFO - 'NO_EM_RESTART': '1', 02:07:29 INFO - 'PAGER': '/bin/cat', 02:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:29 INFO - 'PWD': '/builds/slave/test', 02:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:29 INFO - 'SHELL': '/bin/bash', 02:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:29 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:29 INFO - 'USER': 'cltbld', 02:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:29 INFO - 'XPC_FLAGS': '0x0', 02:07:29 INFO - 'XPC_SERVICE_NAME': '0', 02:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:07:29 INFO - Cleaning up... 02:07:29 INFO - Return code: 0 02:07:29 INFO - Running post-action listener: _resource_record_post_action 02:07:29 INFO - Running post-action listener: _start_resource_monitoring 02:07:29 INFO - Starting resource monitoring. 02:07:29 INFO - [mozharness: 2017-03-21 09:07:29.545642Z] Finished create-virtualenv step (success) 02:07:29 INFO - [mozharness: 2017-03-21 09:07:29.546597Z] Running install step. 02:07:29 INFO - Running pre-action listener: _resource_record_pre_action 02:07:29 INFO - Running main action method: install 02:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:29 INFO - Reading from file tmpfile_stdout 02:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:29 INFO - Reading from file tmpfile_stdout 02:07:29 INFO - Output received: 02:07:29 INFO - Usage: mozinstall [options] installer 02:07:29 INFO - Options: 02:07:29 INFO - -h, --help show this help message and exit 02:07:29 INFO - -d DEST, --destination=DEST 02:07:29 INFO - Directory to install application into. [default: 02:07:29 INFO - "/builds/slave/test"] 02:07:29 INFO - --app=APP Application being installed. [default: firefox] 02:07:29 INFO - mkdir: /builds/slave/test/build/application 02:07:29 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:07:29 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:07:50 INFO - Reading from file tmpfile_stdout 02:07:50 INFO - Output received: 02:07:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:07:50 INFO - Running post-action listener: _resource_record_post_action 02:07:50 INFO - [mozharness: 2017-03-21 09:07:50.256287Z] Finished install step (success) 02:07:50 INFO - [mozharness: 2017-03-21 09:07:50.256436Z] Running run-tests step. 02:07:50 INFO - Running pre-action listener: _resource_record_pre_action 02:07:50 INFO - Running main action method: run_tests 02:07:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:07:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:07:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:07:50 INFO - 2017-03-21 02:07:50.270 screenresolution[1620:7362] starting screenresolution argv=screenresolution get 02:07:50 INFO - 2017-03-21 02:07:50.273 screenresolution[1620:7362] Display 0: 1600x1200x32@60 02:07:50 INFO - 2017-03-21 02:07:50.279 screenresolution[1621:7364] starting screenresolution argv=screenresolution list 02:07:50 INFO - Available Modes on Display 0 02:07:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:07:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:07:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:07:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:07:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:07:50 INFO - Intel Iris: 02:07:50 INFO - Chipset Model: Intel Iris 02:07:50 INFO - Type: GPU 02:07:50 INFO - Bus: Built-In 02:07:50 INFO - VRAM (Dynamic, Max): 1536 MB 02:07:50 INFO - Vendor: Intel (0x8086) 02:07:50 INFO - Device ID: 0x0a2e 02:07:50 INFO - Revision ID: 0x0009 02:07:50 INFO - Displays: 02:07:50 INFO - Display: 02:07:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:07:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:07:50 INFO - Display Serial Number: 1600x1200 60 02:07:50 INFO - Main Display: Yes 02:07:50 INFO - Mirror: Off 02:07:50 INFO - Online: Yes 02:07:50 INFO - Rotation: Supported 02:07:50 INFO - Return code: 0 02:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:50 INFO - Python 2.7.3 02:07:50 INFO - Return code: 0 02:07:50 INFO - grabbing minidump binary from tooltool 02:07: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:07:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcafd30>, '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 0x10dbd6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dca4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:07:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:07:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:07:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:50 INFO - Return code: 0 02:07:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:50 INFO - ENV: RUST_BACKTRACE is now 1 02:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:50 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/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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:07:50 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/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qTuZMqmNB6/Render', 02:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:50 INFO - 'HOME': '/Users/cltbld', 02:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PAGER': '/bin/cat', 02:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test', 02:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:50 INFO - 'RUST_BACKTRACE': '1', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyxzTC1oVi/Listeners', 02:07:50 INFO - 'TMPDIR': '/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/', 02:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - 'XPC_FLAGS': '0x0', 02:07:50 INFO - 'XPC_SERVICE_NAME': '0', 02:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:50 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/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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:07:50 INFO - mozversion application_buildid: 20170321004003 02:07:50 INFO - mozversion application_changeset: 0496e366a8f4d1393a8caba1db5f6d1f49da468d 02:07:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:50 INFO - mozversion application_name: Firefox 02:07:50 INFO - mozversion application_remotingname: firefox-dev 02:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:50 INFO - mozversion application_vendor: Mozilla 02:07:50 INFO - mozversion application_version: 54.0a2 02:07:50 INFO - mozversion platform_buildid: 20170321004003 02:07:50 INFO - mozversion platform_changeset: 0496e366a8f4d1393a8caba1db5f6d1f49da468d 02:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:50 INFO - mozversion platform_version: 54.0a2 02:07:50 INFO - using testdate: 1490087270 02:07:50 INFO - actual date: 1490087270 02:07:50 INFO - starting webserver on 'localhost:49240' 02:07:50 INFO - SUITE-START | Running 2 tests 02:07:50 INFO - TEST-START | dromaeo_css 02:07:50 INFO - operating with platform_type : mac_ 02:07:50 INFO - Initialising browser for dromaeo_css test... 02:07:50 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpGHDci_/profile http://localhost:49240/getInfo.html) 02:07:53 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 02:07:53 INFO - PROCESS | 1631 | colorDepth:24 02:07:53 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 02:07:53 INFO - PROCESS | 1631 | __metrics 02:07:53 INFO - PROCESS | 1631 | 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:07:53 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:54 INFO - TEST-INFO | 1631: exit 0 02:07:54 INFO - Browser initialized. 02:07:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:54 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpGHDci_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:06 INFO - PROCESS | 1634 | RSS: Main: 214470656 02:08:06 INFO - PROCESS | 1634 | 02:11:11 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 02:11:13 INFO - PROCESS | 1634 | RSS: Main: 338587648 02:11:13 INFO - PROCESS | 1634 | 02:12:56 INFO - PROCESS | 1634 | ************************* 02:12:56 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 02:12:56 INFO - PROCESS | 1634 | 02:12:56 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:12:56 INFO - PROCESS | 1634 | Full stack: 02:12:56 INFO - PROCESS | 1634 | ************************* 02:14:16 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 02:14:16 INFO - PROCESS | 1634 | RSS: Main: 350859264 02:14:16 INFO - PROCESS | 1634 | 02:17:19 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 02:17:19 INFO - PROCESS | 1634 | RSS: Main: 346218496 02:17:19 INFO - PROCESS | 1634 | 02:20:22 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 02:20:22 INFO - PROCESS | 1634 | RSS: Main: 345092096 02:20:22 INFO - PROCESS | 1634 | 02:23:26 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 02:23:27 INFO - PROCESS | 1634 | RSS: Main: 316887040 02:23:27 INFO - PROCESS | 1634 | 02:26:30 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 02:26:31 INFO - PROCESS | 1634 | RSS: Main: 411238400 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | __start_tp_report 02:26:31 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 02:26:31 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 02:26:31 INFO - PROCESS | 1634 | |i|pagename|runs| 02:26:31 INFO - PROCESS | 1634 | |0;dojo.html;3299.90100296991;3440.741944354174;3444.9138771530716;3454.9999999999986;3479.2171761353684;6107.969460152699;6138.631682099071;6157.261128664561;6158.815235542941;6161.507079433646;6150.477209437192;6193.504519638429;6199.907001394983;6205.689715514218;6211.161493198428;5496.038193316173;5521.089020311654;5542.307211598551;5543.307086614173;5614.6631202128;5356.982173387044;5392.91910621341;5612.158176273571;5613.635113717616;5622.212890195376;5438;5495.093309603911;5497.285352904117;5579.358373787026;5598.552115830744;5561.193626924093;5584.162375643646;5590.440955904377;5594.720263986805;5603.271574695264;5436.91844622331;5526.4197259288;5539.975104605661;5564.666120032811;5572.7770889164385;5915.526757859361;5967.343592204854;5971.611845230046;5979.133025711291;5985.8802823943715;6359.42765151134;6374.808755737336;6406.519511036691;6448;6451.29035806061;6514.57655252407;6557.245916719543;6568.80293591193;6573.079768832367;6573.276939536647;6193.504519638418;6203.131561581382;6246.406591373903;6267.310595834455;6301.4328710416285;6418.582792118497;6473.514486413538;6597.0434287029075;6662.6668666566475;6715.966420167965;6397.7440902364315;6403.48772098231;6412.487001039905;6415.1981002374705;6426.132472116298;6494.870102597922;6550.312217217123;6558.704858281389;6568.901466478007;6571.835704107436;6270.090836828635;6331.620102793847;6356.269029061625;6368.968155159195;6442.065900444503;6312.242530896322;6323.652199129092;6328.525360597973;6346.555741098079;6436.227652681709;5126.718030508283;5181.404138524118;5198.2202669599865;5210.713410762369;5217.660852044605;4585.243434833215;4604.838830640979;4606.447226332862;4623.052274283764;4631.212693842055;5909.261342332208;5956.344802071769;6028.0355143176885;6136.754529818757;6148.8770224595255;6560.245571759213;6561.245456772437;6587.308332625005;6590.5716128451495;6596.670166491656;6137.447629713347;6143.877122457526;6204.968975155095;6208.906866397007;6211.192544969215;5596.748146333425;5652.463016013472;5731.656100633975;5752.741126649311;5756.798512052058;6567.179102612269;6665.233498147775;6711.765088221889;6775.390214880685;6791.762288319885;6560.9343906560325;6571.835704107244;6573.112629794917;6576.53964222519;6587.275399705933;6713.798586042427;6755.560888542229;6776.45788336922;6810.761623343159;6812.591244525344;6287.339829318039;6386.457151142205;6391.169148010729;6474.935250647433;6493.2857385688485;6524;6539.084528166156;6545.607263564201;6551.770688025897;6564.80305590833;6220.098085777447;6231.158793562811;6259.217597800275;6297.496200303873;6350.650714210763;6348;6348.619082855043;6358.205224346957;6368.649724265025;6371.171747672773;5137.51193636604;6137.407629318989;6213.254409470893;6292.653904035139;6356.014817703263;5278;5343.866403339792;6379.74481020754;6404.359564043559;6408.711607977559;6336.809895703136;6346.555741098079;6351.587146835441;6357.936420635734;6377.0753240778895 02:26:31 INFO - PROCESS | 1634 | |1;ext.html;709.8473828126952;784.9686012559497;862.7196161247596;875.1598465473149;951.1439704266155;36911;37508.249835003284;38516.229675406474;38552.80723596382;38597.614023859824;37246.627533724655;37449.43825842615;37563.06092347693;37602.62397376025;37683.62316376835;7297;7437.107547094329;7715.961420192905;7850.450468467209;10931.890681093206;11000.009999100079;11105.389203593799;11114.11087113029;11121.999020088191;11130.276532025433;11085.334879907192;11115.944420277887;11131.777364452746;11157.163212759035;11157.944210278938;7343.155537113247;7507.399408047398;10889;11063;11111.888881111207;10830.133589312914;10905.34567925927;10907.781844363068;10922.453877306103;10935.781284374347;37835.432468513;37917;37931.051723707125;37984.81007594972;37990.050248743726;3665.981670091659;3802.296575133609;3819.6371344722484;3836.1943991761764;3893.3186692329014;21574.813385263806;24811.379715507257;24852.254432366877;25264;25644.487110257876;2816;2865.8423786691724;3184.5860038194887;3226.6274108635257;3255.283837555734;333506;333649;333795;335295;336013;36435.453468198;37110.44334334987;38399.848004559906;43652;51802.74098629558;52713.47286527162;52918.735406322725;55074.724626377414;55573;55622;15303.693926121416;15388.153651549272;15392.999455035388;15393.846061539465;15405.306761195548;12884.742305154032;12915.289659068842;12922.030847686461;12925;13028.348582570834;13653.658658533615;13664.453421863212;13669;13753.862461375458;13766.724665506634;5931.911021334683;5949.702514874239;5996.850078748066;6000.049983755297;6003.6397816131175;920.9723708288763;944.3342443577261;953.9761505962267;956.4213650741341;978.5792109393029;26381.604275935875;27093.86453067722;27698.3075423112;27811.02661406841;27841.16476505708;1022.7852151048214;1031.3244824639874;1035.0787798858871;1040.7918416316616;1051.558345494894;13907.79138312926;14468.855311446961;14539.78190327146;14561.87751114126;14725.337359818619;480946;482485;482688;484026;486027;56411.35886411326;56769;56820.14769778457;56825.43174568284;56851;1422.587449639593;1458.2708645677162;1458.7884756710218;1459.6715738958649;1460.7370673278913;26466.603000954616;26993;27616;27781.861090694416;27991.72008279891;45508.54491455043;45533.089338213715;45546.772266138454;45646.31530526978;45738.08523829572;446211;447489;448162;448316;448502;27243.910243590035;31089;34885.825570873;35094.64905351016;36283.09292267715;43090.78454607707;43643;44157.23371065121;44430.55569444264;44604.884877878314;34598.751081179646;35974.820125899205;36442.453363200104;37144;37411;34443.13892152716;35778;35912.4613130798;35992.820035899655;37040.44439333466;36105.277894442486;36773.26453470969;36851.26297473982;36946.8152659235;37020.25959480849;30364.392712146077;31961.520577190895;32386;32483.02550923476;32545.34909301848;24196.87901560481;24493.632595511437;24572.139975100785;24739.381515461537;24851.50296994014 02:26:31 INFO - PROCESS | 1634 | |2;jquery.html;373.2367308853393;373.4211971444262;388.2468012056612;424.97025208235425;438.7255024154831;13046.543370982017;14386.496472623461;17653.82346176538;21203.045862936167;21696.566068678618;22116.778832211672;22338.441538961535;22738.431539211488;22901.77098229017;23065.538689226207;6647.667616619174;6709.295523969986;6799.320067993186;6865.210500792423;6918.723251069951;3727.422249551324;6755.864882702343;6879.5184337096425;6880.69036893341;6881.071055407531;4325.870223893273;4401.80191891364;7710.653020614086;7787.532748035108;7823.843523129534;7509.849803003964;7732.613369331567;7775;7789.454738168302;7815.0231221097365;7337.339639432476;7582.924170758332;7647.158812530617;7654.464187506876;7658.119316278588;27452.725472745216;27459.588106178424;27526.587101193498;27634.723652763416;27972.860135699193;2941.1764705882174;2961.896333628334;2966.16947254769;2969.109267219847;3017.8792848286043;16101.355945762156;16186.595335116715;16218.351265949348;16363.59091022722;16919;1977.831884289837;2036.3992622176493;2039.377989713137;2041.8979051047388;2048.272863133596;83926.58036709839;132419.33790330988;134199;136322.636773632;138696.30651846778;22203;22457.663135052986;22740.20409285667;22845.771542284696;22894.42763930882;31103;38465.80767096203;39415.80292098521;39446.605533944865;39460.81617551478;11091.667249982513;11097.278676886139;11111.777764444665;11256.26834255787;11333.943330283295;8974.820503589892;8982.910170898338;9004.36969412135;9161.083891610786;9204.953975230215;8819.647214111492;10692.144628429707;10876.836847447295;10956.616518421817;11005.724856878482;4254.574542545721;4321.481422229353;4354.673399495051;4363.934540981888;4367.672424568106;892.1881088209698;935.1723724503727;944.3955868244329;953.4946478366477;977.237754551451;21687;22960.966756495996;23042.193523226608;23092.845357732047;23173.53652926966;950.4629884115452;976.6814800019916;982;987.629638885418;996.960121595128;9172.49551274673;12086.697832554257;12144.514219431123;12200.389980500939;12248.326342051094;690707;701014;703998;713588.4320578364;720058;86797;115718.8428115725;121947;127138;131032;1245.8068999305121;1263.4314558448734;1292.5346875124947;1293.8512071111943;1297.1503665099376;19920.103595337954;21434.89282553577;21472.24847130343;21525.677114843602;21549;56861.715691421276;57323;57451.42548574461;57469.42530574641;58735.70632146812;78818.21181788338;78870;79982.6000869992;82088;82124.58937705273;11976;12274.693132671755;12620.116591838483;12623.242605443702;12685;13334.26661533625;13420.993425493323;13437.731245374842;13843.930780346034;13915.860841391457;7032.8593428130125;9854;11477.253978491372;11656.941715291368;11805.940970295094;11367;11437.542498299976;11566.710832229262;11618.070554355461;11702.414879256174;11702.824457633313;11810.586629467927;11907.464164112462;11965.401729913643;12141.089418293486;12253.203541769757;12292.508299667914;12355.93822030884;12375.381230938237;12630.810537841757;9643.758906027124;11734.530618775494;11787.292762434281;11790.882091178979;12027.45876435545 02:26:31 INFO - PROCESS | 1634 | |3;mootools.html;1499.7525408307629;1525.0925699208967;1558.4856997190927;1568.6000069982153;1572.1824651181387;10623.57505699772;11131.666050018492;11148.777024459507;11161.609343672973;11164.553417863275;10566.471676416188;11045.005949464547;11154.498047587858;11159.442027898593;11159.776804463905;2400.6159014557675;2441.1944058460667;2443.657887895687;2445.76765207305;2450.13020377766;2371.193794110011;2397.6043952747777;2399.30420178149;2401.327628264089;2407.169526513359;2366.7041619797524;2387.3050134404593;2394.95210095798;2397.244867866625;2398.136670798511;2298.5402919416015;2318.1770471482632;2323.9767602323927;2326.069572171128;2327.1505900346338;2339.4736184358385;2340.1926335414255;2399.3042017814814;2399.928002159938;2406.0135344508844;11050.392228427434;11185.440727963569;11188.66434006981;11216.607418740386;11242.66272011841;5765.279340082489;5962.433568810956;5976.820695379146;5981.58128930975;5990.9101363479585;3494.668006539375;3531.6291789362003;3605.369060414417;3611.6749492545796;3686.870959516404;1159.7100724818795;1169.5672601137549;1206.3968015992004;1228.766534358469;1236.536298887917;13720.519781807589;14073.366698498592;14381.784273235806;15346.386144554315;15505.612359690986;4619.86140415788;4775.307580400822;4800.35195248644;4808.927866082012;4812.614990800727;9920.801583968425;11302.604408845651;11338.376389298668;11360.54557817678;11381.260218085798;4459.464864216315;5169.095408303532;5951.940480595139;5973.133895585116;5985.820425387245;5038.546530812245;5168.9224661630105;5218.347706536683;5288.206768984606;5314.7608357624;4052.452918855976;4087.7138600297694;4143.461350024538;4186.162767446523;4186.434831297735;1117.742919128605;1129.9604513841975;1141.2809929744208;1145.478807142748;1154.7344110854383;910.2899738204211;922.5387306346827;923.8660394242797;936.3352020065694;979.0992287095889;5560.499555039985;6041.24484439445;6283.717232724447;6377.9795232762535;6462.418382345518;836.4813815434348;953.6614501851743;967.7870868409079;986.4180133720996;1021.5096753558186;4006.4791577095375;4024.5975402460103;4058.1072164123843;4095.9795201023803;4100.446439730598;11139.387333696563;13320.134191277535;13586.932065339808;13776.380062896993;13778.448862045407;13358.532451364155;13483.797743033861;13626.454941802216;13730.725385492235;13792.517261895786;10036.397816131055;10125;10144.492775361203;10269.486525673687;10278.434686092336;6368.108464814837;6375.489960803217;6466.321036291121;6508.219013718384;6569.408753212234;12083.275003499819;12122.151449398458;12132.939335303266;12233.755324893631;12276.754464910831;11509.827352589551;12421.068419868365;12534.623961281177;12546.435410406371;12575.748485030432;8926.73219803407;9002.549872506479;9030.277577793891;9071.455712657262;9154.954225228832;10115.848262276219;10236.846447303147;10343.965603439596;10362.637307694195;10392.272540922062;9023.729288121367;9104.271658267191;9110.316726245426;9127.589258483516;9219.49292788903;8633.05036446003;8830.249428798625;8841.911580884365;8888.11118888132;9044.909550904407;7517.661705223169;7699.576523291273;7827.765167044998;7828.060632724109;7829.921700783148;5171.3535808024;5326.36083669962;5547.750351234285;5625.184348269396;5888.263967004124;5773.3072031356505;5783.971080144573;5904.793332233523;5908.881822363614;6075.696215189311 02:26:31 INFO - PROCESS | 1634 | |4;prototype.html;317.1943264109163;330.03300330032994;363.37499500858513;380.5159876481722;381.68320294155853;4620.676552641312;5017;5072.706459852737;5302.269331294387;5370.355557333126;4390.748636638558;4853.369062021932;5202.8699282517955;5207.791688332462;5259.474052594748;4000.879094532636;4053.695972802037;4083.9183216335655;4244.575542445747;4309.870703878889;3332.8166950817817;3444.7416443766692;3659.359612067891;4246.150769846027;4269.167512335081;3388.0344101930955;3593.4430163324596;3711.6288371162937;3911.823967921436;4247;4078.3066878630702;4266.5867306155105;4272.380504826814;4279.154362349034;4299.1831552005015;3398.5411969384063;3430.4168291390524;3987.003249187703;3988.6210809973004;3993.8617494014065;4627.537246275346;4787.54518320759;4788.521147885219;4987.1771157759285;5081.771320290559;4402.723210269018;4760.738159401231;4815.398075240595;4938.407391113054;4972.726500042496;4558.492828944068;5584.832455026356;5597.356304025007;5598.768270980378;5614.606977511576;3887.5140607424073;4179.352200408942;4217.123380095859;4373.825046998117;4379.4087798147475;5270.49930256625;5603.495685388335;5810.912836307459;5818.599540505453;5899.73451194693;3962.32640451124;4079.0006448420327;4297.312430011183;4513.909721805611;4590.334401511829;3848.846046158122;4119.7940102994735;4319;4324.891877703082;4444.466664000276;4237.936430953539;4316.287812510964;4751.239801631722;4771.212749896228;4785.377900872864;4688.718676879398;4718.7023568518935;4895.437024742129;4952.777125029383;5353.38436079848;1402.4039783092146;1498.8271972226482;1538.7614919687467;1563.4684207369548;1569.9764503532456;1020.831148335167;1145.840091427665;1154.3016475032484;1157.1370094148415;1185.8221266810046;4840.757962101951;4914.181752751505;4944.9835600283795;4973.925391119136;5262.60530460217;4905.400137926905;4935.777889994959;5156.576409087723;5674.858128546737;5675.581104723819;4458.907567645948;4547.727136371828;4806.49531799163;4978.5270399312;5230.613887319863;2703.9324016899736;2705.3236690827293;2713.4980028694754;2782.763465105448;2830.1745374233915;5360.969646577882;5623.156526520973;5892.140647875648;5934.406559344117;5966.343702192756;4911.435184953704;5055.890627264206;5452.6455780374945;5570.972145139248;5874.236349274567;5466.180072989084;5886.793962211388;5916.3787802281;5940.257467816523;5957.672328022;5311;5431.321084864392;5466.590005749665;5474.525474525474;5631.549476041825;5071.030390217534;5092;5461.194149148724;5545.425024354843;5804.564657650609;5083.293479993659;5309.761060752198;6004.609700369462;6006.159137720635;6066.2095436098125;4140.855070072533;4437.378766972562;4511.195521791178;4513.729176249435;4515.864524064284;4795.034036045205;5300.1254792958725;5352.5450336721815;5575.609707320611;5755.453231942959;4559.544045595414;5022.573081288131;5057.583876514582;5377.220303056113;5390.730463476732;5019.7239151847;5315.6279060465395;5529.778808847762;5538.723063846872;5556.249531566257;4238.470191226097;4751.842138129137;5245.265662807286;5358.776107915171;5412.646838290428;4776.952230477651;4992;5272.446393128666;5540.833774986757;5557.277553917965;4364.650827933821;4831.661783675109;5363.329583802025;5446.183072539151;5477.616566840283 02:26:31 INFO - PROCESS | 1634 | |5;yui.html;605.2343785111836;721.0842230367437;738.5716284554957;755.8601658693138;851.9062903080662;12192.81710774339;15422.768658470131;15435.305411256493;15436.691266174685;15448.536543903687;11975.64073077809;13937.44250229992;13991.30043497826;14080.929595352009;14136.858631413683;912.1061359867334;923.8290916180495;925.0240995749482;926.393212445849;926.7451450851037;900.4192295969096;901.6078006067349;904.5251243097393;925.4909799610222;960.4141473701071;979.1041197304457;986.8569057486696;994.0258546624312;994.5872462927877;996.6710985374809;986.8273052215869;988.2834944665132;989.806987637411;991.0337421014525;991.3209451525692;733.1422235983912;733.9449541284372;734.2840730287927;734.2950767263434;734.5262305812774;15436.845631543652;15579.532614021597;15609.609759756097;15699.058056516646;15716.135612541306;13829.861701382957;14111.435542578387;14238.572842814732;14291.928540357336;14322.355494002795;11601.35514971817;11690.41547922609;11855.347955862424;11869.169158158933;11958.043356531543;3594.4248920172645;3598.946015809765;3670.9082272943124;3737.626237376268;3832.1186127190904;105292;106913.19291794852;110394.44802776015;111745.44127279393;111746;10368.844467332845;10592.788144237073;10660.987206215397;10691.62579309736;10848.403337816339;21918.123275069138;21941.890290548763;22186.667199992015;22276.66585001226;22319.330420087423;7165.534240274365;7420.220876807965;7649.388048956182;7724.343430808444;7868;4218.282891908383;4255.212785634668;4298.26929421999;4375.649948004152;4471.329300604935;3149.4803357445767;3337.5494308268558;3409.9488507672404;3425.0581090200394;3435.1927297085167;576.9336526299529;616.3897741236144;624.5669603088173;640.6540468147149;640.695669556966;571.865611581278;674.5952428542934;692.1210063219683;694.944404447643;706.4948561778353;10101.683116624847;10128.848067278997;10233.079022887976;10240.53917573696;10562.683119506428;640.4492136762381;693.3551796828897;695.5270416117089;696.6481926627122;708.8015355700412;4956.925646115311;4959.851204463872;4968.975155124202;4969.701817890938;4973.303737476756;74380;75105;78581.60709196418;87752.56123719341;93769.5311523438;75276.24723752802;76246;76293.61853190699;78206.82689759658;79478;70826.5510939794;71611;72978.63510682412;73483;73966.26033739702;9904.405735655884;10565.471726413802;10744.946275268574;10843.969822866815;11191.104711622887;44463.77681115866;44748.55251447574;50429.99140017253;51020.489795101574;51078.744606276734;48523.088614683234;59013;60273.79452411015;61290;61927.69036154971;11947.701307467383;12033.687177731419;12156.452959617016;12339.69150771238;12356.505739770668;13688.247146407044;13697.657558560717;13977.58067257984;14637.19495427719;15126.924365378103;13034.608961731163;13523.256220907944;13695.657608559866;13978.021538492614;14014.439422422989;13047.217166970013;13119.868801311864;13568.1859088455;13570.93214533921;13878.592093053245;12800.61598152057;13204.80192797128;13360.93319533396;13503.729925401634;14021.158730476203;10393.16854651611;10583.62957296491;11201.551937922392;11327.773444531229;11529.1929564933;10239.1767175401;10366.844497332395;10558.260921735406;11040.834387484034;11235.382053987109 02:26:31 INFO - PROCESS | 1634 | __end_tp_report 02:26:31 INFO - PROCESS | 1634 | __start_cc_report 02:26:31 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1564 02:26:31 INFO - PROCESS | 1634 | __end_cc_report 02:26:31 INFO - PROCESS | 1634 | __startTimestamp1490088391198__endTimestamp 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | ------- Summary: start ------- 02:26:31 INFO - PROCESS | 1634 | Number of tests: 6 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:6034.46 Median:6270.09 stddev:679.31 (10.8%) stddev-sans-first:646.63 02:26:31 INFO - PROCESS | 1634 | Values: 3299.9 3440.7 3444.9 3455.0 3479.2 6108.0 6138.6 6157.3 6158.8 6161.5 6150.5 6193.5 6199.9 6205.7 6211.2 5496.0 5521.1 5542.3 5543.3 5614.7 5357.0 5392.9 5612.2 5613.6 5622.2 5438.0 5495.1 5497.3 5579.4 5598.6 5561.2 5584.2 5590.4 5594.7 5603.3 5436.9 5526.4 5540.0 5564.7 5572.8 5915.5 5967.3 5971.6 5979.1 5985.9 6359.4 6374.8 6406.5 6448.0 6451.3 6514.6 6557.2 6568.8 6573.1 6573.3 6193.5 6203.1 6246.4 6267.3 6301.4 6418.6 6473.5 6597.0 6662.7 6716.0 6397.7 6403.5 6412.5 6415.2 6426.1 6494.9 6550.3 6558.7 6568.9 6571.8 6270.1 6331.6 6356.3 6369.0 6442.1 6312.2 6323.7 6328.5 6346.6 6436.2 5126.7 5181.4 5198.2 5210.7 5217.7 4585.2 4604.8 4606.4 4623.1 4631.2 5909.3 5956.3 6028.0 6136.8 6148.9 6560.2 6561.2 6587.3 6590.6 6596.7 6137.4 6143.9 6205.0 6208.9 6211.2 5596.7 5652.5 5731.7 5752.7 5756.8 6567.2 6665.2 6711.8 6775.4 6791.8 6560.9 6571.8 6573.1 6576.5 6587.3 6713.8 6755.6 6776.5 6810.8 6812.6 6287.3 6386.5 6391.2 6474.9 6493.3 6524.0 6539.1 6545.6 6551.8 6564.8 6220.1 6231.2 6259.2 6297.5 6350.7 6348.0 6348.6 6358.2 6368.6 6371.2 5137.5 6137.4 6213.3 6292.7 6356.0 5278.0 5343.9 6379.7 6404.4 6408.7 6336.8 6346.6 6351.6 6357.9 6377.1 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:56196.62 Median:35845.23 stddev:113176.47 (315.7%) stddev-sans-first:113417.28 02:26:31 INFO - PROCESS | 1634 | Values: 709.8 785.0 862.7 875.2 951.1 36911.0 37508.2 38516.2 38552.8 38597.6 37246.6 37449.4 37563.1 37602.6 37683.6 7297.0 7437.1 7716.0 7850.5 10931.9 11000.0 11105.4 11114.1 11122.0 11130.3 11085.3 11115.9 11131.8 11157.2 11157.9 7343.2 7507.4 10889.0 11063.0 11111.9 10830.1 10905.3 10907.8 10922.5 10935.8 37835.4 37917.0 37931.1 37984.8 37990.1 3666.0 3802.3 3819.6 3836.2 3893.3 21574.8 24811.4 24852.3 25264.0 25644.5 2816.0 2865.8 3184.6 3226.6 3255.3 333506.0 333649.0 333795.0 335295.0 336013.0 36435.5 37110.4 38399.8 43652.0 51802.7 52713.5 52918.7 55074.7 55573.0 55622.0 15303.7 15388.2 15393.0 15393.8 15405.3 12884.7 12915.3 12922.0 12925.0 13028.3 13653.7 13664.5 13669.0 13753.9 13766.7 5931.9 5949.7 5996.9 6000.0 6003.6 921.0 944.3 954.0 956.4 978.6 26381.6 27093.9 27698.3 27811.0 27841.2 1022.8 1031.3 1035.1 1040.8 1051.6 13907.8 14468.9 14539.8 14561.9 14725.3 480946.0 482485.0 482688.0 484026.0 486027.0 56411.4 56769.0 56820.1 56825.4 56851.0 1422.6 1458.3 1458.8 1459.7 1460.7 26466.6 26993.0 27616.0 27781.9 27991.7 45508.5 45533.1 45546.8 45646.3 45738.1 446211.0 447489.0 448162.0 448316.0 448502.0 27243.9 31089.0 34885.8 35094.6 36283.1 43090.8 43643.0 44157.2 44430.6 44604.9 34598.8 35974.8 36442.5 37144.0 37411.0 34443.1 35778.0 35912.5 35992.8 37040.4 36105.3 36773.3 36851.3 36946.8 37020.3 30364.4 31961.5 32386.0 32483.0 32545.3 24196.9 24493.6 24572.1 24739.4 24851.5 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:40205.11 Median:23079.19 stddev:116557.36 (505.0%) stddev-sans-first:116845.96 02:26:31 INFO - PROCESS | 1634 | Values: 373.2 373.4 388.2 425.0 438.7 13046.5 14386.5 17653.8 21203.0 21696.6 22116.8 22338.4 22738.4 22901.8 23065.5 6647.7 6709.3 6799.3 6865.2 6918.7 3727.4 6755.9 6879.5 6880.7 6881.1 4325.9 4401.8 7710.7 7787.5 7823.8 7509.8 7732.6 7775.0 7789.5 7815.0 7337.3 7582.9 7647.2 7654.5 7658.1 27452.7 27459.6 27526.6 27634.7 27972.9 2941.2 2961.9 2966.2 2969.1 3017.9 16101.4 16186.6 16218.4 16363.6 16919.0 1977.8 2036.4 2039.4 2041.9 2048.3 83926.6 132419.3 134199.0 136322.6 138696.3 22203.0 22457.7 22740.2 22845.8 22894.4 31103.0 38465.8 39415.8 39446.6 39460.8 11091.7 11097.3 11111.8 11256.3 11333.9 8974.8 8982.9 9004.4 9161.1 9205.0 8819.6 10692.1 10876.8 10956.6 11005.7 4254.6 4321.5 4354.7 4363.9 4367.7 892.2 935.2 944.4 953.5 977.2 21687.0 22961.0 23042.2 23092.8 23173.5 950.5 976.7 982.0 987.6 997.0 9172.5 12086.7 12144.5 12200.4 12248.3 690707.0 701014.0 703998.0 713588.4 720058.0 86797.0 115718.8 121947.0 127138.0 131032.0 1245.8 1263.4 1292.5 1293.9 1297.2 19920.1 21434.9 21472.2 21525.7 21549.0 56861.7 57323.0 57451.4 57469.4 58735.7 78818.2 78870.0 79982.6 82088.0 82124.6 11976.0 12274.7 12620.1 12623.2 12685.0 13334.3 13421.0 13437.7 13843.9 13915.9 7032.9 9854.0 11477.3 11656.9 11805.9 11367.0 11437.5 11566.7 11618.1 11702.4 11702.8 11810.6 11907.5 11965.4 12141.1 12253.2 12292.5 12355.9 12375.4 12630.8 9643.8 11734.5 11787.3 11790.9 12027.5 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:6672.03 Median:2424.18 stddev:4144.62 (171.0%) stddev-sans-first:4138.02 02:26:31 INFO - PROCESS | 1634 | Values: 1499.8 1525.1 1558.5 1568.6 1572.2 10623.6 11131.7 11148.8 11161.6 11164.6 10566.5 11045.0 11154.5 11159.4 11159.8 2400.6 2441.2 2443.7 2445.8 2450.1 2371.2 2397.6 2399.3 2401.3 2407.2 2366.7 2387.3 2395.0 2397.2 2398.1 2298.5 2318.2 2324.0 2326.1 2327.2 2339.5 2340.2 2399.3 2399.9 2406.0 11050.4 11185.4 11188.7 11216.6 11242.7 5765.3 5962.4 5976.8 5981.6 5990.9 3494.7 3531.6 3605.4 3611.7 3686.9 1159.7 1169.6 1206.4 1228.8 1236.5 13720.5 14073.4 14381.8 15346.4 15505.6 4619.9 4775.3 4800.4 4808.9 4812.6 9920.8 11302.6 11338.4 11360.5 11381.3 4459.5 5169.1 5951.9 5973.1 5985.8 5038.5 5168.9 5218.3 5288.2 5314.8 4052.5 4087.7 4143.5 4186.2 4186.4 1117.7 1130.0 1141.3 1145.5 1154.7 910.3 922.5 923.9 936.3 979.1 5560.5 6041.2 6283.7 6378.0 6462.4 836.5 953.7 967.8 986.4 1021.5 4006.5 4024.6 4058.1 4096.0 4100.4 11139.4 13320.1 13586.9 13776.4 13778.4 13358.5 13483.8 13626.5 13730.7 13792.5 10036.4 10125.0 10144.5 10269.5 10278.4 6368.1 6375.5 6466.3 6508.2 6569.4 12083.3 12122.2 12132.9 12233.8 12276.8 11509.8 12421.1 12534.6 12546.4 12575.7 8926.7 9002.5 9030.3 9071.5 9155.0 10115.8 10236.8 10344.0 10362.6 10392.3 9023.7 9104.3 9110.3 9127.6 9219.5 8633.1 8830.2 8841.9 8888.1 9044.9 7517.7 7699.6 7827.8 7828.1 7829.9 5171.4 5326.4 5547.8 5625.2 5888.3 5773.3 5784.0 5904.8 5908.9 6075.7 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4515.74 Median:4836.21 stddev:1287.44 (26.6%) stddev-sans-first:1251.89 02:26:31 INFO - PROCESS | 1634 | Values: 317.2 330.0 363.4 380.5 381.7 4620.7 5017.0 5072.7 5302.3 5370.4 4390.7 4853.4 5202.9 5207.8 5259.5 4000.9 4053.7 4083.9 4244.6 4309.9 3332.8 3444.7 3659.4 4246.2 4269.2 3388.0 3593.4 3711.6 3911.8 4247.0 4078.3 4266.6 4272.4 4279.2 4299.2 3398.5 3430.4 3987.0 3988.6 3993.9 4627.5 4787.5 4788.5 4987.2 5081.8 4402.7 4760.7 4815.4 4938.4 4972.7 4558.5 5584.8 5597.4 5598.8 5614.6 3887.5 4179.4 4217.1 4373.8 4379.4 5270.5 5603.5 5810.9 5818.6 5899.7 3962.3 4079.0 4297.3 4513.9 4590.3 3848.8 4119.8 4319.0 4324.9 4444.5 4237.9 4316.3 4751.2 4771.2 4785.4 4688.7 4718.7 4895.4 4952.8 5353.4 1402.4 1498.8 1538.8 1563.5 1570.0 1020.8 1145.8 1154.3 1157.1 1185.8 4840.8 4914.2 4945.0 4973.9 5262.6 4905.4 4935.8 5156.6 5674.9 5675.6 4458.9 4547.7 4806.5 4978.5 5230.6 2703.9 2705.3 2713.5 2782.8 2830.2 5361.0 5623.2 5892.1 5934.4 5966.3 4911.4 5055.9 5452.6 5571.0 5874.2 5466.2 5886.8 5916.4 5940.3 5957.7 5311.0 5431.3 5466.6 5474.5 5631.5 5071.0 5092.0 5461.2 5545.4 5804.6 5083.3 5309.8 6004.6 6006.2 6066.2 4140.9 4437.4 4511.2 4513.7 4515.9 4795.0 5300.1 5352.5 5575.6 5755.5 4559.5 5022.6 5057.6 5377.2 5390.7 5019.7 5315.6 5529.8 5538.7 5556.2 4238.5 4751.8 5245.3 5358.8 5412.6 4777.0 4992.0 5272.4 5540.8 5557.3 4364.7 4831.7 5363.3 5446.2 5477.6 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:19186.40 Median:3634.93 stddev:26689.59 (734.3%) stddev-sans-first:26727.99 02:26:31 INFO - PROCESS | 1634 | Values: 605.2 721.1 738.6 755.9 851.9 12192.8 15422.8 15435.3 15436.7 15448.5 11975.6 13937.4 13991.3 14080.9 14136.9 912.1 923.8 925.0 926.4 926.7 900.4 901.6 904.5 925.5 960.4 979.1 986.9 994.0 994.6 996.7 986.8 988.3 989.8 991.0 991.3 733.1 733.9 734.3 734.3 734.5 15436.8 15579.5 15609.6 15699.1 15716.1 13829.9 14111.4 14238.6 14291.9 14322.4 11601.4 11690.4 11855.3 11869.2 11958.0 3594.4 3598.9 3670.9 3737.6 3832.1 105292.0 106913.2 110394.4 111745.4 111746.0 10368.8 10592.8 10661.0 10691.6 10848.4 21918.1 21941.9 22186.7 22276.7 22319.3 7165.5 7420.2 7649.4 7724.3 7868.0 4218.3 4255.2 4298.3 4375.6 4471.3 3149.5 3337.5 3409.9 3425.1 3435.2 576.9 616.4 624.6 640.7 640.7 571.9 674.6 692.1 694.9 706.5 10101.7 10128.8 10233.1 10240.5 10562.7 640.4 693.4 695.5 696.6 708.8 4956.9 4959.9 4969.0 4969.7 4973.3 74380.0 75105.0 78581.6 87752.6 93769.5 75276.2 76246.0 76293.6 78206.8 79478.0 70826.6 71611.0 72978.6 73483.0 73966.3 9904.4 10565.5 10744.9 10844.0 11191.1 44463.8 44748.6 50430.0 51020.5 51078.7 48523.1 59013.0 60273.8 61290.0 61927.7 11947.7 12033.7 12156.5 12339.7 12356.5 13688.2 13697.7 13977.6 14637.2 15126.9 13034.6 13523.3 13695.7 13978.0 14014.4 13047.2 13119.9 13568.2 13570.9 13878.6 12800.6 13204.8 13360.9 13503.7 14021.2 10393.2 10583.6 11201.6 11327.8 11529.2 10239.2 10366.8 10558.3 11040.8 11235.4 02:26:31 INFO - PROCESS | 1634 | -------- Summary: end -------- 02:26:31 INFO - PROCESS | 1634 | 02:26:31 INFO - TEST-INFO | 1634: exit 0 02:26:31 INFO - TEST-OK | dromaeo_css | took 1121084ms 02:26:31 INFO - TEST-START | kraken 02:26:31 INFO - operating with platform_type : mac_ 02:26:31 INFO - Initialising browser for kraken test... 02:26:31 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpF1nC9p/profile http://localhost:49240/getInfo.html) 02:26:34 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 02:26:34 INFO - PROCESS | 1643 | colorDepth:24 02:26:34 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 02:26:34 INFO - PROCESS | 1643 | __metrics 02:26:34 INFO - PROCESS | 1643 | 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:26:34 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:34 INFO - TEST-INFO | 1643: exit 0 02:26:34 INFO - Browser initialized. 02:26:34 INFO - Running cycle 1/1 for kraken test... 02:26:34 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/T/tmpF1nC9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:47 INFO - PROCESS | 1645 | RSS: Main: 214544384 02:26:47 INFO - PROCESS | 1645 | 02:26:49 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:50 INFO - PROCESS | 1645 | RSS: Main: 267907072 02:26:50 INFO - PROCESS | 1645 | 02:26:53 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 02:26:54 INFO - PROCESS | 1645 | RSS: Main: 279158784 02:26:54 INFO - PROCESS | 1645 | 02:26:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 02:26:57 INFO - PROCESS | 1645 | RSS: Main: 377835520 02:26:57 INFO - PROCESS | 1645 | 02:26:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 02:27:00 INFO - PROCESS | 1645 | RSS: Main: 279433216 02:27:00 INFO - PROCESS | 1645 | 02:27:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:03 INFO - PROCESS | 1645 | RSS: Main: 280383488 02:27:03 INFO - PROCESS | 1645 | 02:27:05 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:06 INFO - PROCESS | 1645 | RSS: Main: 320991232 02:27:06 INFO - PROCESS | 1645 | 02:27:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:10 INFO - PROCESS | 1645 | RSS: Main: 321515520 02:27:10 INFO - PROCESS | 1645 | 02:27:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 02:27:13 INFO - PROCESS | 1645 | RSS: Main: 316211200 02:27:13 INFO - PROCESS | 1645 | 02:27:15 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:16 INFO - PROCESS | 1645 | RSS: Main: 296357888 02:27:16 INFO - PROCESS | 1645 | 02:27:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:18 INFO - PROCESS | 1645 | RSS: Main: 298840064 02:27:18 INFO - PROCESS | 1645 | 02:27:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:21 INFO - PROCESS | 1645 | RSS: Main: 302632960 02:27:21 INFO - PROCESS | 1645 | 02:27:24 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:24 INFO - PROCESS | 1645 | RSS: Main: 320012288 02:27:24 INFO - PROCESS | 1645 | 02:27:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:28 INFO - PROCESS | 1645 | RSS: Main: 313278464 02:27:28 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 02:27:30 INFO - PROCESS | 1645 | RSS: Main: 357859328 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | __start_tp_report 02:27:30 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 02:27:30 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 02:27:30 INFO - PROCESS | 1645 | |i|pagename|runs| 02:27:30 INFO - PROCESS | 1645 | |0;ai-astar;117;116;115;115;115;114;115;113;114;115 02:27:30 INFO - PROCESS | 1645 | |1;audio-beat-detection;137;108;111;147;140;134;105;107;127;110 02:27:30 INFO - PROCESS | 1645 | |2;audio-dft;181;185;184;187;185;185;184;186;187;187 02:27:30 INFO - PROCESS | 1645 | |3;audio-fft;80;59;61;92;62;63;61;76;97;76 02:27:30 INFO - PROCESS | 1645 | |4;audio-oscillator;88;69;86;69;70;68;82;68;67;84 02:27:30 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;90;88;88;88;88;88;88;88;88;88 02:27:30 INFO - PROCESS | 1645 | |6;imaging-darkroom;111;152;95;95;95;97;96;94;93;96 02:27:30 INFO - PROCESS | 1645 | |7;imaging-desaturate;84;86;86;84;97;136;86;85;85;84 02:27:30 INFO - PROCESS | 1645 | |8;json-parse-financial;63;62;60;63;63;64;65;63;65;65 02:27:30 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;60;54;60;64;61;57;58;58;57;57 02:27:30 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;84;86;82;81;81;82;82;82;83;85 02:27:30 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;152;134;136;135;135;140;139;138;176;151 02:27:30 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;167;166;166;165;168;166;166;162;166;165 02:27:30 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;65;66;67;64;64;65;64;64;65;66 02:27:30 INFO - PROCESS | 1645 | __end_tp_report 02:27:30 INFO - PROCESS | 1645 | __start_cc_report 02:27:30 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2183 02:27:30 INFO - PROCESS | 1645 | __end_cc_report 02:27:30 INFO - PROCESS | 1645 | __startTimestamp1490088450393__endTimestamp 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | ------- Summary: start ------- 02:27:30 INFO - PROCESS | 1645 | Number of tests: 14 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:0.87 02:27:30 INFO - PROCESS | 1645 | Values: 117.0 116.0 115.0 115.0 115.0 114.0 115.0 113.0 114.0 115.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:130.50 stddev:16.04 (12.3%) stddev-sans-first:16.14 02:27:30 INFO - PROCESS | 1645 | Values: 137.0 108.0 111.0 147.0 140.0 134.0 105.0 107.0 127.0 110.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.50 stddev:1.85 (1.0%) stddev-sans-first:1.24 02:27:30 INFO - PROCESS | 1645 | Values: 181.0 185.0 184.0 187.0 185.0 185.0 184.0 186.0 187.0 187.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:72.70 Median:76.00 stddev:13.78 (18.1%) stddev-sans-first:14.36 02:27:30 INFO - PROCESS | 1645 | Values: 80.0 59.0 61.0 92.0 62.0 63.0 61.0 76.0 97.0 76.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.69 (11.4%) stddev-sans-first:7.86 02:27:30 INFO - PROCESS | 1645 | Values: 88.0 69.0 86.0 69.0 70.0 68.0 82.0 68.0 67.0 84.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:0.63 (0.7%) stddev-sans-first:0.00 02:27:30 INFO - PROCESS | 1645 | Values: 90.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:95.00 stddev:18.16 (19.1%) stddev-sans-first:18.99 02:27:30 INFO - PROCESS | 1645 | Values: 111.0 152.0 95.0 95.0 95.0 97.0 96.0 94.0 93.0 96.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:85.50 stddev:16.17 (18.9%) stddev-sans-first:16.94 02:27:30 INFO - PROCESS | 1645 | Values: 84.0 86.0 86.0 84.0 97.0 136.0 86.0 85.0 85.0 84.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:1.57 (2.5%) stddev-sans-first:1.66 02:27:30 INFO - PROCESS | 1645 | Values: 63.0 62.0 60.0 63.0 63.0 64.0 65.0 63.0 65.0 65.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:2.76 (4.7%) stddev-sans-first:2.88 02:27:30 INFO - PROCESS | 1645 | Values: 60.0 54.0 60.0 64.0 61.0 57.0 58.0 58.0 57.0 57.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.69 (2.0%) stddev-sans-first:1.73 02:27:30 INFO - PROCESS | 1645 | Values: 84.0 86.0 82.0 81.0 81.0 82.0 82.0 82.0 83.0 85.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:139.50 stddev:13.07 (9.4%) stddev-sans-first:13.51 02:27:30 INFO - PROCESS | 1645 | Values: 152.0 134.0 136.0 135.0 135.0 140.0 139.0 138.0 176.0 151.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:1.57 (0.9%) stddev-sans-first:1.59 02:27:30 INFO - PROCESS | 1645 | Values: 167.0 166.0 166.0 165.0 168.0 166.0 166.0 162.0 166.0 165.0 02:27:30 INFO - PROCESS | 1645 | 02:27:30 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 02:27:30 INFO - PROCESS | 1645 | Values: 65.0 66.0 67.0 64.0 64.0 65.0 64.0 64.0 65.0 66.0 02:27:30 INFO - PROCESS | 1645 | -------- Summary: end -------- 02:27:30 INFO - PROCESS | 1645 | 02:27:31 INFO - TEST-INFO | 1645: exit 0 02:27:31 INFO - TEST-OK | kraken | took 59376ms 02:27:31 INFO - SUITE-END | took 1180s 02:27:31 INFO - Completed test suite (00:19:40) 02:27:31 INFO - javascript benchmark 02:27:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7696.664498431456, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.90100296991, 3440.741944354174, 3444.9138771530716, 3454.9999999999986, 3479.2171761353684, 6107.969460152699, 6138.631682099071, 6157.261128664561, 6158.815235542941, 6161.507079433646, 6150.477209437192, 6193.504519638429, 6199.907001394983, 6205.689715514218, 6211.161493198428, 5496.038193316173, 5521.089020311654, 5542.307211598551, 5543.307086614173, 5614.6631202128, 5356.982173387044, 5392.91910621341, 5612.158176273571, 5613.635113717616, 5622.212890195376, 5438.0, 5495.093309603911, 5497.285352904117, 5579.358373787026, 5598.552115830744, 5561.193626924093, 5584.162375643646, 5590.440955904377, 5594.720263986805, 5603.271574695264, 5436.91844622331, 5526.4197259288, 5539.975104605661, 5564.666120032811, 5572.7770889164385, 5915.526757859361, 5967.343592204854, 5971.611845230046, 5979.133025711291, 5985.8802823943715, 6359.42765151134, 6374.808755737336, 6406.519511036691, 6448.0, 6451.29035806061, 6514.57655252407, 6557.245916719543, 6568.80293591193, 6573.079768832367, 6573.276939536647, 6193.504519638418, 6203.131561581382, 6246.406591373903, 6267.310595834455, 6301.4328710416285, 6418.582792118497, 6473.514486413538, 6597.0434287029075, 6662.6668666566475, 6715.966420167965, 6397.7440902364315, 6403.48772098231, 6412.487001039905, 6415.1981002374705, 6426.132472116298, 6494.870102597922, 6550.312217217123, 6558.704858281389, 6568.901466478007, 6571.835704107436, 6270.090836828635, 6331.620102793847, 6356.269029061625, 6368.968155159195, 6442.065900444503, 6312.242530896322, 6323.652199129092, 6328.525360597973, 6346.555741098079, 6436.227652681709, 5126.718030508283, 5181.404138524118, 5198.2202669599865, 5210.713410762369, 5217.660852044605, 4585.243434833215, 4604.838830640979, 4606.447226332862, 4623.052274283764, 4631.212693842055, 5909.261342332208, 5956.344802071769, 6028.0355143176885, 6136.754529818757, 6148.8770224595255, 6560.245571759213, 6561.245456772437, 6587.308332625005, 6590.5716128451495, 6596.670166491656, 6137.447629713347, 6143.877122457526, 6204.968975155095, 6208.906866397007, 6211.192544969215, 5596.748146333425, 5652.463016013472, 5731.656100633975, 5752.741126649311, 5756.798512052058, 6567.179102612269, 6665.233498147775, 6711.765088221889, 6775.390214880685, 6791.762288319885, 6560.9343906560325, 6571.835704107244, 6573.112629794917, 6576.53964222519, 6587.275399705933, 6713.798586042427, 6755.560888542229, 6776.45788336922, 6810.761623343159, 6812.591244525344, 6287.339829318039, 6386.457151142205, 6391.169148010729, 6474.935250647433, 6493.2857385688485, 6524.0, 6539.084528166156, 6545.607263564201, 6551.770688025897, 6564.80305590833, 6220.098085777447, 6231.158793562811, 6259.217597800275, 6297.496200303873, 6350.650714210763, 6348.0, 6348.619082855043, 6358.205224346957, 6368.649724265025, 6371.171747672773, 5137.51193636604, 6137.407629318989, 6213.254409470893, 6292.653904035139, 6356.014817703263, 5278.0, 5343.866403339792, 6379.74481020754, 6404.359564043559, 6408.711607977559, 6336.809895703136, 6346.555741098079, 6351.587146835441, 6357.936420635734, 6377.0753240778895], "value": 5989.787696182019, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8473828126952, 784.9686012559497, 862.7196161247596, 875.1598465473149, 951.1439704266155, 36911.0, 37508.249835003284, 38516.229675406474, 38552.80723596382, 38597.614023859824, 37246.627533724655, 37449.43825842615, 37563.06092347693, 37602.62397376025, 37683.62316376835, 7297.0, 7437.107547094329, 7715.961420192905, 7850.450468467209, 10931.890681093206, 11000.009999100079, 11105.389203593799, 11114.11087113029, 11121.999020088191, 11130.276532025433, 11085.334879907192, 11115.944420277887, 11131.777364452746, 11157.163212759035, 11157.944210278938, 7343.155537113247, 7507.399408047398, 10889.0, 11063.0, 11111.888881111207, 10830.133589312914, 10905.34567925927, 10907.781844363068, 10922.453877306103, 10935.781284374347, 37835.432468513, 37917.0, 37931.051723707125, 37984.81007594972, 37990.050248743726, 3665.981670091659, 3802.296575133609, 3819.6371344722484, 3836.1943991761764, 3893.3186692329014, 21574.813385263806, 24811.379715507257, 24852.254432366877, 25264.0, 25644.487110257876, 2816.0, 2865.8423786691724, 3184.5860038194887, 3226.6274108635257, 3255.283837555734, 333506.0, 333649.0, 333795.0, 335295.0, 336013.0, 36435.453468198, 37110.44334334987, 38399.848004559906, 43652.0, 51802.74098629558, 52713.47286527162, 52918.735406322725, 55074.724626377414, 55573.0, 55622.0, 15303.693926121416, 15388.153651549272, 15392.999455035388, 15393.846061539465, 15405.306761195548, 12884.742305154032, 12915.289659068842, 12922.030847686461, 12925.0, 13028.348582570834, 13653.658658533615, 13664.453421863212, 13669.0, 13753.862461375458, 13766.724665506634, 5931.911021334683, 5949.702514874239, 5996.850078748066, 6000.049983755297, 6003.6397816131175, 920.9723708288763, 944.3342443577261, 953.9761505962267, 956.4213650741341, 978.5792109393029, 26381.604275935875, 27093.86453067722, 27698.3075423112, 27811.02661406841, 27841.16476505708, 1022.7852151048214, 1031.3244824639874, 1035.0787798858871, 1040.7918416316616, 1051.558345494894, 13907.79138312926, 14468.855311446961, 14539.78190327146, 14561.87751114126, 14725.337359818619, 480946.0, 482485.0, 482688.0, 484026.0, 486027.0, 56411.35886411326, 56769.0, 56820.14769778457, 56825.43174568284, 56851.0, 1422.587449639593, 1458.2708645677162, 1458.7884756710218, 1459.6715738958649, 1460.7370673278913, 26466.603000954616, 26993.0, 27616.0, 27781.861090694416, 27991.72008279891, 45508.54491455043, 45533.089338213715, 45546.772266138454, 45646.31530526978, 45738.08523829572, 446211.0, 447489.0, 448162.0, 448316.0, 448502.0, 27243.910243590035, 31089.0, 34885.825570873, 35094.64905351016, 36283.09292267715, 43090.78454607707, 43643.0, 44157.23371065121, 44430.55569444264, 44604.884877878314, 34598.751081179646, 35974.820125899205, 36442.453363200104, 37144.0, 37411.0, 34443.13892152716, 35778.0, 35912.4613130798, 35992.820035899655, 37040.44439333466, 36105.277894442486, 36773.26453470969, 36851.26297473982, 36946.8152659235, 37020.25959480849, 30364.392712146077, 31961.520577190895, 32386.0, 32483.02550923476, 32545.34909301848, 24196.87901560481, 24493.632595511437, 24572.139975100785, 24739.381515461537, 24851.50296994014], "value": 18838.4161708189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2367308853393, 373.4211971444262, 388.2468012056612, 424.97025208235425, 438.7255024154831, 13046.543370982017, 14386.496472623461, 17653.82346176538, 21203.045862936167, 21696.566068678618, 22116.778832211672, 22338.441538961535, 22738.431539211488, 22901.77098229017, 23065.538689226207, 6647.667616619174, 6709.295523969986, 6799.320067993186, 6865.210500792423, 6918.723251069951, 3727.422249551324, 6755.864882702343, 6879.5184337096425, 6880.69036893341, 6881.071055407531, 4325.870223893273, 4401.80191891364, 7710.653020614086, 7787.532748035108, 7823.843523129534, 7509.849803003964, 7732.613369331567, 7775.0, 7789.454738168302, 7815.0231221097365, 7337.339639432476, 7582.924170758332, 7647.158812530617, 7654.464187506876, 7658.119316278588, 27452.725472745216, 27459.588106178424, 27526.587101193498, 27634.723652763416, 27972.860135699193, 2941.1764705882174, 2961.896333628334, 2966.16947254769, 2969.109267219847, 3017.8792848286043, 16101.355945762156, 16186.595335116715, 16218.351265949348, 16363.59091022722, 16919.0, 1977.831884289837, 2036.3992622176493, 2039.377989713137, 2041.8979051047388, 2048.272863133596, 83926.58036709839, 132419.33790330988, 134199.0, 136322.636773632, 138696.30651846778, 22203.0, 22457.663135052986, 22740.20409285667, 22845.771542284696, 22894.42763930882, 31103.0, 38465.80767096203, 39415.80292098521, 39446.605533944865, 39460.81617551478, 11091.667249982513, 11097.278676886139, 11111.777764444665, 11256.26834255787, 11333.943330283295, 8974.820503589892, 8982.910170898338, 9004.36969412135, 9161.083891610786, 9204.953975230215, 8819.647214111492, 10692.144628429707, 10876.836847447295, 10956.616518421817, 11005.724856878482, 4254.574542545721, 4321.481422229353, 4354.673399495051, 4363.934540981888, 4367.672424568106, 892.1881088209698, 935.1723724503727, 944.3955868244329, 953.4946478366477, 977.237754551451, 21687.0, 22960.966756495996, 23042.193523226608, 23092.845357732047, 23173.53652926966, 950.4629884115452, 976.6814800019916, 982.0, 987.629638885418, 996.960121595128, 9172.49551274673, 12086.697832554257, 12144.514219431123, 12200.389980500939, 12248.326342051094, 690707.0, 701014.0, 703998.0, 713588.4320578364, 720058.0, 86797.0, 115718.8428115725, 121947.0, 127138.0, 131032.0, 1245.8068999305121, 1263.4314558448734, 1292.5346875124947, 1293.8512071111943, 1297.1503665099376, 19920.103595337954, 21434.89282553577, 21472.24847130343, 21525.677114843602, 21549.0, 56861.715691421276, 57323.0, 57451.42548574461, 57469.42530574641, 58735.70632146812, 78818.21181788338, 78870.0, 79982.6000869992, 82088.0, 82124.58937705273, 11976.0, 12274.693132671755, 12620.116591838483, 12623.242605443702, 12685.0, 13334.26661533625, 13420.993425493323, 13437.731245374842, 13843.930780346034, 13915.860841391457, 7032.8593428130125, 9854.0, 11477.253978491372, 11656.941715291368, 11805.940970295094, 11367.0, 11437.542498299976, 11566.710832229262, 11618.070554355461, 11702.414879256174, 11702.824457633313, 11810.586629467927, 11907.464164112462, 11965.401729913643, 12141.089418293486, 12253.203541769757, 12292.508299667914, 12355.93822030884, 12375.381230938237, 12630.810537841757, 9643.758906027124, 11734.530618775494, 11787.292762434281, 11790.882091178979, 12027.45876435545], "value": 11702.35894681908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.7525408307629, 1525.0925699208967, 1558.4856997190927, 1568.6000069982153, 1572.1824651181387, 10623.57505699772, 11131.666050018492, 11148.777024459507, 11161.609343672973, 11164.553417863275, 10566.471676416188, 11045.005949464547, 11154.498047587858, 11159.442027898593, 11159.776804463905, 2400.6159014557675, 2441.1944058460667, 2443.657887895687, 2445.76765207305, 2450.13020377766, 2371.193794110011, 2397.6043952747777, 2399.30420178149, 2401.327628264089, 2407.169526513359, 2366.7041619797524, 2387.3050134404593, 2394.95210095798, 2397.244867866625, 2398.136670798511, 2298.5402919416015, 2318.1770471482632, 2323.9767602323927, 2326.069572171128, 2327.1505900346338, 2339.4736184358385, 2340.1926335414255, 2399.3042017814814, 2399.928002159938, 2406.0135344508844, 11050.392228427434, 11185.440727963569, 11188.66434006981, 11216.607418740386, 11242.66272011841, 5765.279340082489, 5962.433568810956, 5976.820695379146, 5981.58128930975, 5990.9101363479585, 3494.668006539375, 3531.6291789362003, 3605.369060414417, 3611.6749492545796, 3686.870959516404, 1159.7100724818795, 1169.5672601137549, 1206.3968015992004, 1228.766534358469, 1236.536298887917, 13720.519781807589, 14073.366698498592, 14381.784273235806, 15346.386144554315, 15505.612359690986, 4619.86140415788, 4775.307580400822, 4800.35195248644, 4808.927866082012, 4812.614990800727, 9920.801583968425, 11302.604408845651, 11338.376389298668, 11360.54557817678, 11381.260218085798, 4459.464864216315, 5169.095408303532, 5951.940480595139, 5973.133895585116, 5985.820425387245, 5038.546530812245, 5168.9224661630105, 5218.347706536683, 5288.206768984606, 5314.7608357624, 4052.452918855976, 4087.7138600297694, 4143.461350024538, 4186.162767446523, 4186.434831297735, 1117.742919128605, 1129.9604513841975, 1141.2809929744208, 1145.478807142748, 1154.7344110854383, 910.2899738204211, 922.5387306346827, 923.8660394242797, 936.3352020065694, 979.0992287095889, 5560.499555039985, 6041.24484439445, 6283.717232724447, 6377.9795232762535, 6462.418382345518, 836.4813815434348, 953.6614501851743, 967.7870868409079, 986.4180133720996, 1021.5096753558186, 4006.4791577095375, 4024.5975402460103, 4058.1072164123843, 4095.9795201023803, 4100.446439730598, 11139.387333696563, 13320.134191277535, 13586.932065339808, 13776.380062896993, 13778.448862045407, 13358.532451364155, 13483.797743033861, 13626.454941802216, 13730.725385492235, 13792.517261895786, 10036.397816131055, 10125.0, 10144.492775361203, 10269.486525673687, 10278.434686092336, 6368.108464814837, 6375.489960803217, 6466.321036291121, 6508.219013718384, 6569.408753212234, 12083.275003499819, 12122.151449398458, 12132.939335303266, 12233.755324893631, 12276.754464910831, 11509.827352589551, 12421.068419868365, 12534.623961281177, 12546.435410406371, 12575.748485030432, 8926.73219803407, 9002.549872506479, 9030.277577793891, 9071.455712657262, 9154.954225228832, 10115.848262276219, 10236.846447303147, 10343.965603439596, 10362.637307694195, 10392.272540922062, 9023.729288121367, 9104.271658267191, 9110.316726245426, 9127.589258483516, 9219.49292788903, 8633.05036446003, 8830.249428798625, 8841.911580884365, 8888.11118888132, 9044.909550904407, 7517.661705223169, 7699.576523291273, 7827.765167044998, 7828.060632724109, 7829.921700783148, 5171.3535808024, 5326.36083669962, 5547.750351234285, 5625.184348269396, 5888.263967004124, 5773.3072031356505, 5783.971080144573, 5904.793332233523, 5908.881822363614, 6075.696215189311], "value": 5108.628890857904, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.1943264109163, 330.03300330032994, 363.37499500858513, 380.5159876481722, 381.68320294155853, 4620.676552641312, 5017.0, 5072.706459852737, 5302.269331294387, 5370.355557333126, 4390.748636638558, 4853.369062021932, 5202.8699282517955, 5207.791688332462, 5259.474052594748, 4000.879094532636, 4053.695972802037, 4083.9183216335655, 4244.575542445747, 4309.870703878889, 3332.8166950817817, 3444.7416443766692, 3659.359612067891, 4246.150769846027, 4269.167512335081, 3388.0344101930955, 3593.4430163324596, 3711.6288371162937, 3911.823967921436, 4247.0, 4078.3066878630702, 4266.5867306155105, 4272.380504826814, 4279.154362349034, 4299.1831552005015, 3398.5411969384063, 3430.4168291390524, 3987.003249187703, 3988.6210809973004, 3993.8617494014065, 4627.537246275346, 4787.54518320759, 4788.521147885219, 4987.1771157759285, 5081.771320290559, 4402.723210269018, 4760.738159401231, 4815.398075240595, 4938.407391113054, 4972.726500042496, 4558.492828944068, 5584.832455026356, 5597.356304025007, 5598.768270980378, 5614.606977511576, 3887.5140607424073, 4179.352200408942, 4217.123380095859, 4373.825046998117, 4379.4087798147475, 5270.49930256625, 5603.495685388335, 5810.912836307459, 5818.599540505453, 5899.73451194693, 3962.32640451124, 4079.0006448420327, 4297.312430011183, 4513.909721805611, 4590.334401511829, 3848.846046158122, 4119.7940102994735, 4319.0, 4324.891877703082, 4444.466664000276, 4237.936430953539, 4316.287812510964, 4751.239801631722, 4771.212749896228, 4785.377900872864, 4688.718676879398, 4718.7023568518935, 4895.437024742129, 4952.777125029383, 5353.38436079848, 1402.4039783092146, 1498.8271972226482, 1538.7614919687467, 1563.4684207369548, 1569.9764503532456, 1020.831148335167, 1145.840091427665, 1154.3016475032484, 1157.1370094148415, 1185.8221266810046, 4840.757962101951, 4914.181752751505, 4944.9835600283795, 4973.925391119136, 5262.60530460217, 4905.400137926905, 4935.777889994959, 5156.576409087723, 5674.858128546737, 5675.581104723819, 4458.907567645948, 4547.727136371828, 4806.49531799163, 4978.5270399312, 5230.613887319863, 2703.9324016899736, 2705.3236690827293, 2713.4980028694754, 2782.763465105448, 2830.1745374233915, 5360.969646577882, 5623.156526520973, 5892.140647875648, 5934.406559344117, 5966.343702192756, 4911.435184953704, 5055.890627264206, 5452.6455780374945, 5570.972145139248, 5874.236349274567, 5466.180072989084, 5886.793962211388, 5916.3787802281, 5940.257467816523, 5957.672328022, 5311.0, 5431.321084864392, 5466.590005749665, 5474.525474525474, 5631.549476041825, 5071.030390217534, 5092.0, 5461.194149148724, 5545.425024354843, 5804.564657650609, 5083.293479993659, 5309.761060752198, 6004.609700369462, 6006.159137720635, 6066.2095436098125, 4140.855070072533, 4437.378766972562, 4511.195521791178, 4513.729176249435, 4515.864524064284, 4795.034036045205, 5300.1254792958725, 5352.5450336721815, 5575.609707320611, 5755.453231942959, 4559.544045595414, 5022.573081288131, 5057.583876514582, 5377.220303056113, 5390.730463476732, 5019.7239151847, 5315.6279060465395, 5529.778808847762, 5538.723063846872, 5556.249531566257, 4238.470191226097, 4751.842138129137, 5245.265662807286, 5358.776107915171, 5412.646838290428, 4776.952230477651, 4992.0, 5272.446393128666, 5540.833774986757, 5557.277553917965, 4364.650827933821, 4831.661783675109, 5363.329583802025, 5446.183072539151, 5477.616566840283], "value": 4138.271335900359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2343785111836, 721.0842230367437, 738.5716284554957, 755.8601658693138, 851.9062903080662, 12192.81710774339, 15422.768658470131, 15435.305411256493, 15436.691266174685, 15448.536543903687, 11975.64073077809, 13937.44250229992, 13991.30043497826, 14080.929595352009, 14136.858631413683, 912.1061359867334, 923.8290916180495, 925.0240995749482, 926.393212445849, 926.7451450851037, 900.4192295969096, 901.6078006067349, 904.5251243097393, 925.4909799610222, 960.4141473701071, 979.1041197304457, 986.8569057486696, 994.0258546624312, 994.5872462927877, 996.6710985374809, 986.8273052215869, 988.2834944665132, 989.806987637411, 991.0337421014525, 991.3209451525692, 733.1422235983912, 733.9449541284372, 734.2840730287927, 734.2950767263434, 734.5262305812774, 15436.845631543652, 15579.532614021597, 15609.609759756097, 15699.058056516646, 15716.135612541306, 13829.861701382957, 14111.435542578387, 14238.572842814732, 14291.928540357336, 14322.355494002795, 11601.35514971817, 11690.41547922609, 11855.347955862424, 11869.169158158933, 11958.043356531543, 3594.4248920172645, 3598.946015809765, 3670.9082272943124, 3737.626237376268, 3832.1186127190904, 105292.0, 106913.19291794852, 110394.44802776015, 111745.44127279393, 111746.0, 10368.844467332845, 10592.788144237073, 10660.987206215397, 10691.62579309736, 10848.403337816339, 21918.123275069138, 21941.890290548763, 22186.667199992015, 22276.66585001226, 22319.330420087423, 7165.534240274365, 7420.220876807965, 7649.388048956182, 7724.343430808444, 7868.0, 4218.282891908383, 4255.212785634668, 4298.26929421999, 4375.649948004152, 4471.329300604935, 3149.4803357445767, 3337.5494308268558, 3409.9488507672404, 3425.0581090200394, 3435.1927297085167, 576.9336526299529, 616.3897741236144, 624.5669603088173, 640.6540468147149, 640.695669556966, 571.865611581278, 674.5952428542934, 692.1210063219683, 694.944404447643, 706.4948561778353, 10101.683116624847, 10128.848067278997, 10233.079022887976, 10240.53917573696, 10562.683119506428, 640.4492136762381, 693.3551796828897, 695.5270416117089, 696.6481926627122, 708.8015355700412, 4956.925646115311, 4959.851204463872, 4968.975155124202, 4969.701817890938, 4973.303737476756, 74380.0, 75105.0, 78581.60709196418, 87752.56123719341, 93769.5311523438, 75276.24723752802, 76246.0, 76293.61853190699, 78206.82689759658, 79478.0, 70826.5510939794, 71611.0, 72978.63510682412, 73483.0, 73966.26033739702, 9904.405735655884, 10565.471726413802, 10744.946275268574, 10843.969822866815, 11191.104711622887, 44463.77681115866, 44748.55251447574, 50429.99140017253, 51020.489795101574, 51078.744606276734, 48523.088614683234, 59013.0, 60273.79452411015, 61290.0, 61927.69036154971, 11947.701307467383, 12033.687177731419, 12156.452959617016, 12339.69150771238, 12356.505739770668, 13688.247146407044, 13697.657558560717, 13977.58067257984, 14637.19495427719, 15126.924365378103, 13034.608961731163, 13523.256220907944, 13695.657608559866, 13978.021538492614, 14014.439422422989, 13047.217166970013, 13119.868801311864, 13568.1859088455, 13570.93214533921, 13878.592093053245, 12800.61598152057, 13204.80192797128, 13360.93319533396, 13503.729925401634, 14021.158730476203, 10393.16854651611, 10583.62957296491, 11201.551937922392, 11327.773444531229, 11529.1929564933, 10239.1767175401, 10366.844497332395, 10558.260921735406, 11040.834387484034, 11235.382053987109], "value": 7445.954869396145, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 113.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 108.0, 111.0, 147.0, 140.0, 134.0, 105.0, 107.0, 127.0, 110.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 184.0, 187.0, 185.0, 185.0, 184.0, 186.0, 187.0, 187.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 92.0, 62.0, 63.0, 61.0, 76.0, 97.0, 76.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 86.0, 69.0, 70.0, 68.0, 82.0, 68.0, 67.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 152.0, 95.0, 95.0, 95.0, 97.0, 96.0, 94.0, 93.0, 96.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 84.0, 97.0, 136.0, 86.0, 85.0, 85.0, 84.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 60.0, 63.0, 63.0, 64.0, 65.0, 63.0, 65.0, 65.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 54.0, 60.0, 64.0, 61.0, 57.0, 58.0, 58.0, 57.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 82.0, 81.0, 81.0, 82.0, 82.0, 82.0, 83.0, 85.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 136.0, 135.0, 135.0, 140.0, 139.0, 138.0, 176.0, 151.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 166.0, 165.0, 168.0, 166.0, 166.0, 162.0, 166.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 66.0], "value": 65.0, "unit": "score"}]}]} 02:27:31 INFO - Return code: 0 02:27:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:27:31 ERROR - # TBPL SUCCESS # 02:27:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:31 INFO - 2017-03-21 02:27:31.711 screenresolution[1649:9753] starting screenresolution argv=screenresolution get 02:27:31 INFO - 2017-03-21 02:27:31.713 screenresolution[1649:9753] Display 0: 1600x1200x32@60 02:27:31 INFO - 2017-03-21 02:27:31.720 screenresolution[1650:9756] starting screenresolution argv=screenresolution list 02:27:31 INFO - Available Modes on Display 0 02:27:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:31 INFO - Intel Iris: 02:27:31 INFO - Chipset Model: Intel Iris 02:27:31 INFO - Type: GPU 02:27:31 INFO - Bus: Built-In 02:27:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:31 INFO - Vendor: Intel (0x8086) 02:27:31 INFO - Device ID: 0x0a2e 02:27:31 INFO - Revision ID: 0x0009 02:27:31 INFO - Displays: 02:27:31 INFO - Display: 02:27:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:31 INFO - Display Serial Number: 1600x1200 60 02:27:31 INFO - Main Display: Yes 02:27:31 INFO - Mirror: Off 02:27:31 INFO - Online: Yes 02:27:31 INFO - Rotation: Supported 02:27:31 INFO - Return code: 0 02:27:31 INFO - Running post-action listener: _resource_record_post_action 02:27:31 INFO - [mozharness: 2017-03-21 09:27:31.961243Z] Finished run-tests step (success) 02:27:31 INFO - Running post-run listener: _resource_record_post_run 02:27:32 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 36905984; Write bytes: 507198464; Read time: 416; Write time: 2009 02:27:32 INFO - TinderboxPrint: CPU usage
53.8% 02:27:32 INFO - TinderboxPrint: I/O read bytes / time
36,905,984 / 416 02:27:32 INFO - TinderboxPrint: I/O write bytes / time
507,198,464 / 2,009 02:27:32 INFO - TinderboxPrint: CPU idle
2,222.1 (46.2%) 02:27:32 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 02:27:32 INFO - TinderboxPrint: CPU user
1,627.7 (33.9%) 02:27:32 INFO - TinderboxPrint: Swap in / out
245,297,152 / 0 02:27:32 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202226176; Write bytes: 202487808; Read time: 15668; Write time: 397 02:27:32 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35939328; Write bytes: 294814720; Read time: 400; Write time: 1578 02:27:32 INFO - Running post-run listener: _upload_blobber_files 02:27:32 INFO - Blob upload gear active. 02:27:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:32 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:27:32 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:27:32 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:27:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:33 INFO - (blobuploader) - INFO - Done attempting. 02:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:34 INFO - (blobuploader) - INFO - Done attempting. 02:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:35 INFO - (blobuploader) - INFO - Done attempting. 02:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:37 INFO - (blobuploader) - INFO - Done attempting. 02:27:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:37 INFO - Return code: 0 02:27:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a52afd2cab636a055d1d20f2435a17e4af4a7ab45d702cb0cedbee0e5c0e6817958f2ca38107300d0db35fdb803ab398164091ef83468e9ff9bbb953a037782", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eb7b15ae0fc28df1cb63d4e473a773c037332f8e4d9cdf824a567ff2bb927f3ed48ce523992d04ad3d133c6ca9415262be53075875929fe34ab85c4cf46bbc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33b3d7cf84c658bf3d580132f51e0ae5a3a8eec9f8a02e48eb066b2f19d5c37f9e4fb445ef435186f55a5b982b8fbf37f793e2b60bd0d312c726c62487aaa0f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b57dea161fef7ec1f0f0bedfb297d5db6da4f17a91d029796f38c4b3b3b1c866ab0e05d0d9e3a925e08423b6d71fe974d402010c3a381a86f317102db7128ae"} 02:27:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:37 INFO - Contents: 02:27:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a52afd2cab636a055d1d20f2435a17e4af4a7ab45d702cb0cedbee0e5c0e6817958f2ca38107300d0db35fdb803ab398164091ef83468e9ff9bbb953a037782", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eb7b15ae0fc28df1cb63d4e473a773c037332f8e4d9cdf824a567ff2bb927f3ed48ce523992d04ad3d133c6ca9415262be53075875929fe34ab85c4cf46bbc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33b3d7cf84c658bf3d580132f51e0ae5a3a8eec9f8a02e48eb066b2f19d5c37f9e4fb445ef435186f55a5b982b8fbf37f793e2b60bd0d312c726c62487aaa0f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b57dea161fef7ec1f0f0bedfb297d5db6da4f17a91d029796f38c4b3b3b1c866ab0e05d0d9e3a925e08423b6d71fe974d402010c3a381a86f317102db7128ae"} 02:27:37 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:37 INFO - Copying logs to upload dir... 02:27:37 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.524958 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 02:27:38.210638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 02:27:38.213968) ========= 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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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/0a52afd2cab636a055d1d20f2435a17e4af4a7ab45d702cb0cedbee0e5c0e6817958f2ca38107300d0db35fdb803ab398164091ef83468e9ff9bbb953a037782", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eb7b15ae0fc28df1cb63d4e473a773c037332f8e4d9cdf824a567ff2bb927f3ed48ce523992d04ad3d133c6ca9415262be53075875929fe34ab85c4cf46bbc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33b3d7cf84c658bf3d580132f51e0ae5a3a8eec9f8a02e48eb066b2f19d5c37f9e4fb445ef435186f55a5b982b8fbf37f793e2b60bd0d312c726c62487aaa0f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b57dea161fef7ec1f0f0bedfb297d5db6da4f17a91d029796f38c4b3b3b1c866ab0e05d0d9e3a925e08423b6d71fe974d402010c3a381a86f317102db7128ae"} build_url:https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/EszpTfVmSimQuErfUc8YDw/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/0a52afd2cab636a055d1d20f2435a17e4af4a7ab45d702cb0cedbee0e5c0e6817958f2ca38107300d0db35fdb803ab398164091ef83468e9ff9bbb953a037782", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4eb7b15ae0fc28df1cb63d4e473a773c037332f8e4d9cdf824a567ff2bb927f3ed48ce523992d04ad3d133c6ca9415262be53075875929fe34ab85c4cf46bbc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33b3d7cf84c658bf3d580132f51e0ae5a3a8eec9f8a02e48eb066b2f19d5c37f9e4fb445ef435186f55a5b982b8fbf37f793e2b60bd0d312c726c62487aaa0f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b57dea161fef7ec1f0f0bedfb297d5db6da4f17a91d029796f38c4b3b3b1c866ab0e05d0d9e3a925e08423b6d71fe974d402010c3a381a86f317102db7128ae"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 02:27:38.250769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:27:38.251245) ========= 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.qTuZMqmNB6/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.RyxzTC1oVi/Listeners TMPDIR=/var/folders/mj/3qp78rx17nbd0k3gntr9djpr00000w/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.005307 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 02:27:38.305836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 02:27:38.306155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 02:27:38.306616) ========= ========= Total master_lag: 0.39 =========