builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0340 starttime: 1485397089.02 results: success (0) buildid: 20170125165631 builduid: bda45fa4cd4f4a2883fc09a3d740992e revision: 52a34f9a6cf112377299ab32132384e2dc1f543b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.024204) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.024718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.025047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.049429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.049794) ========= 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.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 18:18:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.84M=0.001s 2017-01-25 18:18:09 (7.84 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140174 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.217609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.218396) ========= 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.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.020047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:09.269026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 18:18:09.269862) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52a34f9a6cf112377299ab32132384e2dc1f543b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52a34f9a6cf112377299ab32132384e2dc1f543b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 18:18:09,363 truncating revision to first 12 chars 2017-01-25 18:18:09,363 Setting DEBUG logging. 2017-01-25 18:18:09,363 attempt 1/10 2017-01-25 18:18:09,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52a34f9a6cf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 18:18:10,673 unpacking tar archive at: mozilla-central-52a34f9a6cf1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.569013 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 18:18:10.864846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:10.865213) ========= script_repo_revision: 52a34f9a6cf112377299ab32132384e2dc1f543b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:10.865669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:10.865985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 18:18:10.885897) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 18:18:10.886219) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:11 INFO - MultiFileLogger online at 20170125 18:18:11 in /builds/slave/test 18:18:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:18:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:11 INFO - {'append_to_log': False, 18:18:11 INFO - 'base_work_dir': '/builds/slave/test', 18:18:11 INFO - 'blob_upload_branch': 'Firefox', 18:18:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:11 INFO - 'branch': 'Firefox', 18:18:11 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:11 INFO - 'config_files': ('talos/mac_config.py',), 18:18:11 INFO - 'default_actions': ('clobber', 18:18:11 INFO - 'read-buildbot-config', 18:18:11 INFO - 'download-and-extract', 18:18:11 INFO - 'populate-webroot', 18:18:11 INFO - 'create-virtualenv', 18:18:11 INFO - 'install', 18:18:11 INFO - 'run-tests'), 18:18:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:11 INFO - 'download_minidump_stackwalk': True, 18:18:11 INFO - 'download_symbols': 'ondemand', 18:18:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:11 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:11 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:11 INFO - 'installer_path': 'installer.exe', 18:18:11 INFO - 'log_level': 'info', 18:18:11 INFO - 'log_name': 'talos', 18:18:11 INFO - 'log_to_console': True, 18:18:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:18:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:18:11 INFO - 'opt_config_files': (), 18:18:11 INFO - 'pip_index': False, 18:18:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:11 INFO - 'cmd': ('bash', 18:18:11 INFO - '-c', 18:18:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:11 INFO - 'enabled': True, 18:18:11 INFO - 'halt_on_failure': False, 18:18:11 INFO - 'name': 'check_screen_resolution'},), 18:18:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:11 INFO - 'cmd': ('bash', 18:18:11 INFO - '-c', 18:18:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:11 INFO - 'enabled': True, 18:18:11 INFO - 'halt_on_failure': False, 18:18:11 INFO - 'name': 'check_screen_resolution'},), 18:18:11 INFO - 'run_cmd_checks_enabled': True, 18:18:11 INFO - 'sps_profile': False, 18:18:11 INFO - 'sps_profile_interval': 0, 18:18:11 INFO - 'suite': 'dromaeojs', 18:18:11 INFO - 'system_bits': '32', 18:18:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:11 INFO - 'title': 't-yosemite-r7-0340', 18:18:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:11 INFO - 'use_talos_json': True, 18:18:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:11 INFO - 'work_dir': 'build'} 18:18:11 INFO - [mozharness: 2017-01-26 02:18:11.098190Z] Running clobber step. 18:18:11 INFO - Running pre-action listener: _resource_record_pre_action 18:18:11 INFO - Running main action method: clobber 18:18:11 INFO - rmtree: /builds/slave/test/build 18:18:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:12 INFO - Running post-action listener: _resource_record_post_action 18:18:12 INFO - [mozharness: 2017-01-26 02:18:12.876421Z] Finished clobber step (success) 18:18:12 INFO - [mozharness: 2017-01-26 02:18:12.876580Z] Running read-buildbot-config step. 18:18:12 INFO - Running pre-action listener: _resource_record_pre_action 18:18:12 INFO - Running main action method: read_buildbot_config 18:18:12 INFO - Using buildbot properties: 18:18:12 INFO - { 18:18:12 INFO - "project": "", 18:18:12 INFO - "product": "firefox", 18:18:12 INFO - "script_repo_revision": "production", 18:18:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:18:12 INFO - "repository": "", 18:18:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:18:12 INFO - "buildid": "20170125165631", 18:18:12 INFO - "pgo_build": "False", 18:18:12 INFO - "basedir": "/builds/slave/test", 18:18:12 INFO - "buildnumber": 34, 18:18:12 INFO - "slavename": "t-yosemite-r7-0340", 18:18:12 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:18:12 INFO - "platform": "yosemite_r7", 18:18:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:18:12 INFO - "branch": "mozilla-central", 18:18:12 INFO - "repo_path": "mozilla-central", 18:18:12 INFO - "revision": "52a34f9a6cf112377299ab32132384e2dc1f543b", 18:18:12 INFO - "stage_platform": "macosx64", 18:18:12 INFO - "builduid": "bda45fa4cd4f4a2883fc09a3d740992e", 18:18:12 INFO - "slavebuilddir": "test" 18:18:12 INFO - } 18:18:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:18:12 INFO - Running post-action listener: _resource_record_post_action 18:18:12 INFO - [mozharness: 2017-01-26 02:18:12.880115Z] Finished read-buildbot-config step (success) 18:18:12 INFO - [mozharness: 2017-01-26 02:18:12.880232Z] Running download-and-extract step. 18:18:12 INFO - Running pre-action listener: _resource_record_pre_action 18:18:12 INFO - Running main action method: download_and_extract 18:18:12 INFO - mkdir: /builds/slave/test/build/tests 18:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:12 INFO - trying https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:18:12 INFO - Downloading https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 18:18:13 INFO - Downloaded 1199 bytes. 18:18:13 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:18:13 INFO - Using the following test package requirements: 18:18:13 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:18:13 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:18:13 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:18:13 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'jsshell-mac.zip'], 18:18:13 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:18:13 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:18:13 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:18:13 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:18:13 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:18:13 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:18:13 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:18:13 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:18:14 INFO - Expected file size: 16351549 18:18:14 INFO - Obtained file size: 16351549 18:18:21 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:18:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:18:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:18:21 INFO - Fetch https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:18:22 INFO - Expected file size: 16351549 18:18:22 INFO - Obtained file size: 16351549 18:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:18:29 INFO - Expected file size: 14403435 18:18:29 INFO - Obtained file size: 14403435 18:18:30 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')]} 18:18:30 INFO - trying https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:18:30 INFO - Downloading https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 18:18:32 INFO - Downloaded 69897934 bytes. 18:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:18:32 INFO - mkdir: /builds/slave/test/properties 18:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:32 INFO - Contents: 18:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:18:33 INFO - Running post-action listener: _resource_record_post_action 18:18:33 INFO - Running post-action listener: set_extra_try_arguments 18:18:33 INFO - [mozharness: 2017-01-26 02:18:33.017681Z] Finished download-and-extract step (success) 18:18:33 INFO - [mozharness: 2017-01-26 02:18:33.017803Z] Running populate-webroot step. 18:18:33 INFO - Running pre-action listener: _resource_record_pre_action 18:18:33 INFO - Running main action method: populate_webroot 18:18:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:33 INFO - '--tppagecycles', 18:18:33 INFO - '7'], 18:18:33 INFO - 'tests': ['tsvgm']}}, 18:18:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['damp', 'tps']}, 18:18:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'tests': ['damp', 'tps']}, 18:18:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['dromaeo_dom']}, 18:18:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['basic_compositor_video']}, 18:18:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['a11yr', 18:18:33 INFO - 'ts_paint', 18:18:33 INFO - 'tpaint', 18:18:33 INFO - 'sessionrestore', 18:18:33 INFO - 'sessionrestore_no_auto_restore', 18:18:33 INFO - 'tabpaint']}, 18:18:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['tsvgx', 18:18:33 INFO - 'tsvgr_opacity', 18:18:33 INFO - 'tart', 18:18:33 INFO - 'tscrollx', 18:18:33 INFO - 'cart', 18:18:33 INFO - 'tsvg_static']}, 18:18:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:33 INFO - 'tsvgr_opacity', 18:18:33 INFO - 'tart', 18:18:33 INFO - 'tscrollx', 18:18:33 INFO - 'cart', 18:18:33 INFO - 'tsvg_static']}, 18:18:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'talos_options': ['--disable-e10s'], 18:18:33 INFO - 'tests': ['tp5o']}, 18:18:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:18:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'talos_options': ['--disable-e10s', 18:18:33 INFO - '--xperf_path', 18:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:33 INFO - 'tests': ['tp5n']}, 18:18:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:18:33 INFO - 'talos_options': ['--xperf_path', 18:18:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:33 INFO - 'tests': ['tp5n']}}, 18:18:33 INFO - 'talos.zip': {'path': '', 18:18:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:33 INFO - Running post-action listener: _resource_record_post_action 18:18:33 INFO - [mozharness: 2017-01-26 02:18:33.036056Z] Finished populate-webroot step (success) 18:18:33 INFO - [mozharness: 2017-01-26 02:18:33.036183Z] Running create-virtualenv step. 18:18:33 INFO - Running pre-action listener: _resource_record_pre_action 18:18:33 INFO - Running main action method: create_virtualenv 18:18:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:33 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 18:18:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:33 INFO - Using real prefix '/tools/python27' 18:18:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:36 INFO - Installing pip.................done. 18:18:36 INFO - Return code: 0 18:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:18:36 INFO - Reading from file tmpfile_stdout 18:18:36 INFO - Output received: 18:18:36 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) 18:18:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:37 INFO - 'HOME': '/Users/cltbld', 18:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:37 INFO - 'LOGNAME': 'cltbld', 18:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:37 INFO - 'MOZ_NO_REMOTE': '1', 18:18:37 INFO - 'NO_EM_RESTART': '1', 18:18:37 INFO - 'PAGER': '/bin/cat', 18:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:37 INFO - 'PWD': '/builds/slave/test', 18:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:37 INFO - 'SHELL': '/bin/bash', 18:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:37 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:37 INFO - 'USER': 'cltbld', 18:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:37 INFO - 'XPC_FLAGS': '0x0', 18:18:37 INFO - 'XPC_SERVICE_NAME': '0', 18:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:18:37 INFO - Cleaning up... 18:18:37 INFO - Return code: 0 18:18:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:37 INFO - 'HOME': '/Users/cltbld', 18:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:37 INFO - 'LOGNAME': 'cltbld', 18:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:37 INFO - 'MOZ_NO_REMOTE': '1', 18:18:37 INFO - 'NO_EM_RESTART': '1', 18:18:37 INFO - 'PAGER': '/bin/cat', 18:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:37 INFO - 'PWD': '/builds/slave/test', 18:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:37 INFO - 'SHELL': '/bin/bash', 18:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:37 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:37 INFO - 'USER': 'cltbld', 18:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:37 INFO - 'XPC_FLAGS': '0x0', 18:18:37 INFO - 'XPC_SERVICE_NAME': '0', 18:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:37 INFO - Downloading/unpacking psutil>=3.1.1 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:41 INFO - Installing collected packages: psutil 18:18:41 INFO - Running setup.py install for psutil 18:18:41 INFO - building 'psutil._psutil_osx' extension 18:18:41 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 18:18:41 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 18:18:41 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 18:18:41 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 18:18:41 INFO - building 'psutil._psutil_posix' extension 18:18:41 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 18:18:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:18:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:18:41 INFO - ^ 18:18:41 INFO - 1 warning generated. 18:18:41 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 18:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:42 INFO - Successfully installed psutil 18:18:42 INFO - Cleaning up... 18:18:42 INFO - Return code: 0 18:18:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18:42 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')]} 18:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 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')]} 18:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:42 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:42 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 18:18:42 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 18:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:42 INFO - 'HOME': '/Users/cltbld', 18:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:42 INFO - 'LOGNAME': 'cltbld', 18:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:42 INFO - 'MOZ_NO_REMOTE': '1', 18:18:42 INFO - 'NO_EM_RESTART': '1', 18:18:42 INFO - 'PAGER': '/bin/cat', 18:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:42 INFO - 'PWD': '/builds/slave/test', 18:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:42 INFO - 'SHELL': '/bin/bash', 18:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:42 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:42 INFO - 'USER': 'cltbld', 18:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:42 INFO - 'XPC_FLAGS': '0x0', 18:18:42 INFO - 'XPC_SERVICE_NAME': '0', 18:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:42 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 18:18:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:44 INFO - Installing collected packages: mozsystemmonitor 18:18:44 INFO - Running setup.py install for mozsystemmonitor 18:18:45 INFO - Successfully installed mozsystemmonitor 18:18:45 INFO - Cleaning up... 18:18:45 INFO - Return code: 0 18:18:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:45 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 18:18:45 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 18:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:45 INFO - 'HOME': '/Users/cltbld', 18:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:45 INFO - 'LOGNAME': 'cltbld', 18:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:45 INFO - 'MOZ_NO_REMOTE': '1', 18:18:45 INFO - 'NO_EM_RESTART': '1', 18:18:45 INFO - 'PAGER': '/bin/cat', 18:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:45 INFO - 'PWD': '/builds/slave/test', 18:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:45 INFO - 'SHELL': '/bin/bash', 18:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:45 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:45 INFO - 'USER': 'cltbld', 18:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:45 INFO - 'XPC_FLAGS': '0x0', 18:18:45 INFO - 'XPC_SERVICE_NAME': '0', 18:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:45 INFO - Downloading/unpacking jsonschema==2.5.1 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:48 INFO - warning: no files found matching '*.txt' 18:18:48 INFO - no previously-included directories found matching 'build' 18:18:48 INFO - no previously-included directories found matching 'dist' 18:18:48 INFO - no previously-included directories found matching '.git*' 18:18:48 INFO - Installing collected packages: jsonschema, functools32 18:18:48 INFO - Running setup.py install for functools32 18:18:48 INFO - warning: no files found matching '*.txt' 18:18:48 INFO - no previously-included directories found matching 'build' 18:18:48 INFO - no previously-included directories found matching 'dist' 18:18:48 INFO - no previously-included directories found matching '.git*' 18:18:48 INFO - Successfully installed jsonschema functools32 18:18:48 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:18:49 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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:49 INFO - 'HOME': '/Users/cltbld', 18:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PAGER': '/bin/cat', 18:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test', 18:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:49 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - 'XPC_FLAGS': '0x0', 18:18:49 INFO - 'XPC_SERVICE_NAME': '0', 18:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:18:49 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:49 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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:49 INFO - 'HOME': '/Users/cltbld', 18:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PAGER': '/bin/cat', 18:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test', 18:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:49 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - 'XPC_FLAGS': '0x0', 18:18:49 INFO - 'XPC_SERVICE_NAME': '0', 18:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:49 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 18:18:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:53 INFO - Downloading docopt-0.6.1.tar.gz 18:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:53 INFO - Running setup.py install for blobuploader 18:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:53 INFO - Running setup.py install for requests 18:18:54 INFO - Running setup.py install for docopt 18:18:54 INFO - Successfully installed blobuploader requests docopt 18:18:54 INFO - Cleaning up... 18:18:54 INFO - Return code: 0 18:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:54 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 18:18:54 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 18:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:54 INFO - 'HOME': '/Users/cltbld', 18:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:54 INFO - 'LOGNAME': 'cltbld', 18:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:54 INFO - 'MOZ_NO_REMOTE': '1', 18:18:54 INFO - 'NO_EM_RESTART': '1', 18:18:54 INFO - 'PAGER': '/bin/cat', 18:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:54 INFO - 'PWD': '/builds/slave/test', 18:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:54 INFO - 'SHELL': '/bin/bash', 18:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:54 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:54 INFO - 'USER': 'cltbld', 18:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:54 INFO - 'XPC_FLAGS': '0x0', 18:18:54 INFO - 'XPC_SERVICE_NAME': '0', 18:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-DY80_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ozpDq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-VieX6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-P38o3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pB6_Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-iVyiLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-x3QP53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-PfkUkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-3yr_6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pwAXUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9jRWVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-UryJlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pNItUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-AvidIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-EK7Klb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-v6i_LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-gfCFjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:56 INFO - Running setup.py install for manifestparser 18:18:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozcrash 18:18:56 INFO - Running setup.py install for mozdebug 18:18:56 INFO - Running setup.py install for mozdevice 18:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozfile 18:18:57 INFO - Running setup.py install for mozhttpd 18:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozinfo 18:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozInstall 18:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:57 INFO - Running setup.py install for mozleak 18:18:57 INFO - Running setup.py install for mozlog 18:18:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Running setup.py install for moznetwork 18:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Running setup.py install for mozprocess 18:18:58 INFO - Running setup.py install for mozprofile 18:18:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Running setup.py install for mozrunner 18:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:58 INFO - Running setup.py install for mozscreenshot 18:18:58 INFO - Running setup.py install for moztest 18:18:58 INFO - Running setup.py install for mozversion 18:18:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:59 INFO - Cleaning up... 18:18:59 INFO - Return code: 0 18:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:59 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:18:59 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 18:18:59 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 18:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:59 INFO - 'HOME': '/Users/cltbld', 18:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:59 INFO - 'LOGNAME': 'cltbld', 18:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:59 INFO - 'MOZ_NO_REMOTE': '1', 18:18:59 INFO - 'NO_EM_RESTART': '1', 18:18:59 INFO - 'PAGER': '/bin/cat', 18:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:59 INFO - 'PWD': '/builds/slave/test', 18:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:59 INFO - 'SHELL': '/bin/bash', 18:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:18:59 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:59 INFO - 'USER': 'cltbld', 18:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:59 INFO - 'XPC_FLAGS': '0x0', 18:18:59 INFO - 'XPC_SERVICE_NAME': '0', 18:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5Fpf8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-y01Omu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-_6jjCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-HQ7HdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-iWOlly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-xisfQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-m3sGSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:00 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)) 18:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:00 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-KF3ysH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-YevGoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pXeQHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-VvhrJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-51Gyck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-kBlcex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CMy7Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-7zpwm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-492epn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:01 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5JA911-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:05 INFO - Downloading blessings-1.6.tar.gz 18:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:05 INFO - Installing collected packages: blessings 18:19:05 INFO - Running setup.py install for blessings 18:19:05 INFO - Successfully installed blessings 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:05 INFO - Reading from file tmpfile_stdout 18:19:05 INFO - Current package versions: 18:19:05 INFO - blessings == 1.6 18:19:05 INFO - blobuploader == 1.2.4 18:19:05 INFO - docopt == 0.6.1 18:19:05 INFO - functools32 == 3.2.3-2 18:19:05 INFO - jsonschema == 2.5.1 18:19:05 INFO - manifestparser == 1.1 18:19:05 INFO - mozInstall == 1.12 18:19:05 INFO - mozcrash == 1.0 18:19:05 INFO - mozdebug == 0.1 18:19:05 INFO - mozdevice == 0.49 18:19:05 INFO - mozfile == 1.2 18:19:05 INFO - mozhttpd == 0.7 18:19:05 INFO - mozinfo == 0.9 18:19:05 INFO - mozleak == 0.1 18:19:05 INFO - mozlog == 3.4 18:19:05 INFO - moznetwork == 0.27 18:19:05 INFO - mozprocess == 0.24 18:19:05 INFO - mozprofile == 0.28 18:19:05 INFO - mozrunner == 6.13 18:19:05 INFO - mozscreenshot == 0.1 18:19:05 INFO - mozsystemmonitor == 0.3 18:19:05 INFO - moztest == 0.8 18:19:05 INFO - mozversion == 1.4 18:19:05 INFO - psutil == 3.1.1 18:19:05 INFO - requests == 1.2.3 18:19:05 INFO - wsgiref == 0.1.2 18:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:05 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:19:05 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 18:19:05 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 18:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:05 INFO - 'HOME': '/Users/cltbld', 18:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:05 INFO - 'LOGNAME': 'cltbld', 18:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:05 INFO - 'MOZ_NO_REMOTE': '1', 18:19:05 INFO - 'NO_EM_RESTART': '1', 18:19:05 INFO - 'PAGER': '/bin/cat', 18:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:05 INFO - 'PWD': '/builds/slave/test', 18:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:05 INFO - 'SHELL': '/bin/bash', 18:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:19:05 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:05 INFO - 'USER': 'cltbld', 18:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:05 INFO - 'XPC_FLAGS': '0x0', 18:19:05 INFO - 'XPC_SERVICE_NAME': '0', 18:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 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)) 18:19:06 INFO - Cleaning up... 18:19:06 INFO - Return code: 0 18:19:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:06 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 0x101398b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10139b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47bc69fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, '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.exU05KBuY1/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.3xzU0hUFhy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:19:06 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 18:19:06 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 18:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:06 INFO - 'HOME': '/Users/cltbld', 18:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:06 INFO - 'LOGNAME': 'cltbld', 18:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:06 INFO - 'MOZ_NO_REMOTE': '1', 18:19:06 INFO - 'NO_EM_RESTART': '1', 18:19:06 INFO - 'PAGER': '/bin/cat', 18:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:06 INFO - 'PWD': '/builds/slave/test', 18:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:06 INFO - 'SHELL': '/bin/bash', 18:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:19:06 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:06 INFO - 'USER': 'cltbld', 18:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:06 INFO - 'XPC_FLAGS': '0x0', 18:19:06 INFO - 'XPC_SERVICE_NAME': '0', 18:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:06 INFO - Cleaning up... 18:19:06 INFO - Return code: 0 18:19:06 INFO - Running post-action listener: _resource_record_post_action 18:19:06 INFO - Running post-action listener: _start_resource_monitoring 18:19:06 INFO - Starting resource monitoring. 18:19:06 INFO - [mozharness: 2017-01-26 02:19:06.351677Z] Finished create-virtualenv step (success) 18:19:06 INFO - [mozharness: 2017-01-26 02:19:06.352665Z] Running install step. 18:19:06 INFO - Running pre-action listener: _resource_record_pre_action 18:19:06 INFO - Running main action method: install 18:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:06 INFO - Reading from file tmpfile_stdout 18:19:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:06 INFO - Reading from file tmpfile_stdout 18:19:06 INFO - Output received: 18:19:06 INFO - Usage: mozinstall [options] installer 18:19:06 INFO - Options: 18:19:06 INFO - -h, --help show this help message and exit 18:19:06 INFO - -d DEST, --destination=DEST 18:19:06 INFO - Directory to install application into. [default: 18:19:06 INFO - "/builds/slave/test"] 18:19:06 INFO - --app=APP Application being installed. [default: firefox] 18:19:06 INFO - mkdir: /builds/slave/test/build/application 18:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:19:28 INFO - Reading from file tmpfile_stdout 18:19:28 INFO - Output received: 18:19:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:19:28 INFO - Running post-action listener: _resource_record_post_action 18:19:28 INFO - [mozharness: 2017-01-26 02:19:28.715220Z] Finished install step (success) 18:19:28 INFO - [mozharness: 2017-01-26 02:19:28.715327Z] Running run-tests step. 18:19:28 INFO - Running pre-action listener: _resource_record_pre_action 18:19:28 INFO - Running main action method: run_tests 18:19:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:19:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:19:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:19:28 INFO - 2017-01-25 18:19:28.730 screenresolution[1898:21265] starting screenresolution argv=screenresolution get 18:19:28 INFO - 2017-01-25 18:19:28.732 screenresolution[1898:21265] Display 0: 1600x1200x32@60 18:19:28 INFO - 2017-01-25 18:19:28.738 screenresolution[1899:21268] starting screenresolution argv=screenresolution list 18:19:28 INFO - Available Modes on Display 0 18:19:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:19:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:19:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:19:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:19:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:19:28 INFO - Intel Iris: 18:19:28 INFO - Chipset Model: Intel Iris 18:19:28 INFO - Type: GPU 18:19:28 INFO - Bus: Built-In 18:19:28 INFO - VRAM (Dynamic, Max): 1536 MB 18:19:28 INFO - Vendor: Intel (0x8086) 18:19:28 INFO - Device ID: 0x0a2e 18:19:28 INFO - Revision ID: 0x0009 18:19:28 INFO - Displays: 18:19:28 INFO - Display: 18:19:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:19:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:19:28 INFO - Display Serial Number: 1600x1200 60 18:19:28 INFO - Main Display: Yes 18:19:28 INFO - Mirror: Off 18:19:28 INFO - Online: Yes 18:19:28 INFO - Rotation: Supported 18:19:28 INFO - Return code: 0 18:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:28 INFO - Python 2.7.3 18:19:28 INFO - Return code: 0 18:19:28 INFO - grabbing minidump binary from tooltool 18:19: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')]} 18:19:28 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 0x101176d30>, '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 0x10109ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10116bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:28 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 18:19:28 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 18:19:28 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 18:19:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:29 INFO - Return code: 0 18:19:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:19:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:19:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 18:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 18:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.exU05KBuY1/Render', 18:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:29 INFO - 'HOME': '/Users/cltbld', 18:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:29 INFO - 'LOGNAME': 'cltbld', 18:19:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:29 INFO - 'MOZ_NO_REMOTE': '1', 18:19:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:29 INFO - 'NO_EM_RESTART': '1', 18:19:29 INFO - 'PAGER': '/bin/cat', 18:19:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:29 INFO - 'PWD': '/builds/slave/test', 18:19:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:29 INFO - 'SHELL': '/bin/bash', 18:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3xzU0hUFhy/Listeners', 18:19:29 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:29 INFO - 'USER': 'cltbld', 18:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:29 INFO - 'XPC_FLAGS': '0x0', 18:19:29 INFO - 'XPC_SERVICE_NAME': '0', 18:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 18:19:29 INFO - mozversion application_buildid: 20170125165631 18:19:29 INFO - mozversion application_changeset: 52a34f9a6cf112377299ab32132384e2dc1f543b 18:19:29 INFO - mozversion application_display_name: Nightly 18:19:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:29 INFO - mozversion application_name: Firefox 18:19:29 INFO - mozversion application_remotingname: firefox 18:19:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:29 INFO - mozversion application_vendor: Mozilla 18:19:29 INFO - mozversion application_version: 54.0a1 18:19:29 INFO - mozversion platform_buildid: 20170125165631 18:19:29 INFO - mozversion platform_changeset: 52a34f9a6cf112377299ab32132384e2dc1f543b 18:19:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:29 INFO - mozversion platform_version: 54.0a1 18:19:29 INFO - using testdate: 1485397169 18:19:29 INFO - actual date: 1485397169 18:19:29 INFO - starting webserver on 'localhost:56943' 18:19:29 INFO - SUITE-START | Running 2 tests 18:19:29 INFO - TEST-START | dromaeo_css 18:19:29 INFO - operating with platform_type : mac_ 18:19:29 INFO - Initialising browser for dromaeo_css test... 18:19:29 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp1XQJ8S/profile http://localhost:56943/getInfo.html) 18:19:31 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 18:19:31 INFO - PROCESS | 1909 | colorDepth:24 18:19:31 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 18:19:31 INFO - PROCESS | 1909 | __metrics 18:19:31 INFO - PROCESS | 1909 | 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" 18:19:31 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:32 INFO - TEST-INFO | 1909: exit 0 18:19:32 INFO - Browser initialized. 18:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:32 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp1XQJ8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:44 INFO - PROCESS | 1911 | RSS: Main: 235888640 18:19:44 INFO - PROCESS | 1911 | 18:22:48 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56943/tests/dromaeo/cssquery-ext.html) 18:22:49 INFO - PROCESS | 1911 | RSS: Main: 372658176 18:22:49 INFO - PROCESS | 1911 | 18:24:34 INFO - PROCESS | 1911 | ************************* 18:24:34 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 18:24:34 INFO - PROCESS | 1911 | 18:24:34 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:24:34 INFO - PROCESS | 1911 | Full stack: 18:24:34 INFO - PROCESS | 1911 | ************************* 18:25:52 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-ext.html (next: http://localhost:56943/tests/dromaeo/cssquery-jquery.html) 18:25:53 INFO - PROCESS | 1911 | RSS: Main: 368250880 18:25:53 INFO - PROCESS | 1911 | 18:28:55 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56943/tests/dromaeo/cssquery-mootools.html) 18:28:56 INFO - PROCESS | 1911 | RSS: Main: 338952192 18:28:56 INFO - PROCESS | 1911 | 18:31:58 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56943/tests/dromaeo/cssquery-prototype.html) 18:31:59 INFO - PROCESS | 1911 | RSS: Main: 335237120 18:31:59 INFO - PROCESS | 1911 | 18:35:03 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56943/tests/dromaeo/cssquery-yui.html) 18:35:03 INFO - PROCESS | 1911 | RSS: Main: 328642560 18:35:03 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:56943/tests/dromaeo/cssquery-yui.html (next: http://localhost:56943/tests/dromaeo/cssquery-dojo.html) 18:38:06 INFO - PROCESS | 1911 | RSS: Main: 552476672 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | __start_tp_report 18:38:06 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 18:38:06 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 18:38:06 INFO - PROCESS | 1911 | |i|pagename|runs| 18:38:06 INFO - PROCESS | 1911 | |0;dojo.html;2808.6067950486936;3310.106271306747;3340.816255105969;3366.7474939379554;3394.2193295542024;5599.580031497633;5615.382307946128;5641.943580564193;5687.374388817232;5710.057840456319;5636.267285252911;5650.576206784497;5705.315362156547;5753.223314852494;5777.566682498808;5137.049645815536;5143.09995750744;5158.123119069748;5229.921551176735;5258.50044245796;5287.49768771968;5304.734763261841;5305.522502974732;5305.681659100447;5328.866778330534;5136.998285334361;5178.352705911761;5264.236685680555;5273.393559740641;5337.786488540453;5180.559652429511;5193.065248255312;5206.245094461282;5225.608079394061;5301.734913254322;5186.377634683862;5193.506616871391;5205.115130427836;5221.556167725748;5224.399194092652;5700.629459085146;5720.427957204246;5731.971340143315;5736.196932429463;5765.913511297334;6059.303180134253;6098.08528720691;6114.816555503342;6168.1056246843955;6215.347388524185;6222.160008398853;6252.155958945576;6279.152314437538;6291.276503202144;6300.054991751274;5865.941340586583;5872.677002764889;5881.240356378504;5885.176075349455;5933.61431506955;6195.070739389128;6202.72087756052;6275.278342990523;6277.905831412532;6362.300146983828;6056.06131049688;6168.321484636686;6187.535934804908;6218.036204388327;6240.843978900564;6102.095423428478;6255.874882502325;6256.249250089927;6259.280182779039;6284.968575157095;6076.361981991916;6113.724882380304;6127.189528148541;6181.690915454209;6183.443490085824;6100.450959413674;6262.874742505124;6266.49868010558;6276.027215781562;6289.0880822280515;4969.950300497021;5001.8499445016705;5006.69959802413;5008.69947803133;5010.574101201439;4474.7762611869275;4493;4498.145352383037;4509.323601459741;4525.366448697185;5928.792492262836;5944.910826337608;5951.137085122633;5954.702264886825;5968.22413086296;5230.686158830406;6109.313572000111;6162.014077747539;6200.286966998763;6264.123022776815;4757.381540399795;5798;5967.701614919237;5970.373110823301;5995.760169593254;4628.467726211461;5509.063459211943;5518.117101263779;5521.3926468088475;5535.778568857281;6206.968965155145;6250.281217660027;6369.840753981188;6392.7123279452535;6401.167848179707;6185.536084793748;6199.256089269136;6242.094896240111;6287.717052732546;6294.71673774672;6337.904931426125;6371.7132729028235;6385.265694445198;6395.872082558416;6400.199975003125;6014.0377539593455;6177.227846519185;6215.81352559424;6217.191765070512;6255.718492667932;6133.701927635063;6154.261488621394;6180.134781130555;6196.380361963767;6291.496680265659;6043.516518678407;6100.267967843887;6113.358913490312;6146.494108943338;6150.415710507495;5839.036558967723;5948.078047902582;5996;6068;6109.238433314604;5943.940560594512;5991.101334799815;6015.037593984942;6049.546284028627;6053.63678179293;6116.724747386289;6127.3566275540425;6139.631622102688;6151.753929842756;6177.6911154443;5796.913046304225;5834.620749651259;5909.2908850938165;5936.940630593812;5975.462208401264 18:38:06 INFO - PROCESS | 1911 | |1;ext.html;451.4650139584592;488.71410225018343;489.16108873282315;489.62543654104593;505.3607186908561;29996;38952.61047389525;40427.797861010724;40429.19141617169;42325.576744232545;41006.794966025125;41366;41430.79284603573;41511.58488415115;41829;8355.415120941536;9260.166585007348;9458.81082378352;9462.668806591771;9467.337286389955;8349.165083491664;11110.111191104692;11386.886131138706;11400.429978501083;11596.362200078993;11381.829272560919;11437.942810285937;11452.31286122831;11454.828177577343;11462.828057579143;8388.32893368529;8613.827723445496;11375.601853935113;11449.198556101077;11470.082393408507;10969.725756856064;11254.987051165434;11285.210035297532;11422.200445968785;11446.885531144748;38864.80567597172;39268.821935341984;39269.41095883564;39286;39350.80324598387;3917.5494818096;3922.960770392288;3945.8618948336957;3975.4434379186937;4003.2193722223888;23941;30586.541201881988;30607.846960765277;30668.693313066808;30947;3177.9205519861957;3188.617365916105;3207.935841283185;3280.96719032809;3322.4517954537473;398184.2451269071;399108;400331.99834000645;401617.9919100415;403156;56999;57326.70049746286;57676.71161644165;57698;57723.42276577181;60460.395396045475;60619.39380606226;60667.39332606706;60671.089933651034;60734.69632651808;15401.460948866736;15876.126813025163;15878.9206053969;15917.602059948595;15937.521874343789;11141.331520108819;11395.917387848142;11419.429028548539;12467.314297713532;12561.811572826415;12710.682232944066;15018.549443516711;15335.61660958485;15558.9222053889;15721;6278.623282603058;7518.548887066793;7551.358134558514;7583.924160758432;7652.349550288177;824.6536454689045;833.1876420489974;843.9198276163754;848.1815048478124;861.8664107063415;28093.752499799968;28400.431991360056;29082.41835163285;29198.124056278346;30107.397852042835;788.2157253532772;1000.9599616015423;1019.3374306700704;1035.5650626736788;1040.6357774778767;13456.654334566465;13821.170729756246;13886;14269.42922283097;14284.928575357057;494711;495400;496721;496967;497127;41792.37311440331;47779.76110119427;48074;48099.5190048102;48172.75913620409;1349.1298112717438;1353.5465619017543;1372.629390064657;1383.163186272311;1387.4034165309015;24223.956199858043;25086.99652013972;25190.118345857805;25203.58123003563;25223.36941576475;40617;42366.78816605897;42685;42857;42962.140757184054;439499.2100158043;442423;442656;442796.78601606784;442918;20907.790922090586;21413.464663382918;23209.419764506023;23550.882245588662;23679.52640947206;39534;40376.79811600923;40400.79799600983;40677.389839151845;40766.388504173054;33188.668113318556;33844.492332614536;33858.8307058473;34661.48007779936;35067;33339.33321333608;33479;33858.83070584631;34299;34405.139871503416;32113.357732844746;32364.676353237108;32431.864884728922;32670.673293266762;32712.182195445304;28875.5668664966;29745;29804.721480637545;29827.10518684443;29950.70049299479;17987.23730450295;19394;22322.330330090124;22581.43546411353;22675.319740407813 18:38:06 INFO - PROCESS | 1911 | |2;jquery.html;390.71282607283644;391.81780472080476;392.32324240684824;401.77902153815404;421.93881887126366;13198.868011319884;19610.607787844252;20518.38444846657;20699.275525356596;20787.896060519695;16653.167341632932;17150.828491715078;20098.397048088544;21005.579888402262;21519.462013449673;5870.589058765878;6188.597741146834;6211.068339749051;6216.564840461147;6223.844403889893;5723.942760572403;6022.759089636409;6083.48290395317;6149.016157414814;6209.503239740832;5943.435373639519;6098.298695649991;6103.42017508336;6108.083787431899;6113.6943152842405;5505.972470137664;5837.211976383176;5885.999380105392;6045.123457098718;6105.847353816146;5334.146536554133;5339;5348;5353.892922141575;5354.866128346784;25455.490890182093;26330.473390532272;26355;26450.206493805217;26834.46331073387;2684.8791804368852;2706.878190481433;2711.430599574072;2715.7827373810046;2723.904663336774;15340.309686064154;16095.03429794216;16100.677986440323;16314.918425407797;17008.48974530766;1867.9439616811517;1890.0283852237753;1894.810518948108;1910.8949007804565;1945.3464555128169;122966;124509.13236301462;126615.36692316571;127764.99999999907;128165.35917320354;11416;11450.828237576443;11526.481308341145;11703.941480292715;11757.588484403175;14686.55940321792;14699.41202351894;14700.705985880222;14710.0438471499;14721;7635.770926872203;7725.304722574995;8845.51349675774;8864.468131912106;8944.597493112826;8428.789280268042;8551.828963420698;8599.678086916498;8888.022317545065;8976.640934362684;6212.658303793335;7298;7401.594481793331;7489.70041198346;7501.137369202503;1676.7484877268507;1941.1167918597005;1981.4247673099633;1990.9203631854564;1993.5215548268602;1012.2762225009154;1048.6772591660147;1051.3429106808244;1057.1331508163387;1080.2006515178712;21280.653406821544;22824.771752282264;23143.768562314162;23162.768372316063;23472.178473753338;971.2327261463365;1062.7290041039485;1099.8900109988938;1112.3048094940661;1115.938623375722;11079.944600276947;11813.686186821724;11848.466818993165;11971.52113915451;11984.940075299568;578368;596459;599822;605458;606372;103126;119343.40328298302;120231.79768202381;122734;127801;1064.80301144287;1065.4406436620682;1091.6561283195767;1094.3543309447464;1094.3980810554322;19574.314898978468;19873.205071796965;19883.403497895088;19921.60156796885;19934.30229941945;38685.41971870368;54689.63275918134;56291.43708562862;56291.71854140867;56487.58781030507;63027;63343;81374;82492;91384.54307728684;8115.837683246184;8202.753917382488;8212.46618969765;8522.36082293818;8697;9202.631894724404;12360.938195308965;12988.48046078184;13248.337583120998;13270.933645332098;10698.144148467949;10790.1367890567;10932.726681833017;11212.66362009141;11328.150388720715;9333.626654933998;9961.800763984535;10846.457677115955;10977.341359518454;11238.66284011481;11324.773504530029;11684.766304674029;11697.590584329508;11763.588274410355;11777.23447975913;8286.047104582809;8435.367347448842;8445.831083378422;8526.275266602408;8562.91437085646;5518.061929471919;6737.62943038118;9051.185393314634;10896.61861834832;11305.547778088785 18:38:06 INFO - PROCESS | 1911 | |3;mootools.html;1322.6032190342894;1419.7870319452081;1422.8648278413548;1432.8065711129002;1439.964000899977;7970.641321140548;8375.95812020939;8389.706360277392;8404.621792019367;8404.747857564267;7114.893276600855;7368.373688236493;7378.704851805921;7958.92041079589;8089;1825.6713791517523;2143.6998820165227;2155.407263002679;2180.5529866377356;2187.354730354541;2282.942926426844;2314.9652755208685;2326.5579539887367;2327.2552783109413;2330.7436182019965;2001.949951251216;2068.172730907634;2239.955200895989;2280.1791355112227;2306.4695120122383;2309.7574754650773;2310.4801419680607;2315.2938353802083;2317.2700599311247;2321.7446080931086;2057.611112499057;2196.791304826039;2235.3405745305013;2288;2320.9419764505856;8227.71203007892;8297.419180657356;8315.916840831575;8321.126281740451;8323.708670196515;4973.204287314049;5113.7443127843835;5113.974430127862;5116.76974536143;5131.076406246874;3166.936661266785;3304.9173770655684;3337.5327454156436;3372.4266874631126;3376.5104059911423;1129.2095533126844;1178.522698307187;1217.8355921950513;1220.0788404754442;1246.7007918099591;10074.244431667654;10493.947530262376;10540.841887371696;10657.200709946708;10676;4378.233809083461;4525.773711314421;4587.3807036050375;4618.95381046192;4636.959737715462;9399.812003760024;9408.388454750419;9416.964133945261;9420.293477989178;9424.575894084783;5025.79896804131;5028.798848046037;5136.640435169502;5143.819966301162;5146.433892271847;3826.3877779555137;4167.958320416757;4601.838935637236;4713.222318317507;4715.504871988461;3757.192203676168;3770.5852356240794;3828.464015037897;3854.209886973164;3879.903002424962;1267.2776517385003;1268.6194141757621;1273.7834568123442;1287.4914408808468;1288.2914397081568;814.2834305810849;836.7280633794041;845.6321500147455;877.9429337093069;879.6613303878053;4937.7777999990085;5039.916417970154;5072.41320880718;5360.651557648818;5367.865803354947;459.4326007380882;542.6798189068469;554.8376151961634;570.1903297317818;570.7517230004961;2699.284689557269;3375.6793104655508;3377.915552111217;3378.611459682119;3423.503591979149;9568.330216884751;9809.607615695435;9872.555734991942;9945.751356216153;9952.651657191964;9862.063104005108;9862.358946668444;9872.703818885446;9901.257405694458;9928.80142397148;7709.6870938719285;7754.883676744853;7781.610919454005;7871.409644276702;7873.173316801768;5049.873753156054;5094.923576146287;5102.591792656504;5162.174052151638;5194.558462530727;8938.24024957886;8941.239994600532;8953;9087.04586018485;9203.76990575241;9067.138621830916;9197.402168859002;9228.815423691623;9309.44143351401;9328.067193280618;6428.260750013808;6640.369164929324;6847.657617119224;7051.929480705333;7152.24901385347;7910.7231246906085;7956.681732730626;7976.1226265109635;7981.2018798119725;7996.24035716606;7006.544574602634;7087.574745515286;7136.750213742494;7161.713531458683;7221.350078492961;6762.830929226612;6794.456443484608;6923.411510021705;6992.720291188499;6998.475114366544;5925.822225333247;6101.115338275837;6155.47678447337;6176.969115154575;6181.598196117238;4553.954460455486;4611.216093264086;4639.048994955959;4660.184467718203;4761.738104404291;3785.6971442285103;4590.2426099693175;4646.83736069236;4708.223143181337;4855.975720121377 18:38:06 INFO - PROCESS | 1911 | |4;prototype.html;351.6149815951533;354.3126334910274;360.9169890925088;369.92601479704064;373.441704651546;4399.582039706231;5151.702910137515;5179.4561571035065;5186.8703282417955;5199.3760748710165;4082.265192265391;4415.549370099593;4852.2721591761165;4877.341558889549;4993.975030124853;3637.908627411779;3754.3805272130203;4033.7176397652174;4057.736247143941;4089.631933126018;3738.5887552369354;3799.9430008549894;3879.398693202558;4092.877213683579;4104.589541045902;3193.680631936811;3588.7308451866083;3823.973294154103;4039.757614543122;4050.9670034141254;3503.8072905990034;3744.7753134811996;3966.147278335172;4051.3315302974975;4067.3898915162813;2878.7984841061134;2962.540806175025;3439.638837922007;3587.1749497615697;3591.8089965121517;4557.4504668412565;4770.904581908342;4975.353204083446;5031.798728050873;5066.544011039025;3579.4451859961746;4597.241455159895;4656.298242896905;4666.113438446719;4678.508756580578;4760.071786001731;5442.693753499171;5443.945560544384;5475.260839786618;5539.723013849291;3624.58317293512;3717.442383642448;3921.313770090251;3984.442178095069;3999.5800440953863;5313.415524292324;5368.436314187033;5704.515116215127;5755.251817263729;5796.159556864273;3183.567394672407;3207.8988262687976;3542.7165826734313;3821.7706937583835;3825.3496905526126;3883.834849545125;3887.358585833306;3907.316219661548;3922.3920292354733;3928.64642182205;3957.485526881487;4202.810873510699;4517.367568540407;4523.2988886722615;4592.954070459253;4630.976845115752;5191.714455704972;5263.578753773307;5310.8141215057285;5476.370217424967;1243.3907385381278;1254.4480428611382;1256.8805963433458;1259.603224984127;1266.7466506698697;718.6945548142019;824.3652387661467;825.793551612097;838.5262326785347;842.9968337678143;4282.758000179975;4470.687051906335;4754.762261886892;4782.187028205213;4962.478939711351;4701.506341834127;4708.422678402705;5344.518993290622;5363.061464243741;5465.098258787256;3782.7541209821275;4194.30793919006;4357.975875669215;4723.267893476516;4818.831340903122;2545.6762483508473;2620.056779559357;2793.720627937231;2800.2439341377712;2811.9297017574722;4306.2894622387585;4575.473820510617;4909.901801963941;5360.391882435254;5592.651086543661;4499.4150760400935;5046.899062018739;5047.520485553867;5091.618128640367;5525.530329922001;5125.487981045675;5837.620554663848;5862.882742345215;5868.325142608569;5924.37079803049;5007.624428167975;5091.974540127276;5264.8674038946765;5578.3584887738425;5759.337676167294;5123.747289749574;5221.373435187802;5316.777141257609;5552.917655879045;5559.8610034747835;5487.478689524489;5891.407780576533;5894.941050589439;5955.67243801595;5964.7912323068485;3624.52881125452;3701.0932321581386;3835.5397352316786;3836.48207491985;3861.45939568455;4963.875903102451;5118.0039784484825;5318.8936221276135;5419.403865574863;5598.496135347838;5116.386033675983;5429.348478182644;5454.881749241316;5459.744258820573;5476.3702174250475;4935.358403407534;5258.868528286824;5434.266374039612;5440.191865694109;5442.945570544244;4629.884252893705;4890.877728056827;5424.83725488236;5433.891322173456;5458.945410546003;4682.836100736458;5366.570674345965;5379.310344827586;5391.919121213106;5481.972590137024;5381.246625472359;5403.13549832025;5426.321709786277;5445.863853403696;5506.201600767947 18:38:06 INFO - PROCESS | 1911 | |5;yui.html;710.2790667472514;743.9404847612192;765.3073968058909;819.8278361544076;828.428384414754;14715.48495802647;15593.142377169252;15621;15650.530484085468;15713.214339283033;14358.210298433609;14515.49195778148;14542.781858272134;14546;14560.344784484698;667.3860048755157;689.3520091114336;691.2672567078887;836.4270474724802;856.3021137772727;838.0571856661256;854.3336197765752;854.6752234151014;855.7689423855555;856.2764464027887;914.8353296406644;915.7847905742145;919.7608621758324;920.4431319051978;923.2567782934735;699.1435491522894;719.6042176802738;883.0683628771643;914.6158613382362;915.1077699243218;678.1455366238525;683.6684208159039;684.3977299976038;685.348918527401;686.2177118085336;14800.333984970595;15148.394064237416;15179.696406071816;15183;15195.848041519554;13690.65773355674;13806.86193138076;13810.93094534531;13833.446662133603;14031.579052628438;12305.507779688802;12474.59311715741;12515.311657858814;12623.684407889785;12769.55306564275;4395.1868904252815;4475.552444755531;4549.31760235964;4557.202489564346;4656.8602941911795;100492.99507004983;104181.47909260482;104493.89332440175;104721;104845;11004.119670426508;11025.944870275758;11039.39283339408;11058.391788451552;11524.481398337095;21598.892005540187;21609.919504024736;21681.891590541945;21706.565868682537;21711.782882170977;7491.8501629967095;7504.399648028145;7505.362044226193;7607.087149542091;7614.58119803405;4073.7148399612333;4129;4242.406063151161;4252.29837076885;4275.657947364203;3110.206897241189;3181.2683082891062;3230.3700778347998;3233.8868139615;3234.5148227765553;592.2892528965173;595.1221947627215;601.8736065426309;605.2464681471508;611.0528680545137;637.9011253255753;639.8944174211204;652.4030512081487;663.5521023309343;678.8845896197658;9359.204467620193;9457.905420945703;9786.168175705003;9937.950310248547;9994.850077248848;588.5732843688291;635.6249812610582;674.2246416620925;674.4907594766019;696.244574636525;4596.839110631112;4752.1921273383605;4794.760261986957;4858.344123543347;5234.848333366654;86559;91216.6317505238;93442.53278733563;98425;98832.50583747035;90797;92379;94282.52858735662;94400.52799735958;95446;79737.20262797414;80779;81144.59427702942;81459.18540814516;83477.31317615538;10587.417692027013;10755.753319891564;10851;10974.945125274322;11066;50476;50668.49331506638;51042;51682.96634067373;51702.48297516977;66889.66555167193;67444.6627766858;68488.3151168482;68684;70852;12970.22178669283;13047;13138.408771605491;13273.402696878857;13519.256440895846;14476.638084047983;14581.343839527035;14653.267336633338;14878.925605371904;15329.770053448985;13679.153314302443;13709.314534273446;14027.438902443788;14155.363008664428;14412.639684007983;13825.861741382458;13915.652108697364;14030.158190508602;14071.437142514595;14502.709945801236;13363.1313964592;13683.589492315246;13689.794653080411;14106.2946852659;14124.43502259898;9472.621095156117;10937.617183398543;11203.611684037496;11303.604373846876;11618.477168527606;9560.426374417557;9739.610415583298;10838.837417438903;11084.390358530358;11088.667339979813 18:38:06 INFO - PROCESS | 1911 | __end_tp_report 18:38:06 INFO - PROCESS | 1911 | __start_cc_report 18:38:06 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1429 18:38:06 INFO - PROCESS | 1911 | __end_cc_report 18:38:06 INFO - PROCESS | 1911 | __startTimestamp1485398286916__endTimestamp 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | ------- Summary: start ------- 18:38:06 INFO - PROCESS | 1911 | Number of tests: 6 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5750.34 Median:5975.46 stddev:651.73 (10.9%) stddev-sans-first:611.51 18:38:06 INFO - PROCESS | 1911 | Values: 2808.6 3310.1 3340.8 3366.7 3394.2 5599.6 5615.4 5641.9 5687.4 5710.1 5636.3 5650.6 5705.3 5753.2 5777.6 5137.0 5143.1 5158.1 5229.9 5258.5 5287.5 5304.7 5305.5 5305.7 5328.9 5137.0 5178.4 5264.2 5273.4 5337.8 5180.6 5193.1 5206.2 5225.6 5301.7 5186.4 5193.5 5205.1 5221.6 5224.4 5700.6 5720.4 5732.0 5736.2 5765.9 6059.3 6098.1 6114.8 6168.1 6215.3 6222.2 6252.2 6279.2 6291.3 6300.1 5865.9 5872.7 5881.2 5885.2 5933.6 6195.1 6202.7 6275.3 6277.9 6362.3 6056.1 6168.3 6187.5 6218.0 6240.8 6102.1 6255.9 6256.2 6259.3 6285.0 6076.4 6113.7 6127.2 6181.7 6183.4 6100.5 6262.9 6266.5 6276.0 6289.1 4970.0 5001.8 5006.7 5008.7 5010.6 4474.8 4493.0 4498.1 4509.3 4525.4 5928.8 5944.9 5951.1 5954.7 5968.2 5230.7 6109.3 6162.0 6200.3 6264.1 4757.4 5798.0 5967.7 5970.4 5995.8 4628.5 5509.1 5518.1 5521.4 5535.8 6207.0 6250.3 6369.8 6392.7 6401.2 6185.5 6199.3 6242.1 6287.7 6294.7 6337.9 6371.7 6385.3 6395.9 6400.2 6014.0 6177.2 6215.8 6217.2 6255.7 6133.7 6154.3 6180.1 6196.4 6291.5 6043.5 6100.3 6113.4 6146.5 6150.4 5839.0 5948.1 5996.0 6068.0 6109.2 5943.9 5991.1 6015.0 6049.5 6053.6 6116.7 6127.4 6139.6 6151.8 6177.7 5796.9 5834.6 5909.3 5936.9 5975.5 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:58050.66 Median:33851.66 stddev:119006.91 (351.6%) stddev-sans-first:119262.18 18:38:06 INFO - PROCESS | 1911 | Values: 451.5 488.7 489.2 489.6 505.4 29996.0 38952.6 40427.8 40429.2 42325.6 41006.8 41366.0 41430.8 41511.6 41829.0 8355.4 9260.2 9458.8 9462.7 9467.3 8349.2 11110.1 11386.9 11400.4 11596.4 11381.8 11437.9 11452.3 11454.8 11462.8 8388.3 8613.8 11375.6 11449.2 11470.1 10969.7 11255.0 11285.2 11422.2 11446.9 38864.8 39268.8 39269.4 39286.0 39350.8 3917.5 3923.0 3945.9 3975.4 4003.2 23941.0 30586.5 30607.8 30668.7 30947.0 3177.9 3188.6 3207.9 3281.0 3322.5 398184.2 399108.0 400332.0 401618.0 403156.0 56999.0 57326.7 57676.7 57698.0 57723.4 60460.4 60619.4 60667.4 60671.1 60734.7 15401.5 15876.1 15878.9 15917.6 15937.5 11141.3 11395.9 11419.4 12467.3 12561.8 12710.7 15018.5 15335.6 15558.9 15721.0 6278.6 7518.5 7551.4 7583.9 7652.3 824.7 833.2 843.9 848.2 861.9 28093.8 28400.4 29082.4 29198.1 30107.4 788.2 1001.0 1019.3 1035.6 1040.6 13456.7 13821.2 13886.0 14269.4 14284.9 494711.0 495400.0 496721.0 496967.0 497127.0 41792.4 47779.8 48074.0 48099.5 48172.8 1349.1 1353.5 1372.6 1383.2 1387.4 24224.0 25087.0 25190.1 25203.6 25223.4 40617.0 42366.8 42685.0 42857.0 42962.1 439499.2 442423.0 442656.0 442796.8 442918.0 20907.8 21413.5 23209.4 23550.9 23679.5 39534.0 40376.8 40400.8 40677.4 40766.4 33188.7 33844.5 33858.8 34661.5 35067.0 33339.3 33479.0 33858.8 34299.0 34405.1 32113.4 32364.7 32431.9 32670.7 32712.2 28875.6 29745.0 29804.7 29827.1 29950.7 17987.2 19394.0 22322.3 22581.4 22675.3 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:35189.02 Median:23153.27 stddev:99622.10 (430.3%) stddev-sans-first:99867.30 18:38:06 INFO - PROCESS | 1911 | Values: 390.7 391.8 392.3 401.8 421.9 13198.9 19610.6 20518.4 20699.3 20787.9 16653.2 17150.8 20098.4 21005.6 21519.5 5870.6 6188.6 6211.1 6216.6 6223.8 5723.9 6022.8 6083.5 6149.0 6209.5 5943.4 6098.3 6103.4 6108.1 6113.7 5506.0 5837.2 5886.0 6045.1 6105.8 5334.1 5339.0 5348.0 5353.9 5354.9 25455.5 26330.5 26355.0 26450.2 26834.5 2684.9 2706.9 2711.4 2715.8 2723.9 15340.3 16095.0 16100.7 16314.9 17008.5 1867.9 1890.0 1894.8 1910.9 1945.3 122966.0 124509.1 126615.4 127765.0 128165.4 11416.0 11450.8 11526.5 11703.9 11757.6 14686.6 14699.4 14700.7 14710.0 14721.0 7635.8 7725.3 8845.5 8864.5 8944.6 8428.8 8551.8 8599.7 8888.0 8976.6 6212.7 7298.0 7401.6 7489.7 7501.1 1676.7 1941.1 1981.4 1990.9 1993.5 1012.3 1048.7 1051.3 1057.1 1080.2 21280.7 22824.8 23143.8 23162.8 23472.2 971.2 1062.7 1099.9 1112.3 1115.9 11079.9 11813.7 11848.5 11971.5 11984.9 578368.0 596459.0 599822.0 605458.0 606372.0 103126.0 119343.4 120231.8 122734.0 127801.0 1064.8 1065.4 1091.7 1094.4 1094.4 19574.3 19873.2 19883.4 19921.6 19934.3 38685.4 54689.6 56291.4 56291.7 56487.6 63027.0 63343.0 81374.0 82492.0 91384.5 8115.8 8202.8 8212.5 8522.4 8697.0 9202.6 12360.9 12988.5 13248.3 13270.9 10698.1 10790.1 10932.7 11212.7 11328.2 9333.6 9961.8 10846.5 10977.3 11238.7 11324.8 11684.8 11697.6 11763.6 11777.2 8286.0 8435.4 8445.8 8526.3 8562.9 5518.1 6737.6 9051.2 10896.6 11305.5 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5281.43 Median:5113.86 stddev:2950.69 (57.7%) stddev-sans-first:2943.97 18:38:06 INFO - PROCESS | 1911 | Values: 1322.6 1419.8 1422.9 1432.8 1440.0 7970.6 8376.0 8389.7 8404.6 8404.7 7114.9 7368.4 7378.7 7958.9 8089.0 1825.7 2143.7 2155.4 2180.6 2187.4 2282.9 2315.0 2326.6 2327.3 2330.7 2001.9 2068.2 2240.0 2280.2 2306.5 2309.8 2310.5 2315.3 2317.3 2321.7 2057.6 2196.8 2235.3 2288.0 2320.9 8227.7 8297.4 8315.9 8321.1 8323.7 4973.2 5113.7 5114.0 5116.8 5131.1 3166.9 3304.9 3337.5 3372.4 3376.5 1129.2 1178.5 1217.8 1220.1 1246.7 10074.2 10493.9 10540.8 10657.2 10676.0 4378.2 4525.8 4587.4 4619.0 4637.0 9399.8 9408.4 9417.0 9420.3 9424.6 5025.8 5028.8 5136.6 5143.8 5146.4 3826.4 4168.0 4601.8 4713.2 4715.5 3757.2 3770.6 3828.5 3854.2 3879.9 1267.3 1268.6 1273.8 1287.5 1288.3 814.3 836.7 845.6 877.9 879.7 4937.8 5039.9 5072.4 5360.7 5367.9 459.4 542.7 554.8 570.2 570.8 2699.3 3375.7 3377.9 3378.6 3423.5 9568.3 9809.6 9872.6 9945.8 9952.7 9862.1 9862.4 9872.7 9901.3 9928.8 7709.7 7754.9 7781.6 7871.4 7873.2 5049.9 5094.9 5102.6 5162.2 5194.6 8938.2 8941.2 8953.0 9087.0 9203.8 9067.1 9197.4 9228.8 9309.4 9328.1 6428.3 6640.4 6847.7 7051.9 7152.2 7910.7 7956.7 7976.1 7981.2 7996.2 7006.5 7087.6 7136.8 7161.7 7221.4 6762.8 6794.5 6923.4 6992.7 6998.5 5925.8 6101.1 6155.5 6177.0 6181.6 4554.0 4611.2 4639.0 4660.2 4761.7 3785.7 4590.2 4646.8 4708.2 4856.0 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4349.58 Median:4776.55 stddev:1334.11 (27.9%) stddev-sans-first:1303.67 18:38:06 INFO - PROCESS | 1911 | Values: 351.6 354.3 360.9 369.9 373.4 4399.6 5151.7 5179.5 5186.9 5199.4 4082.3 4415.5 4852.3 4877.3 4994.0 3637.9 3754.4 4033.7 4057.7 4089.6 3738.6 3799.9 3879.4 4092.9 4104.6 3193.7 3588.7 3824.0 4039.8 4051.0 3503.8 3744.8 3966.1 4051.3 4067.4 2878.8 2962.5 3439.6 3587.2 3591.8 4557.5 4770.9 4975.4 5031.8 5066.5 3579.4 4597.2 4656.3 4666.1 4678.5 4760.1 5442.7 5443.9 5475.3 5539.7 3624.6 3717.4 3921.3 3984.4 3999.6 5313.4 5368.4 5704.5 5755.3 5796.2 3183.6 3207.9 3542.7 3821.8 3825.3 3883.8 3887.4 3907.3 3922.4 3928.6 3957.5 4202.8 4517.4 4523.3 4593.0 4631.0 5191.7 5263.6 5310.8 5476.4 1243.4 1254.4 1256.9 1259.6 1266.7 718.7 824.4 825.8 838.5 843.0 4282.8 4470.7 4754.8 4782.2 4962.5 4701.5 4708.4 5344.5 5363.1 5465.1 3782.8 4194.3 4358.0 4723.3 4818.8 2545.7 2620.1 2793.7 2800.2 2811.9 4306.3 4575.5 4909.9 5360.4 5592.7 4499.4 5046.9 5047.5 5091.6 5525.5 5125.5 5837.6 5862.9 5868.3 5924.4 5007.6 5092.0 5264.9 5578.4 5759.3 5123.7 5221.4 5316.8 5552.9 5559.9 5487.5 5891.4 5894.9 5955.7 5964.8 3624.5 3701.1 3835.5 3836.5 3861.5 4963.9 5118.0 5318.9 5419.4 5598.5 5116.4 5429.3 5454.9 5459.7 5476.4 4935.4 5258.9 5434.3 5440.2 5442.9 4629.9 4890.9 5424.8 5433.9 5458.9 4682.8 5366.6 5379.3 5391.9 5482.0 5381.2 5403.1 5426.3 5445.9 5506.2 18:38:06 INFO - PROCESS | 1911 | 18:38:06 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20522.72 Median:4577.02 stddev:29059.00 (634.9%) stddev-sans-first:29102.44 18:38:06 INFO - PROCESS | 1911 | Values: 710.3 743.9 765.3 819.8 828.4 14715.5 15593.1 15621.0 15650.5 15713.2 14358.2 14515.5 14542.8 14546.0 14560.3 667.4 689.4 691.3 836.4 856.3 838.1 854.3 854.7 855.8 856.3 914.8 915.8 919.8 920.4 923.3 699.1 719.6 883.1 914.6 915.1 678.1 683.7 684.4 685.3 686.2 14800.3 15148.4 15179.7 15183.0 15195.8 13690.7 13806.9 13810.9 13833.4 14031.6 12305.5 12474.6 12515.3 12623.7 12769.6 4395.2 4475.6 4549.3 4557.2 4656.9 100493.0 104181.5 104493.9 104721.0 104845.0 11004.1 11025.9 11039.4 11058.4 11524.5 21598.9 21609.9 21681.9 21706.6 21711.8 7491.9 7504.4 7505.4 7607.1 7614.6 4073.7 4129.0 4242.4 4252.3 4275.7 3110.2 3181.3 3230.4 3233.9 3234.5 592.3 595.1 601.9 605.2 611.1 637.9 639.9 652.4 663.6 678.9 9359.2 9457.9 9786.2 9938.0 9994.9 588.6 635.6 674.2 674.5 696.2 4596.8 4752.2 4794.8 4858.3 5234.8 86559.0 91216.6 93442.5 98425.0 98832.5 90797.0 92379.0 94282.5 94400.5 95446.0 79737.2 80779.0 81144.6 81459.2 83477.3 10587.4 10755.8 10851.0 10974.9 11066.0 50476.0 50668.5 51042.0 51683.0 51702.5 66889.7 67444.7 68488.3 68684.0 70852.0 12970.2 13047.0 13138.4 13273.4 13519.3 14476.6 14581.3 14653.3 14878.9 15329.8 13679.2 13709.3 14027.4 14155.4 14412.6 13825.9 13915.7 14030.2 14071.4 14502.7 13363.1 13683.6 13689.8 14106.3 14124.4 9472.6 10937.6 11203.6 11303.6 11618.5 9560.4 9739.6 10838.8 11084.4 11088.7 18:38:06 INFO - PROCESS | 1911 | -------- Summary: end -------- 18:38:06 INFO - PROCESS | 1911 | 18:38:07 INFO - TEST-INFO | 1911: exit 0 18:38:07 INFO - TEST-OK | dromaeo_css | took 1118281ms 18:38:07 INFO - TEST-START | kraken 18:38:07 INFO - operating with platform_type : mac_ 18:38:07 INFO - Initialising browser for kraken test... 18:38:07 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpA38TYJ/profile http://localhost:56943/getInfo.html) 18:38:09 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 18:38:09 INFO - PROCESS | 1915 | colorDepth:24 18:38:09 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 18:38:09 INFO - PROCESS | 1915 | __metrics 18:38:09 INFO - PROCESS | 1915 | 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" 18:38:09 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:10 INFO - TEST-INFO | 1915: exit 0 18:38:10 INFO - Browser initialized. 18:38:10 INFO - Running cycle 1/1 for kraken test... 18:38:10 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpA38TYJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:22 INFO - PROCESS | 1916 | RSS: Main: 235507712 18:38:22 INFO - PROCESS | 1916 | 18:38:25 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56943/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:26 INFO - PROCESS | 1916 | RSS: Main: 288108544 18:38:26 INFO - PROCESS | 1916 | 18:38:28 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56943/tests/kraken/driver.html?testName=audio-dft) 18:38:29 INFO - PROCESS | 1916 | RSS: Main: 288825344 18:38:29 INFO - PROCESS | 1916 | 18:38:32 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56943/tests/kraken/driver.html?testName=audio-fft) 18:38:33 INFO - PROCESS | 1916 | RSS: Main: 380641280 18:38:33 INFO - PROCESS | 1916 | 18:38:35 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56943/tests/kraken/driver.html?testName=audio-oscillator) 18:38:36 INFO - PROCESS | 1916 | RSS: Main: 281411584 18:38:36 INFO - PROCESS | 1916 | 18:38:38 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:38 INFO - PROCESS | 1916 | RSS: Main: 285253632 18:38:38 INFO - PROCESS | 1916 | 18:38:41 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56943/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:42 INFO - PROCESS | 1916 | RSS: Main: 327204864 18:38:42 INFO - PROCESS | 1916 | 18:38:45 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56943/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:45 INFO - PROCESS | 1916 | RSS: Main: 329879552 18:38:45 INFO - PROCESS | 1916 | 18:38:48 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56943/tests/kraken/driver.html?testName=json-parse-financial) 18:38:49 INFO - PROCESS | 1916 | RSS: Main: 324616192 18:38:49 INFO - PROCESS | 1916 | 18:38:50 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:51 INFO - PROCESS | 1916 | RSS: Main: 303591424 18:38:51 INFO - PROCESS | 1916 | 18:38:53 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:54 INFO - PROCESS | 1916 | RSS: Main: 305831936 18:38:54 INFO - PROCESS | 1916 | 18:38:56 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:56 INFO - PROCESS | 1916 | RSS: Main: 309612544 18:38:56 INFO - PROCESS | 1916 | 18:38:59 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:00 INFO - PROCESS | 1916 | RSS: Main: 329854976 18:39:00 INFO - PROCESS | 1916 | 18:39:03 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:04 INFO - PROCESS | 1916 | RSS: Main: 323792896 18:39:04 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:56943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56943/tests/kraken/driver.html?testName=ai-astar) 18:39:06 INFO - PROCESS | 1916 | RSS: Main: 368889856 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | __start_tp_report 18:39:06 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 18:39:06 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 18:39:06 INFO - PROCESS | 1916 | |i|pagename|runs| 18:39:06 INFO - PROCESS | 1916 | |0;ai-astar;116;113;115;114;112;113;114;114;114;113 18:39:06 INFO - PROCESS | 1916 | |1;audio-beat-detection;175;143;144;147;112;112;112;110;133;112 18:39:06 INFO - PROCESS | 1916 | |2;audio-dft;182;185;182;186;182;185;181;184;184;183 18:39:06 INFO - PROCESS | 1916 | |3;audio-fft;77;52;51;110;88;60;59;60;75;59 18:39:06 INFO - PROCESS | 1916 | |4;audio-oscillator;85;71;84;70;68;71;83;69;69;83 18:39:06 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;89;88;90;87;89;87;90;88;90;86 18:39:06 INFO - PROCESS | 1916 | |6;imaging-darkroom;95;95;96;116;119;95;95;108;130;95 18:39:06 INFO - PROCESS | 1916 | |7;imaging-desaturate;86;87;87;88;85;88;86;86;85;85 18:39:06 INFO - PROCESS | 1916 | |8;json-parse-financial;57;55;57;56;54;56;55;55;54;56 18:39:06 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;66;78;67;77;74;72;75;74;74;75 18:39:06 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;89;102;106;87;86;90;87;90;90;88 18:39:06 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;141;137;164;140;139;142;140;142;170;142 18:39:06 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;214;222;174;175;182;216;176;173;174;169 18:39:06 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;62;78;89;71;68;68;67;67;67;67 18:39:06 INFO - PROCESS | 1916 | __end_tp_report 18:39:06 INFO - PROCESS | 1916 | __start_cc_report 18:39:06 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2094 18:39:06 INFO - PROCESS | 1916 | __end_cc_report 18:39:06 INFO - PROCESS | 1916 | __startTimestamp1485398346414__endTimestamp 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | ------- Summary: start ------- 18:39:06 INFO - PROCESS | 1916 | Number of tests: 14 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:0.88 18:39:06 INFO - PROCESS | 1916 | Values: 116.0 113.0 115.0 114.0 112.0 113.0 114.0 114.0 114.0 113.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:138.00 stddev:22.07 (16.0%) stddev-sans-first:16.33 18:39:06 INFO - PROCESS | 1916 | Values: 175.0 143.0 144.0 147.0 112.0 112.0 112.0 110.0 133.0 112.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.67 18:39:06 INFO - PROCESS | 1916 | Values: 182.0 185.0 182.0 186.0 182.0 185.0 181.0 184.0 184.0 183.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:69.10 Median:60.00 stddev:18.61 (31.0%) stddev-sans-first:19.52 18:39:06 INFO - PROCESS | 1916 | Values: 77.0 52.0 51.0 110.0 88.0 60.0 59.0 60.0 75.0 59.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:77.00 stddev:7.35 (9.5%) stddev-sans-first:6.91 18:39:06 INFO - PROCESS | 1916 | Values: 85.0 71.0 84.0 70.0 68.0 71.0 83.0 69.0 69.0 83.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:1.43 (1.6%) stddev-sans-first:1.50 18:39:06 INFO - PROCESS | 1916 | Values: 89.0 88.0 90.0 87.0 89.0 87.0 90.0 88.0 90.0 86.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:95.00 stddev:13.03 (13.7%) stddev-sans-first:13.37 18:39:06 INFO - PROCESS | 1916 | Values: 95.0 95.0 96.0 116.0 119.0 95.0 95.0 108.0 130.0 95.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.16 (1.3%) stddev-sans-first:1.22 18:39:06 INFO - PROCESS | 1916 | Values: 86.0 87.0 87.0 88.0 85.0 88.0 86.0 86.0 85.0 85.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.08 (1.9%) stddev-sans-first:1.00 18:39:06 INFO - PROCESS | 1916 | Values: 57.0 55.0 57.0 56.0 54.0 56.0 55.0 55.0 54.0 56.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:74.50 stddev:3.91 (5.2%) stddev-sans-first:3.16 18:39:06 INFO - PROCESS | 1916 | Values: 66.0 78.0 67.0 77.0 74.0 72.0 75.0 74.0 74.0 75.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:88.50 stddev:6.80 (7.7%) stddev-sans-first:7.16 18:39:06 INFO - PROCESS | 1916 | Values: 89.0 102.0 106.0 87.0 86.0 90.0 87.0 90.0 90.0 88.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.00 stddev:11.42 (8.0%) stddev-sans-first:11.99 18:39:06 INFO - PROCESS | 1916 | Values: 141.0 137.0 164.0 140.0 139.0 142.0 140.0 142.0 170.0 142.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:179.00 stddev:20.92 (11.7%) stddev-sans-first:19.88 18:39:06 INFO - PROCESS | 1916 | Values: 214.0 222.0 174.0 175.0 182.0 216.0 176.0 173.0 174.0 169.0 18:39:06 INFO - PROCESS | 1916 | 18:39:06 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:68.00 stddev:7.69 (11.3%) stddev-sans-first:7.53 18:39:06 INFO - PROCESS | 1916 | Values: 62.0 78.0 89.0 71.0 68.0 68.0 67.0 67.0 67.0 67.0 18:39:06 INFO - PROCESS | 1916 | -------- Summary: end -------- 18:39:06 INFO - PROCESS | 1916 | 18:39:07 INFO - TEST-INFO | 1916: exit 0 18:39:07 INFO - TEST-OK | kraken | took 59761ms 18:39:07 INFO - SUITE-END | took 1178s 18:39:07 INFO - Completed test suite (00:19:38) 18:39:07 INFO - javascript benchmark 18:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2808.6067950486936, 3310.106271306747, 3340.816255105969, 3366.7474939379554, 3394.2193295542024, 5599.580031497633, 5615.382307946128, 5641.943580564193, 5687.374388817232, 5710.057840456319, 5636.267285252911, 5650.576206784497, 5705.315362156547, 5753.223314852494, 5777.566682498808, 5137.049645815536, 5143.09995750744, 5158.123119069748, 5229.921551176735, 5258.50044245796, 5287.49768771968, 5304.734763261841, 5305.522502974732, 5305.681659100447, 5328.866778330534, 5136.998285334361, 5178.352705911761, 5264.236685680555, 5273.393559740641, 5337.786488540453, 5180.559652429511, 5193.065248255312, 5206.245094461282, 5225.608079394061, 5301.734913254322, 5186.377634683862, 5193.506616871391, 5205.115130427836, 5221.556167725748, 5224.399194092652, 5700.629459085146, 5720.427957204246, 5731.971340143315, 5736.196932429463, 5765.913511297334, 6059.303180134253, 6098.08528720691, 6114.816555503342, 6168.1056246843955, 6215.347388524185, 6222.160008398853, 6252.155958945576, 6279.152314437538, 6291.276503202144, 6300.054991751274, 5865.941340586583, 5872.677002764889, 5881.240356378504, 5885.176075349455, 5933.61431506955, 6195.070739389128, 6202.72087756052, 6275.278342990523, 6277.905831412532, 6362.300146983828, 6056.06131049688, 6168.321484636686, 6187.535934804908, 6218.036204388327, 6240.843978900564, 6102.095423428478, 6255.874882502325, 6256.249250089927, 6259.280182779039, 6284.968575157095, 6076.361981991916, 6113.724882380304, 6127.189528148541, 6181.690915454209, 6183.443490085824, 6100.450959413674, 6262.874742505124, 6266.49868010558, 6276.027215781562, 6289.0880822280515, 4969.950300497021, 5001.8499445016705, 5006.69959802413, 5008.69947803133, 5010.574101201439, 4474.7762611869275, 4493.0, 4498.145352383037, 4509.323601459741, 4525.366448697185, 5928.792492262836, 5944.910826337608, 5951.137085122633, 5954.702264886825, 5968.22413086296, 5230.686158830406, 6109.313572000111, 6162.014077747539, 6200.286966998763, 6264.123022776815, 4757.381540399795, 5798.0, 5967.701614919237, 5970.373110823301, 5995.760169593254, 4628.467726211461, 5509.063459211943, 5518.117101263779, 5521.3926468088475, 5535.778568857281, 6206.968965155145, 6250.281217660027, 6369.840753981188, 6392.7123279452535, 6401.167848179707, 6185.536084793748, 6199.256089269136, 6242.094896240111, 6287.717052732546, 6294.71673774672, 6337.904931426125, 6371.7132729028235, 6385.265694445198, 6395.872082558416, 6400.199975003125, 6014.0377539593455, 6177.227846519185, 6215.81352559424, 6217.191765070512, 6255.718492667932, 6133.701927635063, 6154.261488621394, 6180.134781130555, 6196.380361963767, 6291.496680265659, 6043.516518678407, 6100.267967843887, 6113.358913490312, 6146.494108943338, 6150.415710507495, 5839.036558967723, 5948.078047902582, 5996.0, 6068.0, 6109.238433314604, 5943.940560594512, 5991.101334799815, 6015.037593984942, 6049.546284028627, 6053.63678179293, 6116.724747386289, 6127.3566275540425, 6139.631622102688, 6151.753929842756, 6177.6911154443, 5796.913046304225, 5834.620749651259, 5909.2908850938165, 5936.940630593812, 5975.462208401264], "value": 5707.533500567654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.4650139584592, 488.71410225018343, 489.16108873282315, 489.62543654104593, 505.3607186908561, 29996.0, 38952.61047389525, 40427.797861010724, 40429.19141617169, 42325.576744232545, 41006.794966025125, 41366.0, 41430.79284603573, 41511.58488415115, 41829.0, 8355.415120941536, 9260.166585007348, 9458.81082378352, 9462.668806591771, 9467.337286389955, 8349.165083491664, 11110.111191104692, 11386.886131138706, 11400.429978501083, 11596.362200078993, 11381.829272560919, 11437.942810285937, 11452.31286122831, 11454.828177577343, 11462.828057579143, 8388.32893368529, 8613.827723445496, 11375.601853935113, 11449.198556101077, 11470.082393408507, 10969.725756856064, 11254.987051165434, 11285.210035297532, 11422.200445968785, 11446.885531144748, 38864.80567597172, 39268.821935341984, 39269.41095883564, 39286.0, 39350.80324598387, 3917.5494818096, 3922.960770392288, 3945.8618948336957, 3975.4434379186937, 4003.2193722223888, 23941.0, 30586.541201881988, 30607.846960765277, 30668.693313066808, 30947.0, 3177.9205519861957, 3188.617365916105, 3207.935841283185, 3280.96719032809, 3322.4517954537473, 398184.2451269071, 399108.0, 400331.99834000645, 401617.9919100415, 403156.0, 56999.0, 57326.70049746286, 57676.71161644165, 57698.0, 57723.42276577181, 60460.395396045475, 60619.39380606226, 60667.39332606706, 60671.089933651034, 60734.69632651808, 15401.460948866736, 15876.126813025163, 15878.9206053969, 15917.602059948595, 15937.521874343789, 11141.331520108819, 11395.917387848142, 11419.429028548539, 12467.314297713532, 12561.811572826415, 12710.682232944066, 15018.549443516711, 15335.61660958485, 15558.9222053889, 15721.0, 6278.623282603058, 7518.548887066793, 7551.358134558514, 7583.924160758432, 7652.349550288177, 824.6536454689045, 833.1876420489974, 843.9198276163754, 848.1815048478124, 861.8664107063415, 28093.752499799968, 28400.431991360056, 29082.41835163285, 29198.124056278346, 30107.397852042835, 788.2157253532772, 1000.9599616015423, 1019.3374306700704, 1035.5650626736788, 1040.6357774778767, 13456.654334566465, 13821.170729756246, 13886.0, 14269.42922283097, 14284.928575357057, 494711.0, 495400.0, 496721.0, 496967.0, 497127.0, 41792.37311440331, 47779.76110119427, 48074.0, 48099.5190048102, 48172.75913620409, 1349.1298112717438, 1353.5465619017543, 1372.629390064657, 1383.163186272311, 1387.4034165309015, 24223.956199858043, 25086.99652013972, 25190.118345857805, 25203.58123003563, 25223.36941576475, 40617.0, 42366.78816605897, 42685.0, 42857.0, 42962.140757184054, 439499.2100158043, 442423.0, 442656.0, 442796.78601606784, 442918.0, 20907.790922090586, 21413.464663382918, 23209.419764506023, 23550.882245588662, 23679.52640947206, 39534.0, 40376.79811600923, 40400.79799600983, 40677.389839151845, 40766.388504173054, 33188.668113318556, 33844.492332614536, 33858.8307058473, 34661.48007779936, 35067.0, 33339.33321333608, 33479.0, 33858.83070584631, 34299.0, 34405.139871503416, 32113.357732844746, 32364.676353237108, 32431.864884728922, 32670.673293266762, 32712.182195445304, 28875.5668664966, 29745.0, 29804.721480637545, 29827.10518684443, 29950.70049299479, 17987.23730450295, 19394.0, 22322.330330090124, 22581.43546411353, 22675.319740407813], "value": 18535.17979760024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.71282607283644, 391.81780472080476, 392.32324240684824, 401.77902153815404, 421.93881887126366, 13198.868011319884, 19610.607787844252, 20518.38444846657, 20699.275525356596, 20787.896060519695, 16653.167341632932, 17150.828491715078, 20098.397048088544, 21005.579888402262, 21519.462013449673, 5870.589058765878, 6188.597741146834, 6211.068339749051, 6216.564840461147, 6223.844403889893, 5723.942760572403, 6022.759089636409, 6083.48290395317, 6149.016157414814, 6209.503239740832, 5943.435373639519, 6098.298695649991, 6103.42017508336, 6108.083787431899, 6113.6943152842405, 5505.972470137664, 5837.211976383176, 5885.999380105392, 6045.123457098718, 6105.847353816146, 5334.146536554133, 5339.0, 5348.0, 5353.892922141575, 5354.866128346784, 25455.490890182093, 26330.473390532272, 26355.0, 26450.206493805217, 26834.46331073387, 2684.8791804368852, 2706.878190481433, 2711.430599574072, 2715.7827373810046, 2723.904663336774, 15340.309686064154, 16095.03429794216, 16100.677986440323, 16314.918425407797, 17008.48974530766, 1867.9439616811517, 1890.0283852237753, 1894.810518948108, 1910.8949007804565, 1945.3464555128169, 122966.0, 124509.13236301462, 126615.36692316571, 127764.99999999907, 128165.35917320354, 11416.0, 11450.828237576443, 11526.481308341145, 11703.941480292715, 11757.588484403175, 14686.55940321792, 14699.41202351894, 14700.705985880222, 14710.0438471499, 14721.0, 7635.770926872203, 7725.304722574995, 8845.51349675774, 8864.468131912106, 8944.597493112826, 8428.789280268042, 8551.828963420698, 8599.678086916498, 8888.022317545065, 8976.640934362684, 6212.658303793335, 7298.0, 7401.594481793331, 7489.70041198346, 7501.137369202503, 1676.7484877268507, 1941.1167918597005, 1981.4247673099633, 1990.9203631854564, 1993.5215548268602, 1012.2762225009154, 1048.6772591660147, 1051.3429106808244, 1057.1331508163387, 1080.2006515178712, 21280.653406821544, 22824.771752282264, 23143.768562314162, 23162.768372316063, 23472.178473753338, 971.2327261463365, 1062.7290041039485, 1099.8900109988938, 1112.3048094940661, 1115.938623375722, 11079.944600276947, 11813.686186821724, 11848.466818993165, 11971.52113915451, 11984.940075299568, 578368.0, 596459.0, 599822.0, 605458.0, 606372.0, 103126.0, 119343.40328298302, 120231.79768202381, 122734.0, 127801.0, 1064.80301144287, 1065.4406436620682, 1091.6561283195767, 1094.3543309447464, 1094.3980810554322, 19574.314898978468, 19873.205071796965, 19883.403497895088, 19921.60156796885, 19934.30229941945, 38685.41971870368, 54689.63275918134, 56291.43708562862, 56291.71854140867, 56487.58781030507, 63027.0, 63343.0, 81374.0, 82492.0, 91384.54307728684, 8115.837683246184, 8202.753917382488, 8212.46618969765, 8522.36082293818, 8697.0, 9202.631894724404, 12360.938195308965, 12988.48046078184, 13248.337583120998, 13270.933645332098, 10698.144148467949, 10790.1367890567, 10932.726681833017, 11212.66362009141, 11328.150388720715, 9333.626654933998, 9961.800763984535, 10846.457677115955, 10977.341359518454, 11238.66284011481, 11324.773504530029, 11684.766304674029, 11697.590584329508, 11763.588274410355, 11777.23447975913, 8286.047104582809, 8435.367347448842, 8445.831083378422, 8526.275266602408, 8562.91437085646, 5518.061929471919, 6737.62943038118, 9051.185393314634, 10896.61861834832, 11305.547778088785], "value": 9972.45898794723, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.6032190342894, 1419.7870319452081, 1422.8648278413548, 1432.8065711129002, 1439.964000899977, 7970.641321140548, 8375.95812020939, 8389.706360277392, 8404.621792019367, 8404.747857564267, 7114.893276600855, 7368.373688236493, 7378.704851805921, 7958.92041079589, 8089.0, 1825.6713791517523, 2143.6998820165227, 2155.407263002679, 2180.5529866377356, 2187.354730354541, 2282.942926426844, 2314.9652755208685, 2326.5579539887367, 2327.2552783109413, 2330.7436182019965, 2001.949951251216, 2068.172730907634, 2239.955200895989, 2280.1791355112227, 2306.4695120122383, 2309.7574754650773, 2310.4801419680607, 2315.2938353802083, 2317.2700599311247, 2321.7446080931086, 2057.611112499057, 2196.791304826039, 2235.3405745305013, 2288.0, 2320.9419764505856, 8227.71203007892, 8297.419180657356, 8315.916840831575, 8321.126281740451, 8323.708670196515, 4973.204287314049, 5113.7443127843835, 5113.974430127862, 5116.76974536143, 5131.076406246874, 3166.936661266785, 3304.9173770655684, 3337.5327454156436, 3372.4266874631126, 3376.5104059911423, 1129.2095533126844, 1178.522698307187, 1217.8355921950513, 1220.0788404754442, 1246.7007918099591, 10074.244431667654, 10493.947530262376, 10540.841887371696, 10657.200709946708, 10676.0, 4378.233809083461, 4525.773711314421, 4587.3807036050375, 4618.95381046192, 4636.959737715462, 9399.812003760024, 9408.388454750419, 9416.964133945261, 9420.293477989178, 9424.575894084783, 5025.79896804131, 5028.798848046037, 5136.640435169502, 5143.819966301162, 5146.433892271847, 3826.3877779555137, 4167.958320416757, 4601.838935637236, 4713.222318317507, 4715.504871988461, 3757.192203676168, 3770.5852356240794, 3828.464015037897, 3854.209886973164, 3879.903002424962, 1267.2776517385003, 1268.6194141757621, 1273.7834568123442, 1287.4914408808468, 1288.2914397081568, 814.2834305810849, 836.7280633794041, 845.6321500147455, 877.9429337093069, 879.6613303878053, 4937.7777999990085, 5039.916417970154, 5072.41320880718, 5360.651557648818, 5367.865803354947, 459.4326007380882, 542.6798189068469, 554.8376151961634, 570.1903297317818, 570.7517230004961, 2699.284689557269, 3375.6793104655508, 3377.915552111217, 3378.611459682119, 3423.503591979149, 9568.330216884751, 9809.607615695435, 9872.555734991942, 9945.751356216153, 9952.651657191964, 9862.063104005108, 9862.358946668444, 9872.703818885446, 9901.257405694458, 9928.80142397148, 7709.6870938719285, 7754.883676744853, 7781.610919454005, 7871.409644276702, 7873.173316801768, 5049.873753156054, 5094.923576146287, 5102.591792656504, 5162.174052151638, 5194.558462530727, 8938.24024957886, 8941.239994600532, 8953.0, 9087.04586018485, 9203.76990575241, 9067.138621830916, 9197.402168859002, 9228.815423691623, 9309.44143351401, 9328.067193280618, 6428.260750013808, 6640.369164929324, 6847.657617119224, 7051.929480705333, 7152.24901385347, 7910.7231246906085, 7956.681732730626, 7976.1226265109635, 7981.2018798119725, 7996.24035716606, 7006.544574602634, 7087.574745515286, 7136.750213742494, 7161.713531458683, 7221.350078492961, 6762.830929226612, 6794.456443484608, 6923.411510021705, 6992.720291188499, 6998.475114366544, 5925.822225333247, 6101.115338275837, 6155.47678447337, 6176.969115154575, 6181.598196117238, 4553.954460455486, 4611.216093264086, 4639.048994955959, 4660.184467718203, 4761.738104404291, 3785.6971442285103, 4590.2426099693175, 4646.83736069236, 4708.223143181337, 4855.975720121377], "value": 4225.313711367277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6149815951533, 354.3126334910274, 360.9169890925088, 369.92601479704064, 373.441704651546, 4399.582039706231, 5151.702910137515, 5179.4561571035065, 5186.8703282417955, 5199.3760748710165, 4082.265192265391, 4415.549370099593, 4852.2721591761165, 4877.341558889549, 4993.975030124853, 3637.908627411779, 3754.3805272130203, 4033.7176397652174, 4057.736247143941, 4089.631933126018, 3738.5887552369354, 3799.9430008549894, 3879.398693202558, 4092.877213683579, 4104.589541045902, 3193.680631936811, 3588.7308451866083, 3823.973294154103, 4039.757614543122, 4050.9670034141254, 3503.8072905990034, 3744.7753134811996, 3966.147278335172, 4051.3315302974975, 4067.3898915162813, 2878.7984841061134, 2962.540806175025, 3439.638837922007, 3587.1749497615697, 3591.8089965121517, 4557.4504668412565, 4770.904581908342, 4975.353204083446, 5031.798728050873, 5066.544011039025, 3579.4451859961746, 4597.241455159895, 4656.298242896905, 4666.113438446719, 4678.508756580578, 4760.071786001731, 5442.693753499171, 5443.945560544384, 5475.260839786618, 5539.723013849291, 3624.58317293512, 3717.442383642448, 3921.313770090251, 3984.442178095069, 3999.5800440953863, 5313.415524292324, 5368.436314187033, 5704.515116215127, 5755.251817263729, 5796.159556864273, 3183.567394672407, 3207.8988262687976, 3542.7165826734313, 3821.7706937583835, 3825.3496905526126, 3883.834849545125, 3887.358585833306, 3907.316219661548, 3922.3920292354733, 3928.64642182205, 3957.485526881487, 4202.810873510699, 4517.367568540407, 4523.2988886722615, 4592.954070459253, 4630.976845115752, 5191.714455704972, 5263.578753773307, 5310.8141215057285, 5476.370217424967, 1243.3907385381278, 1254.4480428611382, 1256.8805963433458, 1259.603224984127, 1266.7466506698697, 718.6945548142019, 824.3652387661467, 825.793551612097, 838.5262326785347, 842.9968337678143, 4282.758000179975, 4470.687051906335, 4754.762261886892, 4782.187028205213, 4962.478939711351, 4701.506341834127, 4708.422678402705, 5344.518993290622, 5363.061464243741, 5465.098258787256, 3782.7541209821275, 4194.30793919006, 4357.975875669215, 4723.267893476516, 4818.831340903122, 2545.6762483508473, 2620.056779559357, 2793.720627937231, 2800.2439341377712, 2811.9297017574722, 4306.2894622387585, 4575.473820510617, 4909.901801963941, 5360.391882435254, 5592.651086543661, 4499.4150760400935, 5046.899062018739, 5047.520485553867, 5091.618128640367, 5525.530329922001, 5125.487981045675, 5837.620554663848, 5862.882742345215, 5868.325142608569, 5924.37079803049, 5007.624428167975, 5091.974540127276, 5264.8674038946765, 5578.3584887738425, 5759.337676167294, 5123.747289749574, 5221.373435187802, 5316.777141257609, 5552.917655879045, 5559.8610034747835, 5487.478689524489, 5891.407780576533, 5894.941050589439, 5955.67243801595, 5964.7912323068485, 3624.52881125452, 3701.0932321581386, 3835.5397352316786, 3836.48207491985, 3861.45939568455, 4963.875903102451, 5118.0039784484825, 5318.8936221276135, 5419.403865574863, 5598.496135347838, 5116.386033675983, 5429.348478182644, 5454.881749241316, 5459.744258820573, 5476.3702174250475, 4935.358403407534, 5258.868528286824, 5434.266374039612, 5440.191865694109, 5442.945570544244, 4629.884252893705, 4890.877728056827, 5424.83725488236, 5433.891322173456, 5458.945410546003, 4682.836100736458, 5366.570674345965, 5379.310344827586, 5391.919121213106, 5481.972590137024, 5381.246625472359, 5403.13549832025, 5426.321709786277, 5445.863853403696, 5506.201600767947], "value": 3940.226437815307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2790667472514, 743.9404847612192, 765.3073968058909, 819.8278361544076, 828.428384414754, 14715.48495802647, 15593.142377169252, 15621.0, 15650.530484085468, 15713.214339283033, 14358.210298433609, 14515.49195778148, 14542.781858272134, 14546.0, 14560.344784484698, 667.3860048755157, 689.3520091114336, 691.2672567078887, 836.4270474724802, 856.3021137772727, 838.0571856661256, 854.3336197765752, 854.6752234151014, 855.7689423855555, 856.2764464027887, 914.8353296406644, 915.7847905742145, 919.7608621758324, 920.4431319051978, 923.2567782934735, 699.1435491522894, 719.6042176802738, 883.0683628771643, 914.6158613382362, 915.1077699243218, 678.1455366238525, 683.6684208159039, 684.3977299976038, 685.348918527401, 686.2177118085336, 14800.333984970595, 15148.394064237416, 15179.696406071816, 15183.0, 15195.848041519554, 13690.65773355674, 13806.86193138076, 13810.93094534531, 13833.446662133603, 14031.579052628438, 12305.507779688802, 12474.59311715741, 12515.311657858814, 12623.684407889785, 12769.55306564275, 4395.1868904252815, 4475.552444755531, 4549.31760235964, 4557.202489564346, 4656.8602941911795, 100492.99507004983, 104181.47909260482, 104493.89332440175, 104721.0, 104845.0, 11004.119670426508, 11025.944870275758, 11039.39283339408, 11058.391788451552, 11524.481398337095, 21598.892005540187, 21609.919504024736, 21681.891590541945, 21706.565868682537, 21711.782882170977, 7491.8501629967095, 7504.399648028145, 7505.362044226193, 7607.087149542091, 7614.58119803405, 4073.7148399612333, 4129.0, 4242.406063151161, 4252.29837076885, 4275.657947364203, 3110.206897241189, 3181.2683082891062, 3230.3700778347998, 3233.8868139615, 3234.5148227765553, 592.2892528965173, 595.1221947627215, 601.8736065426309, 605.2464681471508, 611.0528680545137, 637.9011253255753, 639.8944174211204, 652.4030512081487, 663.5521023309343, 678.8845896197658, 9359.204467620193, 9457.905420945703, 9786.168175705003, 9937.950310248547, 9994.850077248848, 588.5732843688291, 635.6249812610582, 674.2246416620925, 674.4907594766019, 696.244574636525, 4596.839110631112, 4752.1921273383605, 4794.760261986957, 4858.344123543347, 5234.848333366654, 86559.0, 91216.6317505238, 93442.53278733563, 98425.0, 98832.50583747035, 90797.0, 92379.0, 94282.52858735662, 94400.52799735958, 95446.0, 79737.20262797414, 80779.0, 81144.59427702942, 81459.18540814516, 83477.31317615538, 10587.417692027013, 10755.753319891564, 10851.0, 10974.945125274322, 11066.0, 50476.0, 50668.49331506638, 51042.0, 51682.96634067373, 51702.48297516977, 66889.66555167193, 67444.6627766858, 68488.3151168482, 68684.0, 70852.0, 12970.22178669283, 13047.0, 13138.408771605491, 13273.402696878857, 13519.256440895846, 14476.638084047983, 14581.343839527035, 14653.267336633338, 14878.925605371904, 15329.770053448985, 13679.153314302443, 13709.314534273446, 14027.438902443788, 14155.363008664428, 14412.639684007983, 13825.861741382458, 13915.652108697364, 14030.158190508602, 14071.437142514595, 14502.709945801236, 13363.1313964592, 13683.589492315246, 13689.794653080411, 14106.2946852659, 14124.43502259898, 9472.621095156117, 10937.617183398543, 11203.611684037496, 11303.604373846876, 11618.477168527606, 9560.426374417557, 9739.610415583298, 10838.837417438903, 11084.390358530358, 11088.667339979813], "value": 7516.494610217416, "unit": "score"}], "name": "dromaeo_css", "value": 7135.897719958181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 114.0, 112.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 143.0, 144.0, 147.0, 112.0, 112.0, 112.0, 110.0, 133.0, 112.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 182.0, 186.0, 182.0, 185.0, 181.0, 184.0, 184.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 52.0, 51.0, 110.0, 88.0, 60.0, 59.0, 60.0, 75.0, 59.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 84.0, 70.0, 68.0, 71.0, 83.0, 69.0, 69.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 87.0, 89.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 116.0, 119.0, 95.0, 95.0, 108.0, 130.0, 95.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 88.0, 85.0, 88.0, 86.0, 86.0, 85.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 54.0, 56.0, 55.0, 55.0, 54.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 67.0, 77.0, 74.0, 72.0, 75.0, 74.0, 74.0, 75.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 102.0, 106.0, 87.0, 86.0, 90.0, 87.0, 90.0, 90.0, 88.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 164.0, 140.0, 139.0, 142.0, 140.0, 142.0, 170.0, 142.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 222.0, 174.0, 175.0, 182.0, 216.0, 176.0, 173.0, 174.0, 169.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 78.0, 89.0, 71.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1474.5000000000002, "alertThreshold": 2.0}]} 18:39:07 INFO - Return code: 0 18:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:07 ERROR - # TBPL SUCCESS # 18:39:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:39:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:39:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:39:07 INFO - 2017-01-25 18:39:07.719 screenresolution[1920:23269] starting screenresolution argv=screenresolution get 18:39:07 INFO - 2017-01-25 18:39:07.721 screenresolution[1920:23269] Display 0: 1600x1200x32@60 18:39:07 INFO - 2017-01-25 18:39:07.728 screenresolution[1921:23272] starting screenresolution argv=screenresolution list 18:39:07 INFO - Available Modes on Display 0 18:39:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:39:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:39:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:39:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:39:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:39:07 INFO - Intel Iris: 18:39:07 INFO - Chipset Model: Intel Iris 18:39:07 INFO - Type: GPU 18:39:07 INFO - Bus: Built-In 18:39:07 INFO - VRAM (Dynamic, Max): 1536 MB 18:39:07 INFO - Vendor: Intel (0x8086) 18:39:07 INFO - Device ID: 0x0a2e 18:39:07 INFO - Revision ID: 0x0009 18:39:07 INFO - Displays: 18:39:07 INFO - Display: 18:39:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:39:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:39:07 INFO - Display Serial Number: 1600x1200 60 18:39:07 INFO - Main Display: Yes 18:39:07 INFO - Mirror: Off 18:39:07 INFO - Online: Yes 18:39:07 INFO - Rotation: Supported 18:39:07 INFO - Return code: 0 18:39:07 INFO - Running post-action listener: _resource_record_post_action 18:39:07 INFO - [mozharness: 2017-01-26 02:39:07.964675Z] Finished run-tests step (success) 18:39:07 INFO - Running post-run listener: _resource_record_post_run 18:39:08 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 331776; Write bytes: 551547904; Read time: 5; Write time: 1642 18:39:08 INFO - TinderboxPrint: CPU usage
53.6% 18:39:08 INFO - TinderboxPrint: I/O read bytes / time
331,776 / 5 18:39:08 INFO - TinderboxPrint: I/O write bytes / time
551,547,904 / 1,642 18:39:08 INFO - TinderboxPrint: CPU idle
2,231.1 (46.4%) 18:39:08 INFO - TinderboxPrint: CPU system
958.6 (19.9%) 18:39:08 INFO - TinderboxPrint: CPU user
1,615.9 (33.6%) 18:39:08 INFO - TinderboxPrint: Swap in / out
250,802,176 / 0 18:39:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245002752; Write bytes: 237514752; Read time: 18055; Write time: 486 18:39:08 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 294912; Write bytes: 298529792; Read time: 5; Write time: 1115 18:39:08 INFO - Running post-run listener: _upload_blobber_files 18:39:08 INFO - Blob upload gear active. 18:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:08 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 18:39:08 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:08 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:09 INFO - (blobuploader) - INFO - Done attempting. 18:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:10 INFO - (blobuploader) - INFO - Done attempting. 18:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:11 INFO - (blobuploader) - INFO - Done attempting. 18:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:13 INFO - (blobuploader) - INFO - Done attempting. 18:39:13 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:13 INFO - Return code: 0 18:39:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc11bf0777f6651a22072c21b3cf69985230c1bfb1195f89c25e6bb81a16b26bdff9da1ddcdb71315d999ec9999d9fcfcd0266f6d3610b552ea3b91235d1a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9763250652572d90763e17658e16cd749c93c2926e6eceb518dbb44312d952404033a87c207a146c859836e5b09814336c5ac4752adabdac986cb90c32c7c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a34bad75bd75839548fa2644f3591e16da15fdbac7107b9842e2dc7a9a65acb80a66492f32c626e65e06ec49a8b58f72d57fd9ca56f07ce2efb0ae8d424f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34496ca6144d0a1ebe154dd80b69fc25958da80327c04a6abd6954e7bc144cc86d8c8fdb0607ea9a93954b68a7169cb8a290352e765719616d2683ace34fe5e4"} 18:39:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:13 INFO - Contents: 18:39:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc11bf0777f6651a22072c21b3cf69985230c1bfb1195f89c25e6bb81a16b26bdff9da1ddcdb71315d999ec9999d9fcfcd0266f6d3610b552ea3b91235d1a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9763250652572d90763e17658e16cd749c93c2926e6eceb518dbb44312d952404033a87c207a146c859836e5b09814336c5ac4752adabdac986cb90c32c7c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a34bad75bd75839548fa2644f3591e16da15fdbac7107b9842e2dc7a9a65acb80a66492f32c626e65e06ec49a8b58f72d57fd9ca56f07ce2efb0ae8d424f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34496ca6144d0a1ebe154dd80b69fc25958da80327c04a6abd6954e7bc144cc86d8c8fdb0607ea9a93954b68a7169cb8a290352e765719616d2683ace34fe5e4"} 18:39:13 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:13 INFO - Copying logs to upload dir... 18:39:13 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.746524 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 18:39:13.671542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 18:39:13.675039) ========= 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.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/Firefox/sha512/fc11bf0777f6651a22072c21b3cf69985230c1bfb1195f89c25e6bb81a16b26bdff9da1ddcdb71315d999ec9999d9fcfcd0266f6d3610b552ea3b91235d1a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9763250652572d90763e17658e16cd749c93c2926e6eceb518dbb44312d952404033a87c207a146c859836e5b09814336c5ac4752adabdac986cb90c32c7c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a34bad75bd75839548fa2644f3591e16da15fdbac7107b9842e2dc7a9a65acb80a66492f32c626e65e06ec49a8b58f72d57fd9ca56f07ce2efb0ae8d424f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34496ca6144d0a1ebe154dd80b69fc25958da80327c04a6abd6954e7bc144cc86d8c8fdb0607ea9a93954b68a7169cb8a290352e765719616d2683ace34fe5e4"} build_url:https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/AW7Wf9BqQ3qtB5gSZgSQVg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc11bf0777f6651a22072c21b3cf69985230c1bfb1195f89c25e6bb81a16b26bdff9da1ddcdb71315d999ec9999d9fcfcd0266f6d3610b552ea3b91235d1a7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a9763250652572d90763e17658e16cd749c93c2926e6eceb518dbb44312d952404033a87c207a146c859836e5b09814336c5ac4752adabdac986cb90c32c7c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a34bad75bd75839548fa2644f3591e16da15fdbac7107b9842e2dc7a9a65acb80a66492f32c626e65e06ec49a8b58f72d57fd9ca56f07ce2efb0ae8d424f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34496ca6144d0a1ebe154dd80b69fc25958da80327c04a6abd6954e7bc144cc86d8c8fdb0607ea9a93954b68a7169cb8a290352e765719616d2683ace34fe5e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 18:39:13.709531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:39:13.709909) ========= 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.exU05KBuY1/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.3xzU0hUFhy/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005239 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 18:39:13.758223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 18:39:13.758505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 18:39:13.758809) ========= ========= Total master_lag: 0.19 =========