builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1484971087.52 results: success (0) buildid: 20170120185226 builduid: f8aa9ad37fd043e285a22fa064f14bed revision: 41d8ef56d03b9b5b382d0575def6712d9d51b1df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.524131) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.524550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.524825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.550562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.550823) ========= 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.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-20 19:58:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2017-01-20 19:58:07 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.737566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.737880) ========= 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.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.027161 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:07.787049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 19:58:07.787394) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 41d8ef56d03b9b5b382d0575def6712d9d51b1df --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 41d8ef56d03b9b5b382d0575def6712d9d51b1df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-20 19:58:07,889 truncating revision to first 12 chars 2017-01-20 19:58:07,889 Setting DEBUG logging. 2017-01-20 19:58:07,889 attempt 1/10 2017-01-20 19:58:07,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/41d8ef56d03b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 19:58:09,630 unpacking tar archive at: mozilla-central-41d8ef56d03b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.011524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 19:58:09.822620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:09.822955) ========= script_repo_revision: 41d8ef56d03b9b5b382d0575def6712d9d51b1df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:09.823340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:09.823605) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 19:58:09.843029) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-20 19:58:09.843297) ========= /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.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:10 INFO - MultiFileLogger online at 20170120 19:58:10 in /builds/slave/test 19:58:10 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 19:58:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:10 INFO - {'append_to_log': False, 19:58:10 INFO - 'base_work_dir': '/builds/slave/test', 19:58:10 INFO - 'blob_upload_branch': 'Firefox', 19:58:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:10 INFO - 'branch': 'Firefox', 19:58:10 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:10 INFO - 'config_files': ('talos/mac_config.py',), 19:58:10 INFO - 'default_actions': ('clobber', 19:58:10 INFO - 'read-buildbot-config', 19:58:10 INFO - 'download-and-extract', 19:58:10 INFO - 'populate-webroot', 19:58:10 INFO - 'create-virtualenv', 19:58:10 INFO - 'install', 19:58:10 INFO - 'run-tests'), 19:58:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:10 INFO - 'download_minidump_stackwalk': True, 19:58:10 INFO - 'download_symbols': 'ondemand', 19:58:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:10 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:10 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:10 INFO - 'installer_path': 'installer.exe', 19:58:10 INFO - 'log_level': 'info', 19:58:10 INFO - 'log_name': 'talos', 19:58:10 INFO - 'log_to_console': True, 19:58:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:58:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:58:10 INFO - 'opt_config_files': (), 19:58:10 INFO - 'pip_index': False, 19:58:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:58:10 INFO - 'cmd': ('bash', 19:58:10 INFO - '-c', 19:58:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:58:10 INFO - 'enabled': True, 19:58:10 INFO - 'halt_on_failure': False, 19:58:10 INFO - 'name': 'check_screen_resolution'},), 19:58:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:58:10 INFO - 'cmd': ('bash', 19:58:10 INFO - '-c', 19:58:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:58:10 INFO - 'enabled': True, 19:58:10 INFO - 'halt_on_failure': False, 19:58:10 INFO - 'name': 'check_screen_resolution'},), 19:58:10 INFO - 'run_cmd_checks_enabled': True, 19:58:10 INFO - 'sps_profile': False, 19:58:10 INFO - 'sps_profile_interval': 0, 19:58:10 INFO - 'suite': 'dromaeojs', 19:58:10 INFO - 'system_bits': '32', 19:58:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:10 INFO - 'title': 't-yosemite-r7-0097', 19:58:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:10 INFO - 'use_talos_json': True, 19:58:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:10 INFO - 'work_dir': 'build'} 19:58:10 INFO - [mozharness: 2017-01-21 03:58:10.057150Z] Running clobber step. 19:58:10 INFO - Running pre-action listener: _resource_record_pre_action 19:58:10 INFO - Running main action method: clobber 19:58:10 INFO - rmtree: /builds/slave/test/build 19:58:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:12 INFO - Running post-action listener: _resource_record_post_action 19:58:12 INFO - [mozharness: 2017-01-21 03:58:12.665955Z] Finished clobber step (success) 19:58:12 INFO - [mozharness: 2017-01-21 03:58:12.666125Z] Running read-buildbot-config step. 19:58:12 INFO - Running pre-action listener: _resource_record_pre_action 19:58:12 INFO - Running main action method: read_buildbot_config 19:58:12 INFO - Using buildbot properties: 19:58:12 INFO - { 19:58:12 INFO - "project": "", 19:58:12 INFO - "product": "firefox", 19:58:12 INFO - "script_repo_revision": "production", 19:58:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:58:12 INFO - "repository": "", 19:58:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:58:12 INFO - "buildid": "20170120185226", 19:58:12 INFO - "pgo_build": "False", 19:58:12 INFO - "basedir": "/builds/slave/test", 19:58:12 INFO - "buildnumber": 19, 19:58:12 INFO - "slavename": "t-yosemite-r7-0097", 19:58:12 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:58:12 INFO - "platform": "yosemite_r7", 19:58:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:58:12 INFO - "branch": "mozilla-central", 19:58:12 INFO - "repo_path": "mozilla-central", 19:58:12 INFO - "revision": "41d8ef56d03b9b5b382d0575def6712d9d51b1df", 19:58:12 INFO - "stage_platform": "macosx64", 19:58:12 INFO - "builduid": "f8aa9ad37fd043e285a22fa064f14bed", 19:58:12 INFO - "slavebuilddir": "test" 19:58:12 INFO - } 19:58:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:58:12 INFO - Running post-action listener: _resource_record_post_action 19:58:12 INFO - [mozharness: 2017-01-21 03:58:12.669498Z] Finished read-buildbot-config step (success) 19:58:12 INFO - [mozharness: 2017-01-21 03:58:12.669640Z] Running download-and-extract step. 19:58:12 INFO - Running pre-action listener: _resource_record_pre_action 19:58:12 INFO - Running main action method: download_and_extract 19:58:12 INFO - mkdir: /builds/slave/test/build/tests 19:58: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')]} 19:58:12 INFO - trying https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:58:12 INFO - Downloading https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:58:13 INFO - Downloaded 1199 bytes. 19:58:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:58:13 INFO - Using the following test package requirements: 19:58:13 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:58:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:58:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:58:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'jsshell-mac.zip'], 19:58:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:58:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:58:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:58:13 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:58:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:58:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:58:13 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:58:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:58:14 INFO - Expected file size: 16345805 19:58:14 INFO - Obtained file size: 16345805 19:58:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:58:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:58:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:58:21 INFO - Fetch https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:58:22 INFO - Expected file size: 16345805 19:58:22 INFO - Obtained file size: 16345805 19:58:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:58:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:58:28 INFO - Fetch https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:58:29 INFO - Expected file size: 14403476 19:58:29 INFO - Obtained file size: 14403476 19:58: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')]} 19:58:30 INFO - trying https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:58:32 INFO - Downloaded 69989260 bytes. 19:58:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:58:32 INFO - mkdir: /builds/slave/test/properties 19:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:58:32 INFO - Writing to file /builds/slave/test/properties/build_url 19:58:32 INFO - Contents: 19:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:58:33 INFO - Running post-action listener: _resource_record_post_action 19:58:33 INFO - Running post-action listener: set_extra_try_arguments 19:58:33 INFO - [mozharness: 2017-01-21 03:58:33.250654Z] Finished download-and-extract step (success) 19:58:33 INFO - [mozharness: 2017-01-21 03:58:33.250802Z] Running populate-webroot step. 19:58:33 INFO - Running pre-action listener: _resource_record_pre_action 19:58:33 INFO - Running main action method: populate_webroot 19:58:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:33 INFO - '--tppagecycles', 19:58:33 INFO - '7'], 19:58:33 INFO - 'tests': ['tsvgm']}}, 19:58:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:58:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:58:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:58:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['damp', 'tps']}, 19:58:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'tests': ['damp', 'tps']}, 19:58:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['dromaeo_dom']}, 19:58:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['basic_compositor_video']}, 19:58:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:58:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'other-e10s': {'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['a11yr', 19:58:33 INFO - 'ts_paint', 19:58:33 INFO - 'tpaint', 19:58:33 INFO - 'sessionrestore', 19:58:33 INFO - 'sessionrestore_no_auto_restore', 19:58:33 INFO - 'tabpaint']}, 19:58:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['tsvgx', 19:58:33 INFO - 'tsvgr_opacity', 19:58:33 INFO - 'tart', 19:58:33 INFO - 'tscrollx', 19:58:33 INFO - 'cart', 19:58:33 INFO - 'tsvg_static']}, 19:58:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:58:33 INFO - 'tsvgr_opacity', 19:58:33 INFO - 'tart', 19:58:33 INFO - 'tscrollx', 19:58:33 INFO - 'cart', 19:58:33 INFO - 'tsvg_static']}, 19:58:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'talos_options': ['--disable-e10s'], 19:58:33 INFO - 'tests': ['tp5o']}, 19:58:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:58:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'talos_options': ['--disable-e10s', 19:58:33 INFO - '--xperf_path', 19:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:33 INFO - 'tests': ['tp5n']}, 19:58:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:58:33 INFO - 'talos_options': ['--xperf_path', 19:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:33 INFO - 'tests': ['tp5n']}}, 19:58:33 INFO - 'talos.zip': {'path': '', 19:58:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:33 INFO - Running post-action listener: _resource_record_post_action 19:58:33 INFO - [mozharness: 2017-01-21 03:58:33.269185Z] Finished populate-webroot step (success) 19:58:33 INFO - [mozharness: 2017-01-21 03:58:33.269278Z] Running create-virtualenv step. 19:58:33 INFO - Running pre-action listener: _resource_record_pre_action 19:58:33 INFO - Running main action method: create_virtualenv 19:58:33 INFO - Creating virtualenv /builds/slave/test/build/venv 19:58: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 19:58:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:58:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:33 INFO - Using real prefix '/tools/python27' 19:58:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:58:34 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:36 INFO - Installing pip.................done. 19:58:36 INFO - Return code: 0 19:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:58:37 INFO - Reading from file tmpfile_stdout 19:58:37 INFO - Output received: 19:58:37 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) 19:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:38 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:38 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 19:58:38 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 19:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:38 INFO - 'HOME': '/Users/cltbld', 19:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:38 INFO - 'LOGNAME': 'cltbld', 19:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:38 INFO - 'MOZ_NO_REMOTE': '1', 19:58:38 INFO - 'NO_EM_RESTART': '1', 19:58:38 INFO - 'PAGER': '/bin/cat', 19:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:38 INFO - 'PWD': '/builds/slave/test', 19:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:38 INFO - 'SHELL': '/bin/bash', 19:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:38 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:38 INFO - 'USER': 'cltbld', 19:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:38 INFO - 'XPC_FLAGS': '0x0', 19:58:38 INFO - 'XPC_SERVICE_NAME': '0', 19:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:38 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 19:58:38 INFO - Cleaning up... 19:58:38 INFO - Return code: 0 19:58:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:58:38 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')]} 19:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:38 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')]} 19:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:38 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:38 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 19:58:38 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 19:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:38 INFO - 'HOME': '/Users/cltbld', 19:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:38 INFO - 'LOGNAME': 'cltbld', 19:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:38 INFO - 'MOZ_NO_REMOTE': '1', 19:58:38 INFO - 'NO_EM_RESTART': '1', 19:58:38 INFO - 'PAGER': '/bin/cat', 19:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:38 INFO - 'PWD': '/builds/slave/test', 19:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:38 INFO - 'SHELL': '/bin/bash', 19:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:38 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:38 INFO - 'USER': 'cltbld', 19:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:38 INFO - 'XPC_FLAGS': '0x0', 19:58:38 INFO - 'XPC_SERVICE_NAME': '0', 19:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:38 INFO - Downloading/unpacking psutil>=3.1.1 19:58:38 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 19:58:38 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 19:58:38 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 19:58:38 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 19:58:38 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 19:58:38 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 19:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:42 INFO - Installing collected packages: psutil 19:58:42 INFO - Running setup.py install for psutil 19:58:42 INFO - building 'psutil._psutil_osx' extension 19:58:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:58:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:58:43 INFO - building 'psutil._psutil_posix' extension 19:58:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:58:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:58:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:58:43 INFO - ^ 19:58:43 INFO - 1 warning generated. 19:58:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:43 INFO - Successfully installed psutil 19:58:43 INFO - Cleaning up... 19:58:43 INFO - Return code: 0 19:58:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:43 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:43 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 19:58:43 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 19:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:43 INFO - 'HOME': '/Users/cltbld', 19:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:43 INFO - 'LOGNAME': 'cltbld', 19:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:43 INFO - 'MOZ_NO_REMOTE': '1', 19:58:43 INFO - 'NO_EM_RESTART': '1', 19:58:43 INFO - 'PAGER': '/bin/cat', 19:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:43 INFO - 'PWD': '/builds/slave/test', 19:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:43 INFO - 'SHELL': '/bin/bash', 19:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:43 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:43 INFO - 'USER': 'cltbld', 19:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:43 INFO - 'XPC_FLAGS': '0x0', 19:58:43 INFO - 'XPC_SERVICE_NAME': '0', 19:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:58:46 INFO - Installing collected packages: mozsystemmonitor 19:58:46 INFO - Running setup.py install for mozsystemmonitor 19:58:47 INFO - Successfully installed mozsystemmonitor 19:58:47 INFO - Cleaning up... 19:58:47 INFO - Return code: 0 19:58:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:58:47 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')]} 19:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 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')]} 19:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:47 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 19:58:47 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 19:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:47 INFO - 'HOME': '/Users/cltbld', 19:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:47 INFO - 'LOGNAME': 'cltbld', 19:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:47 INFO - 'MOZ_NO_REMOTE': '1', 19:58:47 INFO - 'NO_EM_RESTART': '1', 19:58:47 INFO - 'PAGER': '/bin/cat', 19:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:47 INFO - 'PWD': '/builds/slave/test', 19:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:47 INFO - 'SHELL': '/bin/bash', 19:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:47 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:47 INFO - 'USER': 'cltbld', 19:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:47 INFO - 'XPC_FLAGS': '0x0', 19:58:47 INFO - 'XPC_SERVICE_NAME': '0', 19:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 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 19:58:50 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:50 INFO - warning: no files found matching '*.txt' 19:58:50 INFO - no previously-included directories found matching 'build' 19:58:50 INFO - no previously-included directories found matching 'dist' 19:58:50 INFO - no previously-included directories found matching '.git*' 19:58:50 INFO - Installing collected packages: jsonschema, functools32 19:58:50 INFO - Running setup.py install for functools32 19:58:50 INFO - warning: no files found matching '*.txt' 19:58:50 INFO - no previously-included directories found matching 'build' 19:58:50 INFO - no previously-included directories found matching 'dist' 19:58:50 INFO - no previously-included directories found matching '.git*' 19:58:50 INFO - Successfully installed jsonschema functools32 19:58:50 INFO - Cleaning up... 19:58:50 INFO - Return code: 0 19:58:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:50 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:50 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 19:58:50 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 19:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:50 INFO - 'HOME': '/Users/cltbld', 19:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:50 INFO - 'LOGNAME': 'cltbld', 19:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:50 INFO - 'MOZ_NO_REMOTE': '1', 19:58:50 INFO - 'NO_EM_RESTART': '1', 19:58:50 INFO - 'PAGER': '/bin/cat', 19:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:50 INFO - 'PWD': '/builds/slave/test', 19:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:50 INFO - 'SHELL': '/bin/bash', 19:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:50 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:50 INFO - 'USER': 'cltbld', 19:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:50 INFO - 'XPC_FLAGS': '0x0', 19:58:50 INFO - 'XPC_SERVICE_NAME': '0', 19:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:58:51 INFO - Cleaning up... 19:58:51 INFO - Return code: 0 19:58:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58:51 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')]} 19:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 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')]} 19:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:51 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 19:58:51 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 19:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:51 INFO - 'HOME': '/Users/cltbld', 19:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:51 INFO - 'LOGNAME': 'cltbld', 19:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:51 INFO - 'MOZ_NO_REMOTE': '1', 19:58:51 INFO - 'NO_EM_RESTART': '1', 19:58:51 INFO - 'PAGER': '/bin/cat', 19:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:51 INFO - 'PWD': '/builds/slave/test', 19:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:51 INFO - 'SHELL': '/bin/bash', 19:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:51 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:51 INFO - 'USER': 'cltbld', 19:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:51 INFO - 'XPC_FLAGS': '0x0', 19:58:51 INFO - 'XPC_SERVICE_NAME': '0', 19:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:55 INFO - Downloading docopt-0.6.1.tar.gz 19:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:55 INFO - Running setup.py install for blobuploader 19:58:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:55 INFO - Running setup.py install for requests 19:58:56 INFO - Running setup.py install for docopt 19:58:56 INFO - Successfully installed blobuploader requests docopt 19:58:56 INFO - Cleaning up... 19:58:56 INFO - Return code: 0 19:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:56 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:58:56 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 19:58:56 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 19:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:56 INFO - 'HOME': '/Users/cltbld', 19:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:56 INFO - 'LOGNAME': 'cltbld', 19:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:56 INFO - 'MOZ_NO_REMOTE': '1', 19:58:56 INFO - 'NO_EM_RESTART': '1', 19:58:56 INFO - 'PAGER': '/bin/cat', 19:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:56 INFO - 'PWD': '/builds/slave/test', 19:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:56 INFO - 'SHELL': '/bin/bash', 19:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:58:56 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:56 INFO - 'USER': 'cltbld', 19:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:56 INFO - 'XPC_FLAGS': '0x0', 19:58:56 INFO - 'XPC_SERVICE_NAME': '0', 19:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:56 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-pN5_nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:56 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-yPZjXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:56 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-rM5fH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:56 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-JFJoVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-fJ47DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-B97rNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-xwWEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-kgvbHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Y0NIdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-0SicIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Y0V8bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-SYWosl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-hKh9qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:57 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-q5Jngj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:58 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-2ln8U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:58 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-P0nO47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:58 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-cvbV7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:58 INFO - Running setup.py install for manifestparser 19:58:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:58 INFO - Running setup.py install for mozcrash 19:58:58 INFO - Running setup.py install for mozdebug 19:58:58 INFO - Running setup.py install for mozdevice 19:58:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Running setup.py install for mozfile 19:58:59 INFO - Running setup.py install for mozhttpd 19:58:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Running setup.py install for mozinfo 19:58:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Running setup.py install for mozInstall 19:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Running setup.py install for mozleak 19:58:59 INFO - Running setup.py install for mozlog 19:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:59 INFO - Running setup.py install for moznetwork 19:59:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Running setup.py install for mozprocess 19:59:00 INFO - Running setup.py install for mozprofile 19:59:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Running setup.py install for mozrunner 19:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Running setup.py install for mozscreenshot 19:59:00 INFO - Running setup.py install for moztest 19:59:00 INFO - Running setup.py install for mozversion 19:59:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:00 INFO - Cleaning up... 19:59:00 INFO - Return code: 0 19:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:01 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:59:01 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 19:59:01 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 19:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:01 INFO - 'HOME': '/Users/cltbld', 19:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:01 INFO - 'LOGNAME': 'cltbld', 19:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:01 INFO - 'MOZ_NO_REMOTE': '1', 19:59:01 INFO - 'NO_EM_RESTART': '1', 19:59:01 INFO - 'PAGER': '/bin/cat', 19:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:01 INFO - 'PWD': '/builds/slave/test', 19:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:01 INFO - 'SHELL': '/bin/bash', 19:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:59:01 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:01 INFO - 'USER': 'cltbld', 19:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:01 INFO - 'XPC_FLAGS': '0x0', 19:59:01 INFO - 'XPC_SERVICE_NAME': '0', 19:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-N0aQCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-EzIXG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ZQgqnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-I8SIkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-W78Oer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Ebg7t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:01 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)) 19:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:01 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-o3jz3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QG_6iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4zkuZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-jhrSPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-MBMhoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-U3dwSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-suSP2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-VlT9So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-rFZdBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-PeOkkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:02 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)) 19:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FTjRaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:03 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)) 19:59:03 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)) 19:59:03 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)) 19:59:03 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)) 19:59:03 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)) 19:59:03 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)) 19:59:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:03 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 19:59:03 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 19:59:03 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 19:59:03 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 19:59:03 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 19:59:03 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 19:59:05 INFO - Downloading blessings-1.6.tar.gz 19:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:05 INFO - Installing collected packages: blessings 19:59:05 INFO - Running setup.py install for blessings 19:59:05 INFO - Successfully installed blessings 19:59:05 INFO - Cleaning up... 19:59:06 INFO - Return code: 0 19:59:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:06 INFO - Reading from file tmpfile_stdout 19:59:06 INFO - Current package versions: 19:59:06 INFO - blessings == 1.6 19:59:06 INFO - blobuploader == 1.2.4 19:59:06 INFO - docopt == 0.6.1 19:59:06 INFO - functools32 == 3.2.3-2 19:59:06 INFO - jsonschema == 2.5.1 19:59:06 INFO - manifestparser == 1.1 19:59:06 INFO - mozInstall == 1.12 19:59:06 INFO - mozcrash == 1.0 19:59:06 INFO - mozdebug == 0.1 19:59:06 INFO - mozdevice == 0.49 19:59:06 INFO - mozfile == 1.2 19:59:06 INFO - mozhttpd == 0.7 19:59:06 INFO - mozinfo == 0.9 19:59:06 INFO - mozleak == 0.1 19:59:06 INFO - mozlog == 3.4 19:59:06 INFO - moznetwork == 0.27 19:59:06 INFO - mozprocess == 0.24 19:59:06 INFO - mozprofile == 0.28 19:59:06 INFO - mozrunner == 6.13 19:59:06 INFO - mozscreenshot == 0.1 19:59:06 INFO - mozsystemmonitor == 0.3 19:59:06 INFO - moztest == 0.8 19:59:06 INFO - mozversion == 1.4 19:59:06 INFO - psutil == 3.1.1 19:59:06 INFO - requests == 1.2.3 19:59:06 INFO - wsgiref == 0.1.2 19:59:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:06 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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:59:06 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 19:59:06 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 19:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:06 INFO - 'HOME': '/Users/cltbld', 19:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:06 INFO - 'LOGNAME': 'cltbld', 19:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:06 INFO - 'MOZ_NO_REMOTE': '1', 19:59:06 INFO - 'NO_EM_RESTART': '1', 19:59:06 INFO - 'PAGER': '/bin/cat', 19:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:06 INFO - 'PWD': '/builds/slave/test', 19:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:06 INFO - 'SHELL': '/bin/bash', 19:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:59:06 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:06 INFO - 'USER': 'cltbld', 19:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:06 INFO - 'XPC_FLAGS': '0x0', 19:59:06 INFO - 'XPC_SERVICE_NAME': '0', 19:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59: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)) 19:59:06 INFO - Cleaning up... 19:59:06 INFO - Return code: 0 19:59:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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 0x10401ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10401d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6b954d6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, '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.Z0btKytX24/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.UWGobqv2Lt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 19:59: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 19:59: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 19:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:06 INFO - 'HOME': '/Users/cltbld', 19:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:06 INFO - 'LOGNAME': 'cltbld', 19:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:06 INFO - 'MOZ_NO_REMOTE': '1', 19:59:06 INFO - 'NO_EM_RESTART': '1', 19:59:06 INFO - 'PAGER': '/bin/cat', 19:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:06 INFO - 'PWD': '/builds/slave/test', 19:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:06 INFO - 'SHELL': '/bin/bash', 19:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:59:06 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:06 INFO - 'USER': 'cltbld', 19:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:06 INFO - 'XPC_FLAGS': '0x0', 19:59:06 INFO - 'XPC_SERVICE_NAME': '0', 19:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:59:06 INFO - Cleaning up... 19:59:06 INFO - Return code: 0 19:59:06 INFO - Running post-action listener: _resource_record_post_action 19:59:06 INFO - Running post-action listener: _start_resource_monitoring 19:59:06 INFO - Starting resource monitoring. 19:59:06 INFO - [mozharness: 2017-01-21 03:59:06.990483Z] Finished create-virtualenv step (success) 19:59:06 INFO - [mozharness: 2017-01-21 03:59:06.991461Z] Running install step. 19:59:06 INFO - Running pre-action listener: _resource_record_pre_action 19:59:06 INFO - Running main action method: install 19:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:07 INFO - Reading from file tmpfile_stdout 19:59:07 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:07 INFO - Reading from file tmpfile_stdout 19:59:07 INFO - Output received: 19:59:07 INFO - Usage: mozinstall [options] installer 19:59:07 INFO - Options: 19:59:07 INFO - -h, --help show this help message and exit 19:59:07 INFO - -d DEST, --destination=DEST 19:59:07 INFO - Directory to install application into. [default: 19:59:07 INFO - "/builds/slave/test"] 19:59:07 INFO - --app=APP Application being installed. [default: firefox] 19:59:07 INFO - mkdir: /builds/slave/test/build/application 19:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:59:29 INFO - Reading from file tmpfile_stdout 19:59:29 INFO - Output received: 19:59:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:59:29 INFO - Running post-action listener: _resource_record_post_action 19:59:29 INFO - [mozharness: 2017-01-21 03:59:29.296731Z] Finished install step (success) 19:59:29 INFO - [mozharness: 2017-01-21 03:59:29.296895Z] Running run-tests step. 19:59:29 INFO - Running pre-action listener: _resource_record_pre_action 19:59:29 INFO - Running main action method: run_tests 19:59:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:59:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:59:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:59:29 INFO - 2017-01-20 19:59:29.311 screenresolution[1626:7632] starting screenresolution argv=screenresolution get 19:59:29 INFO - 2017-01-20 19:59:29.314 screenresolution[1626:7632] Display 0: 1600x1200x32@60 19:59:29 INFO - 2017-01-20 19:59:29.320 screenresolution[1627:7634] starting screenresolution argv=screenresolution list 19:59:29 INFO - Available Modes on Display 0 19:59:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:59:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:59:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:59:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:59:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:59:29 INFO - Intel Iris: 19:59:29 INFO - Chipset Model: Intel Iris 19:59:29 INFO - Type: GPU 19:59:29 INFO - Bus: Built-In 19:59:29 INFO - VRAM (Dynamic, Max): 1536 MB 19:59:29 INFO - Vendor: Intel (0x8086) 19:59:29 INFO - Device ID: 0x0a2e 19:59:29 INFO - Revision ID: 0x0009 19:59:29 INFO - Displays: 19:59:29 INFO - Display: 19:59:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:59:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:59:29 INFO - Display Serial Number: 1600x1200 60 19:59:29 INFO - Main Display: Yes 19:59:29 INFO - Mirror: Off 19:59:29 INFO - Online: Yes 19:59:29 INFO - Rotation: Supported 19:59:29 INFO - Return code: 0 19:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:29 INFO - Python 2.7.3 19:59:29 INFO - Return code: 0 19:59:29 INFO - grabbing minidump binary from tooltool 19:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:29 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 0x103df8d30>, '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 0x103d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dedbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:29 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 19:59:29 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 19:59:29 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 19:59:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:29 INFO - Return code: 0 19:59:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:59:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:59:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59: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/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 19:59: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/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 19:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z0btKytX24/Render', 19:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:59:29 INFO - 'HOME': '/Users/cltbld', 19:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:59:29 INFO - 'LOGNAME': 'cltbld', 19:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:29 INFO - 'MOZ_NO_REMOTE': '1', 19:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:29 INFO - 'NO_EM_RESTART': '1', 19:59:29 INFO - 'PAGER': '/bin/cat', 19:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:29 INFO - 'PWD': '/builds/slave/test', 19:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:59:29 INFO - 'SHELL': '/bin/bash', 19:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWGobqv2Lt/Listeners', 19:59:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 19:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:59:29 INFO - 'USER': 'cltbld', 19:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:29 INFO - 'XPC_FLAGS': '0x0', 19:59:29 INFO - 'XPC_SERVICE_NAME': '0', 19:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:59: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/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 19:59:29 INFO - mozversion application_buildid: 20170120185226 19:59:29 INFO - mozversion application_changeset: 41d8ef56d03b9b5b382d0575def6712d9d51b1df 19:59:29 INFO - mozversion application_display_name: Nightly 19:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:29 INFO - mozversion application_name: Firefox 19:59:29 INFO - mozversion application_remotingname: firefox 19:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:59:29 INFO - mozversion application_vendor: Mozilla 19:59:29 INFO - mozversion application_version: 53.0a1 19:59:29 INFO - mozversion platform_buildid: 20170120185226 19:59:29 INFO - mozversion platform_changeset: 41d8ef56d03b9b5b382d0575def6712d9d51b1df 19:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:59:29 INFO - mozversion platform_version: 53.0a1 19:59:29 INFO - using testdate: 1484971169 19:59:29 INFO - actual date: 1484971169 19:59:29 INFO - starting webserver on 'localhost:49246' 19:59:29 INFO - SUITE-START | Running 2 tests 19:59:29 INFO - TEST-START | dromaeo_css 19:59:29 INFO - operating with platform_type : mac_ 19:59:29 INFO - Initialising browser for dromaeo_css test... 19:59:29 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpUnWJ7C/profile http://localhost:49246/getInfo.html) 19:59:32 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 19:59:32 INFO - PROCESS | 1637 | colorDepth:24 19:59:32 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 19:59:32 INFO - PROCESS | 1637 | __metrics 19:59:32 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 19:59:32 INFO - PROCESS | 1637 | 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" 19:59:32 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:33 INFO - TEST-INFO | 1637: exit 0 19:59:33 INFO - Browser initialized. 19:59:33 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:33 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpUnWJ7C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:45 INFO - PROCESS | 1639 | RSS: Main: 235401216 19:59:45 INFO - PROCESS | 1639 | 20:02:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 20:02:52 INFO - PROCESS | 1639 | RSS: Main: 407404544 20:02:52 INFO - PROCESS | 1639 | 20:04:35 INFO - PROCESS | 1639 | ************************* 20:04:35 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 20:04:35 INFO - PROCESS | 1639 | 20:04:35 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:04:35 INFO - PROCESS | 1639 | Full stack: 20:04:35 INFO - PROCESS | 1639 | ************************* 20:05:55 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 20:05:55 INFO - PROCESS | 1639 | RSS: Main: 368234496 20:05:55 INFO - PROCESS | 1639 | 20:08:58 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 20:08:58 INFO - PROCESS | 1639 | RSS: Main: 349331456 20:08:58 INFO - PROCESS | 1639 | 20:12:01 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 20:12:01 INFO - PROCESS | 1639 | RSS: Main: 333492224 20:12:01 INFO - PROCESS | 1639 | 20:15:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 20:15:06 INFO - PROCESS | 1639 | RSS: Main: 332943360 20:15:06 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 20:18:09 INFO - PROCESS | 1639 | RSS: Main: 420913152 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | __start_tp_report 20:18:09 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 20:18:09 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 20:18:09 INFO - PROCESS | 1639 | |i|pagename|runs| 20:18:09 INFO - PROCESS | 1639 | |0;dojo.html;3316.6351701312865;3326.9833650831742;3329.117783787296;3349.464085746281;3385.475251336042;5590.273264475612;5600.439956004398;5646.548276137909;5671.517920976717;5677.091665333543;5643.633163844347;5675.829725108243;5677.772889084442;5681;5697.173909783079;5100.617453690978;5138.845834624967;5151.459096794839;5179.352580927384;5206.76569554371;5303.23103150043;5305.602079844008;5318.361796584415;5318.973405132988;5327.840164795062;5298.682079075248;5300.204969254604;5300.522952934235;5302.125149350371;5303.973480132594;5305.3898801637915;5310.362756469229;5311.920321195185;5315.601329900234;5317.73411329432;5094.133997220444;5196.246544251062;5214.5306922376785;5249.42256351801;5250.9737451312885;5794.21778059965;5857.4435428634215;5862.179294898718;5934.821955341346;5939.584229103964;6160.568760186744;6168.907466388007;6180.598261113013;6191.411815877529;6224.315325314212;5270;6123.234595675541;6139.78510752126;6143.385661433866;6143.771245750868;5862.530997520188;5935.465808077208;5946.108083787466;5963.344032156459;5988;6223.906641400383;6250.531210159256;6253.874922501615;6261.812145635638;6264.185655864709;6017.247844019497;6105.236845394325;6106.480949119375;6112.694365281718;6188.659623720739;6186.19579454677;6212.689365531795;6228.28374736902;6233.971394719911;6237.220347456568;6132.78535251264;6227.377262273827;6244.594101383486;6254;6266.49868010558;6117.174181485442;6154.599951003171;6269.561130720897;6279.780207692709;6305.558610897193;4993.251012348177;5007.223880298559;5023.34696489454;5037.143685573461;5083.034223497523;4458.487273963471;4469.083837813306;4490.169318676056;4507.985703216816;4538.568835960578;4787.3537072495465;5833.416658334133;5893.086571581412;5897.7935772247765;5899.233099697012;5307.310049693515;6123.632582045091;6126.334466362936;6166.537509686702;6199.938000619936;5771.826845194651;5836.591438599257;5839.708014599253;5841.88316233673;5844.8538786529825;5430.8099216527235;5431.21247419122;5451.64564303319;5459.07195776711;5496.395396506381;6242.53181011435;6252.273712642575;6257.4681152102585;6289.7169627365965;6314.210723659543;6004.067335894996;6206.813795586139;6207.844803879939;6208.658523781235;6221.160143380585;6138.204480310071;6179.443850053517;6180.042093475518;6204.3795620439405;6225.750969961332;6068.4841788448475;6212.627242365473;6227.96886015567;6237.126802247598;6253.530985176221;5460.972695136499;6152.661603611844;6180.7527698891545;6189.412005859436;6190.81427557174;5978.372270911492;6018.638881667114;6026.126211699191;6052.303985041776;6077.787277445268;6122.032243765608;6126.853582554517;6131.162586540493;6131.651934473353;6144.695739097839;6004.819855404345;6008.218931538872;6015.789447369321;6017.15759793638;6052.878942421215;5965.403459654;6041.6375017499095;6071.089336599545;6112.266528016667;6120.663363515049;5870.119482077723;5935;5939.940600593939;5941.673207973603;5961.552883533839 20:18:09 INFO - PROCESS | 1639 | |1;ext.html;446.3527884567377;497.75112443778113;506.8428787076007;520.3417676639052;523.7983376400085;30408.54387184194;30669.539956900637;39307.99999999996;40751;41069;34889.82555087221;41816.58183418165;41957.58042419575;41988.95027624311;42163.78918105405;7907.2488113629115;9032.77418064547;9269.768255793591;9287.442753434781;9307.395019323756;8178;8384.371172162113;10867.891321086807;11169.49737261821;11209.215354925158;11040.227184097117;11080.335179889193;11110.777784444306;11121.110311175087;11140.275882067639;8150.5517196554165;11066.944665276702;11133.554657813636;11144.665660030212;11148.386838723867;8226.794330141734;8354.498730076155;8364.832703345959;8368.24685778283;10712.035916767529;35890.64109358925;38070.048248793726;39990.600093998975;40004.599954000376;40126.59873401258;3544.7873127612424;3716.8141592920515;4009.498812648419;4063.1061166543313;4082.5509193988637;24777.62833557498;28969.56545651817;30307;30322.393552129055;30355.848220758755;3131.592892923928;3226.8547915343865;3269.591301087364;3270.329582435595;3315.1049216711353;440333;444240;445379.5462045403;446083;446765;48492.51507484951;56128.50971922236;56868.14697779537;56875;56991;52652.210216846775;61601.76796464046;61626.69186654038;61695;61718;15258.313375898111;15883.761743573856;15886.52340429789;15904.284307205971;15920.920395397949;11026.338419694845;11345.943270283597;12002.699932501582;12100.394980251129;12344.135910486359;11449.313041217554;13680.65798355049;13698.45206191741;13702.040857139904;15165.772513412308;5971.701414929236;6599.1091202687985;6902;6969.23338432772;6996.580205187705;830.6718846055895;855.6149732620346;886.6807949138305;895.789489469974;915.1489115122866;27986.580201296998;28197;28977.7102228975;29800.10599682013;29999.400011999638;1060.3425875956802;1067.5729708116814;1088.2056099047738;1099.769048499808;1208.510553225945;15053;15142.54572362831;15174.317155728018;15581.688366232613;15595.922020390053;232228;232456;232702;232880;233016;48861.511384886406;58373.416265837644;58497.70751146302;58629.41370586325;58642.706786465795;1419.836718777333;1436.7485690004207;1457.4024649893493;1459.153690859299;1466.296177834624;23567;27185.72814271832;28858.42283154283;29573.408531829675;29632.259193519472;48087.03825923532;48442.5155748438;48564;48607.75696121497;48738;499133;502035;502587;503689;504193;37391;37886.62113378831;38041.42937855879;38209.617903821716;38291.85124446271;43703;43834.780826095666;44599.77700111479;45054;45147.32279015883;34797.434115465374;36274.8186259067;36469.45295820618;37651.81174094112;37836;27321.86339068292;28852.855735721187;33739.81910633116;34171.65828341685;35502.8224858874;34170.658293416745;34532.30935381228;34752;34833.825830870686;34958.65041349656;29455.85272073626;31068.533971989986;31085.378292434478;31163.84418077986;31180.53229201609;18758.531036723645;20255.392338229878;23034.308970730235;23175.88412057929;23486.530269394174 20:18:09 INFO - PROCESS | 1639 | |2;jquery.html;364.52247555702047;380.14277803552983;381.0264773503699;388.84251877989414;388.9241597888413;14520.854791452095;15653.84346156538;17784.911075444637;20474.976251187454;20860.8956955215;21392.786072139275;21798;21801.90990450479;22001.694419809854;22152.667709984322;5566.582506312023;5648.152777083439;5897.764089436418;5907.911381329283;5921.467067963882;5476.616636835423;5731.226284451608;5961.433663801932;5963.9403605964035;5973.044312909935;3383.424817780983;4094.976255936016;5561.277033985576;5639.746211420496;6576;5963.642181469082;6244.500439964837;6588.4729221662155;6626.73493060277;6629.436497897685;5884.852878678024;5885.970570147122;5895.734691938873;5902.763889444417;5906.3207731110615;11182.32906025641;12886.677833054155;13151.605451836365;13236.272005039718;13464.057515973886;2558.411565339982;2645.7486538778785;2648.3908700998877;2654.429297700984;2684.6644169478814;9873.160781333596;10358.119559837423;10642.414667193301;10854.945725271402;16073.517794466185;1571.88210884183;1816.9727454088068;1820.1354356680604;1820.1354356680604;1851.7777866656088;137459;141268.2936585321;143134.56865431316;146796.26601867029;146859.53140468567;9677.854832177523;11386.544538218379;11433.771324573629;11496.655100346836;11739.530418783153;14969.101853888584;14976.625584360478;14993.100413974978;15000.624984375478;15021.399144034334;8307.626156822836;8520.531370774543;8533.957330213309;8677.479351238946;8709.477431354138;8359.707410240733;8360.874586881202;8387.580620968927;8516.403851730443;8539.914600854036;4066.8816075579452;4532.297493888453;4643.95356046442;4652.209124448852;4710.552497512799;1915.3240914200076;1980.544474770811;1991.7908619595023;1996.301294546897;1998.1707591349718;942.528735632184;948.9940662897351;973.9238141853292;992.9921130053002;1026.7484466305802;18305.450836474927;19214.519637009187;21502.191565702145;21758.02088906003;21783.455413614785;963.3064193780467;978.5107446276861;1022.3814592171777;1058.5554067291755;1069.9144068474504;10623.025552845216;11011.61459348935;11274;11309.09527237819;11415.429228538706;698061;702990;713718;713873;714448;125208.1218781719;137127;140096.59903400837;146044;150345;938.3056538161848;948.7248697877538;971.9271054670928;974.4056125763278;976.9413835169912;18230.270789168284;18344.816551834843;18434.63130737351;18461.446156615322;18511.889286642843;49533.009339812284;59590.70204648949;61577.99999999821;61667;62203.377966219756;85102;87556.5622171885;87735.68396474185;87760.1223987752;89678;8075.475094118863;8091.109977902308;8286;8298.419110662437;8346.666133354598;12792.296423696785;13034.957203423894;13309.267990260629;13310.201387916755;13407.932960335136;11236;11328.150388720715;11547.653570392902;11552.711182220512;11576.479058442223;9992.500374981077;11011.953864382871;11057.170712196777;11136.10911127124;11517.481713322753;10731;10924.126069914546;11023.669289921316;11087.611933582286;11115.88884111181;7919.920800791919;7928.246816552418;8122.39082068859;8140.7557773264525;8306.04480484752;7946.40401969843;10148.23888208402;10401.791964160826;10752.51613677402;10815.405152716676 20:18:09 INFO - PROCESS | 1639 | |3;mootools.html;1316.8880645145161;1464.633841539615;1470.404486183096;1485.3167542930257;1495.7905893174957;8061.234182752636;8443.197896199852;8462.87305690415;8466.407351485406;8476.194761497663;7344.706211751537;7634.656440460179;7980.800479988004;8223.136570660085;8228.91771082289;2238.6418173092347;2277.487565297811;2282.224043825099;2286.8170546356337;2293.3693234360517;2064.122747832173;2247.505548779266;2303.009705826494;2309.7921187093157;2313.826463015272;2048.672212446009;2069.4515953272394;2218.101668824129;2283.703118594589;2294.6443301288245;2237.8209743220505;2262.592733308004;2267.365137761421;2268.1494439585153;2275.112706044644;2282.2696737044153;2299.9655005174936;2307.9538409231723;2308.6190778521523;2310.145246258895;8181.71364002263;8369.121242269595;8379.413441059129;8382.287505562035;8390.790230244233;4970.329005584236;5113.054084994288;5124.5131712487255;5125.487451254882;5129.384473863161;3209.7271731902583;3280.2291461506525;3435.793852368866;3487.459443786192;3493.423585108454;1207.565276500459;1233.1244816180522;1239.8388209532702;1248.332142303863;1269.641483612535;10717.517711702993;10735.980081892285;10749.462526873547;10756.515956781963;10768.892311076946;4283.1433713257475;4503.842365517191;4607.101615185074;4614.561616646413;4632.2125238709505;9314.673986410578;9426.62293508252;9455.149036586603;9455.669051583161;9476.668316608886;5189.273501709688;5189.481051894856;5191.987562425291;5198.896022079537;5276.182191760283;4630.490646028934;4637.049404871993;4669.813207471731;4708.270218116198;4715.221988371949;3685.94471082934;3722.274156539503;3771.396576547794;3806.2197249563774;3809.695224382043;1079.924405291622;1147.4893672315739;1235.0613533714263;1238.5231685801032;1259.1123258103016;747.6971826410313;765.8714152686339;775.1241097559835;788.3653658804717;801.3909428834128;5373.892522149535;5478.91781623276;5513.94724877215;5530.446955304437;5646.463585959327;900.9594568244445;910.1308250620641;912.6623149434752;933.3932943586723;950.7432993091827;3094.9535756963664;3642.9453558196647;3748.981255093707;3749.2314075614436;3760.9623903761158;9462.432254064779;9914.40513569188;9946.850797238047;10041.096301332915;10057.748556286151;9624.470654113951;9859.605615775288;9895.257855660855;9948.602055917827;9953.601855925826;7654.119776225805;7840.647170877324;7841.333486653698;7867.095284042294;7872;5345.38528069277;5377.354717433933;5437.619366644455;5486.1222204448695;5495.395506494203;8976;9083.409578377385;9104.044075372256;9183.908160918305;9298.302627302844;8862.822743544964;9162.725118246462;9297.953510232675;9382.202512786489;9391.624335026523;6192.628442293297;7037.577745335297;7210.783676489504;7213.9278607213255;7236.167840698387;7464.216257292906;7748.573828439265;7805.843883122192;7917.327027202522;7920.762377128695;7022.859542809218;7038.94415837608;7058.223595404399;7118.537295075804;7251.746188883364;6153.38466153399;6967.895481567679;6974;6993.370596646327;6995.650217489207;6077.756889724362;6267.874642507216;6324.462420694109;6378.489720822416;6391.073294372197;4823.252395878644;4924.8392243129865;4931.260310953386;4942.629302802232;5074.873128171826;4898.21628539432;4937.629677774109;5034.421041580119;5040.747962601782;5066.9239961401345 20:18:09 INFO - PROCESS | 1639 | |4;prototype.html;335.5101551734468;363.95450568678916;368.70872011111226;373.4920508108973;374.69649583837094;4461.709988850726;5033.6728112672745;5276.551493123089;5305.681659100456;5327.786888524459;4956.306117143603;5197.402298735647;5198.686584469912;5240.423553409122;5264.236685680574;3400.9829950850212;3818.599047100049;3917.2763983847017;4032.717709760318;4085;4057.1885622875543;4062.9639441942263;4085.1829634073156;4104.363823607346;4106.671466282705;3618.2763447310645;3670.6696397324235;4085;4088.121053973395;4112.2803509385885;3268;3661.919733678571;3930.371140617516;3959.010247438126;4024.6579040781567;3258.771885967983;3563.1982803868923;3572.3034008368377;3608.332458495187;3625.5649322081254;4409.5007697382725;4577.702449340783;4700.529947005306;4724.763761811896;4726.26742854858;4232.873013809591;4331.7834108294455;4600.9769951150365;4724.858254252378;4823.758812059383;4956.529129732669;4991.575716064139;5549.722513874331;5578.9163162552595;5655.1517272409055;3766.4350347448103;4051.4530538377235;4063.2889244382113;4082.8775136745944;4107.938380924288;4606.677532572688;5078.847634570969;5258.107081450713;5420.864478388033;5880.529557635379;3489.5986961499243;3726.8509259629855;3938.330483817758;4066.369712694537;4105.3020986432375;3452.4648679454726;4139.027328577782;4170.601903905266;4173.165366926627;4176.893123322322;4259.914801703949;4699.365585645963;4702.553257440538;4719.174144524694;4725.936664250585;4729;5525.530329922001;5611.7474713637985;5637.492625663628;5645.407232240637;1203.7171264752776;1256.5036810459817;1276.3873340796283;1277.565627686591;1278.6957303550328;763.812271917163;811.9106898241189;862.0388267082159;867.869819527076;868.96524139035;4369.759663218553;4424.557544245549;4605.6776025678555;4928.028788484635;4937.136001199776;4399.844076402604;4662.487126416091;5060.9381324298265;5386.13821788512;5432.70120143388;4472.658202539225;4653.790579423934;4717.599004084623;4856.660033797671;4886;2507.160101366063;2697.9460410791676;2824.884170752541;2868.3976364963173;2885.9422811544073;5532.336119665585;5650;5681.772729090872;5683.829485115453;5694.60137790359;4610.596879979611;5338.092524270884;5341.973290133525;5586.888262234814;5637.492625663628;5633.492985631313;5648.265725455664;5679.233303503974;5736.508507788005;5745.569082318842;4874.926876096933;5107.770150343318;5353.78584856617;5357.973210133924;5362.436944120967;4499.91000179988;4967.3424717775815;5113.5966095934855;5464.207689885024;5485.424030476743;4825.565699087099;4845.781939812647;5829.970850145722;5848.473637372486;5881.353051164283;3209.743220542398;3353.312570922906;3734.8048624439916;3833.849845046531;3859.864904728321;5152.6650767699975;5704.664455014302;5726.828195154152;5741.942580574141;5764.434826502166;4547.795349209227;5191.792328306977;5538.6122971391615;5548.667079975215;5561.332640083216;5497.560195184456;5530.695811730394;5533.446655334596;5536.7785288588;5543.695096769717;3891.221755648938;5014.974925125351;5392.946070539245;5412.945870541244;5438.102713052302;5262.921101174326;5292.867678308073;5612.214289999485;5635.718214089197;5675.31896172462;4468.888277793081;5505.532029777353;5529.778808847601;5532.806351777668;5538.196961440488 20:18:09 INFO - PROCESS | 1639 | |5;yui.html;714.1109318897969;721.5634541102629;752.180123665205;775.6936010275941;840.1682334488854;13637.113587616797;14182.00725949184;14189.219592922385;14199.361028753705;14218.715625687493;14186.21975791331;14363.497277595287;14368.71262574748;14389.78415323771;14393.208373539452;677.5866721300004;695.7703957693949;699.3286445012768;853.3557164340914;854.5599016506504;869.695606537713;882.3911501064246;889.9866502002475;895.8297923394534;895.9641614335419;936.7985883035146;937.4984383354872;938.3431597881477;938.9718258506958;939.2532936315646;727.8471520980601;741.8664640364732;889.2574700125404;890.0743227043866;892.2638822971074;669.621663759974;678.5284227461916;686.8935315026179;697.006765359366;697.1146643762394;14884.404623815035;14996.47512337063;14998.250087495582;15004.399824007027;15042.398304067825;12441.253524788452;13043.282619455926;13117.803232951514;13247.536336228282;13322.400491977884;12485.375731213493;13029.86970130296;13055.412506437233;13242.86757132426;13718.17690938547;4110.91778164438;4444.088961762831;4463.419755431805;4467.1735728889935;4714.599259062984;101108.9889101107;104484;105096.47451762692;105954.47022764914;107392;10383.792324153626;10390.948045259725;10785.29895556802;10818.891811081945;11010.39442830636;20423.489412764502;20563.588728225353;20716.067776950073;20804.687929681066;20850.58298834015;6612.504062195355;7561.432892533082;7572.323292573858;7588.886166707503;7764.417668674872;3774.509313789245;4272.700910936204;4272.786360681954;4325.43769309994;4478.328250762412;3401.3367393358058;3440.724742020632;3488.8255587220538;3508.964910350915;3736.439534069911;710.2506855267638;712.4158190284021;720.8594324106749;730.8684436801427;732.3262598409476;622.5237693164732;685.3934268172603;693.8577591593711;735.4961851131992;738.4609235258291;9995.150412215044;10382.221333400024;10408.843867341995;10437.739056523496;10580.894191058145;692.6363659079024;704.830840598263;712.5653351455608;721.3039416962656;728.2899173305984;4643.489216186217;4970.627202959792;4976;4981.875453113628;4985.52637499437;91675;93838.53080734552;95242.523787382;95764.52117739366;97549;91808;94116.52941735384;95142;96318;98286;76574.617126914;79161.60419197867;79444.92368448645;80309.59845200737;80357;8422.915770842214;9670;9720.270979676694;9777.560009799434;9825.606975720892;44738.3289250655;45876.77061614671;52874.73562632162;55249.44750552604;55764.60588485158;66694.66610667856;68149.65925170343;69251.30748692449;69924;70575.64712176406;12723;13281.535146269835;13289.534866279633;13350.465981360638;13568.59294221175;14723.263836808332;14820.481283155037;14851.777223341875;14938.850611493746;15539.922300388425;11706.88293117058;13586.388612512263;13714;13838.4464621414;14309.856901430852;13232.603021909357;13236.602901912958;13547.661308467366;13776.380062896993;14222.146671199762;13162.670933226746;13349.599512014654;13406.664833379244;13528.458861645424;13800.93099534496;9450.43297402158;10866.239363244496;11001.22991390595;11217.943910280397;11488.655340339803;10855.348679079281;10974.615888443866;11005.119590432907;11280.605178818701;11564 20:18:09 INFO - PROCESS | 1639 | __end_tp_report 20:18:09 INFO - PROCESS | 1639 | __start_cc_report 20:18:09 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1959 20:18:09 INFO - PROCESS | 1639 | __end_cc_report 20:18:09 INFO - PROCESS | 1639 | __startTimestamp1484972289658__endTimestamp 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | ------- Summary: start ------- 20:18:09 INFO - PROCESS | 1639 | Number of tests: 6 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5739.87 Median:5965.40 stddev:618.58 (10.4%) stddev-sans-first:590.55 20:18:09 INFO - PROCESS | 1639 | Values: 3316.6 3327.0 3329.1 3349.5 3385.5 5590.3 5600.4 5646.5 5671.5 5677.1 5643.6 5675.8 5677.8 5681.0 5697.2 5100.6 5138.8 5151.5 5179.4 5206.8 5303.2 5305.6 5318.4 5319.0 5327.8 5298.7 5300.2 5300.5 5302.1 5304.0 5305.4 5310.4 5311.9 5315.6 5317.7 5094.1 5196.2 5214.5 5249.4 5251.0 5794.2 5857.4 5862.2 5934.8 5939.6 6160.6 6168.9 6180.6 6191.4 6224.3 5270.0 6123.2 6139.8 6143.4 6143.8 5862.5 5935.5 5946.1 5963.3 5988.0 6223.9 6250.5 6253.9 6261.8 6264.2 6017.2 6105.2 6106.5 6112.7 6188.7 6186.2 6212.7 6228.3 6234.0 6237.2 6132.8 6227.4 6244.6 6254.0 6266.5 6117.2 6154.6 6269.6 6279.8 6305.6 4993.3 5007.2 5023.3 5037.1 5083.0 4458.5 4469.1 4490.2 4508.0 4538.6 4787.4 5833.4 5893.1 5897.8 5899.2 5307.3 6123.6 6126.3 6166.5 6199.9 5771.8 5836.6 5839.7 5841.9 5844.9 5430.8 5431.2 5451.6 5459.1 5496.4 6242.5 6252.3 6257.5 6289.7 6314.2 6004.1 6206.8 6207.8 6208.7 6221.2 6138.2 6179.4 6180.0 6204.4 6225.8 6068.5 6212.6 6228.0 6237.1 6253.5 5461.0 6152.7 6180.8 6189.4 6190.8 5978.4 6018.6 6026.1 6052.3 6077.8 6122.0 6126.9 6131.2 6131.7 6144.7 6004.8 6008.2 6015.8 6017.2 6052.9 5965.4 6041.6 6071.1 6112.3 6120.7 5870.1 5935.0 5939.9 5941.7 5961.6 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:54519.58 Median:19251.72 stddev:109094.00 (566.7%) stddev-sans-first:109324.49 20:18:09 INFO - PROCESS | 1639 | Values: 446.4 497.8 506.8 520.3 523.8 30408.5 30669.5 39308.0 40751.0 41069.0 34889.8 41816.6 41957.6 41989.0 42163.8 7907.2 9032.8 9269.8 9287.4 9307.4 8178.0 8384.4 10867.9 11169.5 11209.2 11040.2 11080.3 11110.8 11121.1 11140.3 8150.6 11066.9 11133.6 11144.7 11148.4 8226.8 8354.5 8364.8 8368.2 10712.0 35890.6 38070.0 39990.6 40004.6 40126.6 3544.8 3716.8 4009.5 4063.1 4082.6 24777.6 28969.6 30307.0 30322.4 30355.8 3131.6 3226.9 3269.6 3270.3 3315.1 440333.0 444240.0 445379.5 446083.0 446765.0 48492.5 56128.5 56868.1 56875.0 56991.0 52652.2 61601.8 61626.7 61695.0 61718.0 15258.3 15883.8 15886.5 15904.3 15920.9 11026.3 11345.9 12002.7 12100.4 12344.1 11449.3 13680.7 13698.5 13702.0 15165.8 5971.7 6599.1 6902.0 6969.2 6996.6 830.7 855.6 886.7 895.8 915.1 27986.6 28197.0 28977.7 29800.1 29999.4 1060.3 1067.6 1088.2 1099.8 1208.5 15053.0 15142.5 15174.3 15581.7 15595.9 232228.0 232456.0 232702.0 232880.0 233016.0 48861.5 58373.4 58497.7 58629.4 58642.7 1419.8 1436.7 1457.4 1459.2 1466.3 23567.0 27185.7 28858.4 29573.4 29632.3 48087.0 48442.5 48564.0 48607.8 48738.0 499133.0 502035.0 502587.0 503689.0 504193.0 37391.0 37886.6 38041.4 38209.6 38291.9 43703.0 43834.8 44599.8 45054.0 45147.3 34797.4 36274.8 36469.5 37651.8 37836.0 27321.9 28852.9 33739.8 34171.7 35502.8 34170.7 34532.3 34752.0 34833.8 34958.7 29455.9 31068.5 31085.4 31163.8 31180.5 18758.5 20255.4 23034.3 23175.9 23486.5 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:39200.80 Median:2602.08 stddev:118368.62 (4549.0%) stddev-sans-first:118664.76 20:18:09 INFO - PROCESS | 1639 | Values: 364.5 380.1 381.0 388.8 388.9 14520.9 15653.8 17784.9 20475.0 20860.9 21392.8 21798.0 21801.9 22001.7 22152.7 5566.6 5648.2 5897.8 5907.9 5921.5 5476.6 5731.2 5961.4 5963.9 5973.0 3383.4 4095.0 5561.3 5639.7 6576.0 5963.6 6244.5 6588.5 6626.7 6629.4 5884.9 5886.0 5895.7 5902.8 5906.3 11182.3 12886.7 13151.6 13236.3 13464.1 2558.4 2645.7 2648.4 2654.4 2684.7 9873.2 10358.1 10642.4 10854.9 16073.5 1571.9 1817.0 1820.1 1820.1 1851.8 137459.0 141268.3 143134.6 146796.3 146859.5 9677.9 11386.5 11433.8 11496.7 11739.5 14969.1 14976.6 14993.1 15000.6 15021.4 8307.6 8520.5 8534.0 8677.5 8709.5 8359.7 8360.9 8387.6 8516.4 8539.9 4066.9 4532.3 4644.0 4652.2 4710.6 1915.3 1980.5 1991.8 1996.3 1998.2 942.5 949.0 973.9 993.0 1026.7 18305.5 19214.5 21502.2 21758.0 21783.5 963.3 978.5 1022.4 1058.6 1069.9 10623.0 11011.6 11274.0 11309.1 11415.4 698061.0 702990.0 713718.0 713873.0 714448.0 125208.1 137127.0 140096.6 146044.0 150345.0 938.3 948.7 971.9 974.4 976.9 18230.3 18344.8 18434.6 18461.4 18511.9 49533.0 59590.7 61578.0 61667.0 62203.4 85102.0 87556.6 87735.7 87760.1 89678.0 8075.5 8091.1 8286.0 8298.4 8346.7 12792.3 13035.0 13309.3 13310.2 13407.9 11236.0 11328.2 11547.7 11552.7 11576.5 9992.5 11012.0 11057.2 11136.1 11517.5 10731.0 10924.1 11023.7 11087.6 11115.9 7919.9 7928.2 8122.4 8140.8 8306.0 7946.4 10148.2 10401.8 10752.5 10815.4 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5377.59 Median:5237.54 stddev:2945.98 (56.2%) stddev-sans-first:2938.44 20:18:09 INFO - PROCESS | 1639 | Values: 1316.9 1464.6 1470.4 1485.3 1495.8 8061.2 8443.2 8462.9 8466.4 8476.2 7344.7 7634.7 7980.8 8223.1 8228.9 2238.6 2277.5 2282.2 2286.8 2293.4 2064.1 2247.5 2303.0 2309.8 2313.8 2048.7 2069.5 2218.1 2283.7 2294.6 2237.8 2262.6 2267.4 2268.1 2275.1 2282.3 2300.0 2308.0 2308.6 2310.1 8181.7 8369.1 8379.4 8382.3 8390.8 4970.3 5113.1 5124.5 5125.5 5129.4 3209.7 3280.2 3435.8 3487.5 3493.4 1207.6 1233.1 1239.8 1248.3 1269.6 10717.5 10736.0 10749.5 10756.5 10768.9 4283.1 4503.8 4607.1 4614.6 4632.2 9314.7 9426.6 9455.1 9455.7 9476.7 5189.3 5189.5 5192.0 5198.9 5276.2 4630.5 4637.0 4669.8 4708.3 4715.2 3685.9 3722.3 3771.4 3806.2 3809.7 1079.9 1147.5 1235.1 1238.5 1259.1 747.7 765.9 775.1 788.4 801.4 5373.9 5478.9 5513.9 5530.4 5646.5 901.0 910.1 912.7 933.4 950.7 3095.0 3642.9 3749.0 3749.2 3761.0 9462.4 9914.4 9946.9 10041.1 10057.7 9624.5 9859.6 9895.3 9948.6 9953.6 7654.1 7840.6 7841.3 7867.1 7872.0 5345.4 5377.4 5437.6 5486.1 5495.4 8976.0 9083.4 9104.0 9183.9 9298.3 8862.8 9162.7 9298.0 9382.2 9391.6 6192.6 7037.6 7210.8 7213.9 7236.2 7464.2 7748.6 7805.8 7917.3 7920.8 7022.9 7038.9 7058.2 7118.5 7251.7 6153.4 6967.9 6974.0 6993.4 6995.7 6077.8 6267.9 6324.5 6378.5 6391.1 4823.3 4924.8 4931.3 4942.6 5074.9 4898.2 4937.6 5034.4 5040.7 5066.9 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4415.42 Median:4824.66 stddev:1335.27 (27.7%) stddev-sans-first:1303.43 20:18:09 INFO - PROCESS | 1639 | Values: 335.5 364.0 368.7 373.5 374.7 4461.7 5033.7 5276.6 5305.7 5327.8 4956.3 5197.4 5198.7 5240.4 5264.2 3401.0 3818.6 3917.3 4032.7 4085.0 4057.2 4063.0 4085.2 4104.4 4106.7 3618.3 3670.7 4085.0 4088.1 4112.3 3268.0 3661.9 3930.4 3959.0 4024.7 3258.8 3563.2 3572.3 3608.3 3625.6 4409.5 4577.7 4700.5 4724.8 4726.3 4232.9 4331.8 4601.0 4724.9 4823.8 4956.5 4991.6 5549.7 5578.9 5655.2 3766.4 4051.5 4063.3 4082.9 4107.9 4606.7 5078.8 5258.1 5420.9 5880.5 3489.6 3726.9 3938.3 4066.4 4105.3 3452.5 4139.0 4170.6 4173.2 4176.9 4259.9 4699.4 4702.6 4719.2 4725.9 4729.0 5525.5 5611.7 5637.5 5645.4 1203.7 1256.5 1276.4 1277.6 1278.7 763.8 811.9 862.0 867.9 869.0 4369.8 4424.6 4605.7 4928.0 4937.1 4399.8 4662.5 5060.9 5386.1 5432.7 4472.7 4653.8 4717.6 4856.7 4886.0 2507.2 2697.9 2824.9 2868.4 2885.9 5532.3 5650.0 5681.8 5683.8 5694.6 4610.6 5338.1 5342.0 5586.9 5637.5 5633.5 5648.3 5679.2 5736.5 5745.6 4874.9 5107.8 5353.8 5358.0 5362.4 4499.9 4967.3 5113.6 5464.2 5485.4 4825.6 4845.8 5830.0 5848.5 5881.4 3209.7 3353.3 3734.8 3833.8 3859.9 5152.7 5704.7 5726.8 5741.9 5764.4 4547.8 5191.8 5538.6 5548.7 5561.3 5497.6 5530.7 5533.4 5536.8 5543.7 3891.2 5015.0 5392.9 5412.9 5438.1 5262.9 5292.9 5612.2 5635.7 5675.3 4468.9 5505.5 5529.8 5532.8 5538.2 20:18:09 INFO - PROCESS | 1639 | 20:18:09 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20461.89 Median:24602.75 stddev:29251.39 (118.9%) stddev-sans-first:29295.86 20:18:09 INFO - PROCESS | 1639 | Values: 714.1 721.6 752.2 775.7 840.2 13637.1 14182.0 14189.2 14199.4 14218.7 14186.2 14363.5 14368.7 14389.8 14393.2 677.6 695.8 699.3 853.4 854.6 869.7 882.4 890.0 895.8 896.0 936.8 937.5 938.3 939.0 939.3 727.8 741.9 889.3 890.1 892.3 669.6 678.5 686.9 697.0 697.1 14884.4 14996.5 14998.3 15004.4 15042.4 12441.3 13043.3 13117.8 13247.5 13322.4 12485.4 13029.9 13055.4 13242.9 13718.2 4110.9 4444.1 4463.4 4467.2 4714.6 101109.0 104484.0 105096.5 105954.5 107392.0 10383.8 10390.9 10785.3 10818.9 11010.4 20423.5 20563.6 20716.1 20804.7 20850.6 6612.5 7561.4 7572.3 7588.9 7764.4 3774.5 4272.7 4272.8 4325.4 4478.3 3401.3 3440.7 3488.8 3509.0 3736.4 710.3 712.4 720.9 730.9 732.3 622.5 685.4 693.9 735.5 738.5 9995.2 10382.2 10408.8 10437.7 10580.9 692.6 704.8 712.6 721.3 728.3 4643.5 4970.6 4976.0 4981.9 4985.5 91675.0 93838.5 95242.5 95764.5 97549.0 91808.0 94116.5 95142.0 96318.0 98286.0 76574.6 79161.6 79444.9 80309.6 80357.0 8422.9 9670.0 9720.3 9777.6 9825.6 44738.3 45876.8 52874.7 55249.4 55764.6 66694.7 68149.7 69251.3 69924.0 70575.6 12723.0 13281.5 13289.5 13350.5 13568.6 14723.3 14820.5 14851.8 14938.9 15539.9 11706.9 13586.4 13714.0 13838.4 14309.9 13232.6 13236.6 13547.7 13776.4 14222.1 13162.7 13349.6 13406.7 13528.5 13800.9 9450.4 10866.2 11001.2 11217.9 11488.7 10855.3 10974.6 11005.1 11280.6 11564.0 20:18:09 INFO - PROCESS | 1639 | -------- Summary: end -------- 20:18:09 INFO - PROCESS | 1639 | 20:18:10 INFO - TEST-INFO | 1639: exit 0 20:18:10 INFO - TEST-OK | dromaeo_css | took 1120557ms 20:18:10 INFO - TEST-START | kraken 20:18:10 INFO - operating with platform_type : mac_ 20:18:10 INFO - Initialising browser for kraken test... 20:18:10 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp0DLbqS/profile http://localhost:49246/getInfo.html) 20:18:12 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 20:18:12 INFO - PROCESS | 1645 | colorDepth:24 20:18:12 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 20:18:12 INFO - PROCESS | 1645 | __metrics 20:18:12 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 20:18:12 INFO - PROCESS | 1645 | 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" 20:18:12 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:13 INFO - TEST-INFO | 1645: exit 0 20:18:13 INFO - Browser initialized. 20:18:13 INFO - Running cycle 1/1 for kraken test... 20:18:13 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp0DLbqS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:25 INFO - PROCESS | 1646 | RSS: Main: 235274240 20:18:25 INFO - PROCESS | 1646 | 20:18:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:29 INFO - PROCESS | 1646 | RSS: Main: 287617024 20:18:29 INFO - PROCESS | 1646 | 20:18:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 20:18:32 INFO - PROCESS | 1646 | RSS: Main: 286883840 20:18:32 INFO - PROCESS | 1646 | 20:18:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 20:18:36 INFO - PROCESS | 1646 | RSS: Main: 379752448 20:18:36 INFO - PROCESS | 1646 | 20:18:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 20:18:39 INFO - PROCESS | 1646 | RSS: Main: 281710592 20:18:39 INFO - PROCESS | 1646 | 20:18:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:41 INFO - PROCESS | 1646 | RSS: Main: 285548544 20:18:41 INFO - PROCESS | 1646 | 20:18:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:45 INFO - PROCESS | 1646 | RSS: Main: 327057408 20:18:45 INFO - PROCESS | 1646 | 20:18:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:48 INFO - PROCESS | 1646 | RSS: Main: 330285056 20:18:48 INFO - PROCESS | 1646 | 20:18:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 20:18:52 INFO - PROCESS | 1646 | RSS: Main: 328802304 20:18:52 INFO - PROCESS | 1646 | 20:18:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:54 INFO - PROCESS | 1646 | RSS: Main: 302907392 20:18:54 INFO - PROCESS | 1646 | 20:18:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:57 INFO - PROCESS | 1646 | RSS: Main: 305582080 20:18:57 INFO - PROCESS | 1646 | 20:18:59 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:59 INFO - PROCESS | 1646 | RSS: Main: 306728960 20:18:59 INFO - PROCESS | 1646 | 20:19:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:03 INFO - PROCESS | 1646 | RSS: Main: 323878912 20:19:03 INFO - PROCESS | 1646 | 20:19:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:07 INFO - PROCESS | 1646 | RSS: Main: 317566976 20:19:07 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 20:19:09 INFO - PROCESS | 1646 | RSS: Main: 361791488 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | __start_tp_report 20:19:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 20:19:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 20:19:09 INFO - PROCESS | 1646 | |i|pagename|runs| 20:19:09 INFO - PROCESS | 1646 | |0;ai-astar;113;114;114;114;114;112;112;113;112;114 20:19:09 INFO - PROCESS | 1646 | |1;audio-beat-detection;147;111;109;148;117;132;131;111;130;109 20:19:09 INFO - PROCESS | 1646 | |2;audio-dft;185;184;185;183;185;185;181;184;182;182 20:19:09 INFO - PROCESS | 1646 | |3;audio-fft;80;58;59;87;62;59;59;59;74;58 20:19:09 INFO - PROCESS | 1646 | |4;audio-oscillator;84;71;86;71;68;68;82;68;68;84 20:19:09 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;87;85;87;86;87;84;88;84;87;84 20:19:09 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;98;94;94;94;94;93;95;94;93 20:19:09 INFO - PROCESS | 1646 | |7;imaging-desaturate;85;87;86;86;89;85;85;86;86;85 20:19:09 INFO - PROCESS | 1646 | |8;json-parse-financial;58;56;57;55;56;56;55;56;56;55 20:19:09 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;66;68;71;75;73;68;70;70;71;72 20:19:09 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;88;87;85;88;86;98;101;100;101;91 20:19:09 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;141;141;141;160;151;150;138;152;205;158 20:19:09 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;176;178;177;171;177;172;173;176;175;175 20:19:09 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;69;66;79;82;83;73;66;67;68;67 20:19:09 INFO - PROCESS | 1646 | __end_tp_report 20:19:09 INFO - PROCESS | 1646 | __start_cc_report 20:19:09 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2078 20:19:09 INFO - PROCESS | 1646 | __end_cc_report 20:19:09 INFO - PROCESS | 1646 | __startTimestamp1484972349497__endTimestamp 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | ------- Summary: start ------- 20:19:09 INFO - PROCESS | 1646 | Number of tests: 14 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 20:19:09 INFO - PROCESS | 1646 | Values: 113.0 114.0 114.0 114.0 114.0 112.0 112.0 113.0 112.0 114.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:130.50 stddev:15.23 (11.7%) stddev-sans-first:13.81 20:19:09 INFO - PROCESS | 1646 | Values: 147.0 111.0 109.0 148.0 117.0 132.0 131.0 111.0 130.0 109.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:1.51 (0.8%) stddev-sans-first:1.51 20:19:09 INFO - PROCESS | 1646 | Values: 185.0 184.0 185.0 183.0 185.0 185.0 181.0 184.0 182.0 182.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:65.50 Median:60.50 stddev:10.74 (17.8%) stddev-sans-first:10.03 20:19:09 INFO - PROCESS | 1646 | Values: 80.0 58.0 59.0 87.0 62.0 59.0 59.0 59.0 74.0 58.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.50 stddev:7.89 (10.3%) stddev-sans-first:7.66 20:19:09 INFO - PROCESS | 1646 | Values: 84.0 71.0 86.0 71.0 68.0 68.0 82.0 68.0 68.0 84.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.56 20:19:09 INFO - PROCESS | 1646 | Values: 87.0 85.0 87.0 86.0 87.0 84.0 88.0 84.0 87.0 84.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 20:19:09 INFO - PROCESS | 1646 | Values: 94.0 98.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 93.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 20:19:09 INFO - PROCESS | 1646 | Values: 85.0 87.0 86.0 86.0 89.0 85.0 85.0 86.0 86.0 85.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:0.67 20:19:09 INFO - PROCESS | 1646 | Values: 58.0 56.0 57.0 55.0 56.0 56.0 55.0 56.0 56.0 55.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:2.63 (3.7%) stddev-sans-first:2.26 20:19:09 INFO - PROCESS | 1646 | Values: 66.0 68.0 71.0 75.0 73.0 68.0 70.0 70.0 71.0 72.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:87.50 stddev:6.69 (7.6%) stddev-sans-first:6.89 20:19:09 INFO - PROCESS | 1646 | Values: 88.0 87.0 85.0 88.0 86.0 98.0 101.0 100.0 101.0 91.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:151.50 stddev:19.56 (12.9%) stddev-sans-first:20.20 20:19:09 INFO - PROCESS | 1646 | Values: 141.0 141.0 141.0 160.0 151.0 150.0 138.0 152.0 205.0 158.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:2.31 (1.3%) stddev-sans-first:2.42 20:19:09 INFO - PROCESS | 1646 | Values: 176.0 178.0 177.0 171.0 177.0 172.0 173.0 176.0 175.0 175.0 20:19:09 INFO - PROCESS | 1646 | 20:19:09 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.00 stddev:6.82 (9.6%) stddev-sans-first:7.14 20:19:09 INFO - PROCESS | 1646 | Values: 69.0 66.0 79.0 82.0 83.0 73.0 66.0 67.0 68.0 67.0 20:19:09 INFO - PROCESS | 1646 | -------- Summary: end -------- 20:19:09 INFO - PROCESS | 1646 | 20:19:10 INFO - TEST-INFO | 1646: exit 0 20:19:10 INFO - TEST-OK | kraken | took 59942ms 20:19:10 INFO - SUITE-END | took 1180s 20:19:10 INFO - Completed test suite (00:19:40) 20:19:10 INFO - javascript benchmark 20:19:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.6351701312865, 3326.9833650831742, 3329.117783787296, 3349.464085746281, 3385.475251336042, 5590.273264475612, 5600.439956004398, 5646.548276137909, 5671.517920976717, 5677.091665333543, 5643.633163844347, 5675.829725108243, 5677.772889084442, 5681.0, 5697.173909783079, 5100.617453690978, 5138.845834624967, 5151.459096794839, 5179.352580927384, 5206.76569554371, 5303.23103150043, 5305.602079844008, 5318.361796584415, 5318.973405132988, 5327.840164795062, 5298.682079075248, 5300.204969254604, 5300.522952934235, 5302.125149350371, 5303.973480132594, 5305.3898801637915, 5310.362756469229, 5311.920321195185, 5315.601329900234, 5317.73411329432, 5094.133997220444, 5196.246544251062, 5214.5306922376785, 5249.42256351801, 5250.9737451312885, 5794.21778059965, 5857.4435428634215, 5862.179294898718, 5934.821955341346, 5939.584229103964, 6160.568760186744, 6168.907466388007, 6180.598261113013, 6191.411815877529, 6224.315325314212, 5270.0, 6123.234595675541, 6139.78510752126, 6143.385661433866, 6143.771245750868, 5862.530997520188, 5935.465808077208, 5946.108083787466, 5963.344032156459, 5988.0, 6223.906641400383, 6250.531210159256, 6253.874922501615, 6261.812145635638, 6264.185655864709, 6017.247844019497, 6105.236845394325, 6106.480949119375, 6112.694365281718, 6188.659623720739, 6186.19579454677, 6212.689365531795, 6228.28374736902, 6233.971394719911, 6237.220347456568, 6132.78535251264, 6227.377262273827, 6244.594101383486, 6254.0, 6266.49868010558, 6117.174181485442, 6154.599951003171, 6269.561130720897, 6279.780207692709, 6305.558610897193, 4993.251012348177, 5007.223880298559, 5023.34696489454, 5037.143685573461, 5083.034223497523, 4458.487273963471, 4469.083837813306, 4490.169318676056, 4507.985703216816, 4538.568835960578, 4787.3537072495465, 5833.416658334133, 5893.086571581412, 5897.7935772247765, 5899.233099697012, 5307.310049693515, 6123.632582045091, 6126.334466362936, 6166.537509686702, 6199.938000619936, 5771.826845194651, 5836.591438599257, 5839.708014599253, 5841.88316233673, 5844.8538786529825, 5430.8099216527235, 5431.21247419122, 5451.64564303319, 5459.07195776711, 5496.395396506381, 6242.53181011435, 6252.273712642575, 6257.4681152102585, 6289.7169627365965, 6314.210723659543, 6004.067335894996, 6206.813795586139, 6207.844803879939, 6208.658523781235, 6221.160143380585, 6138.204480310071, 6179.443850053517, 6180.042093475518, 6204.3795620439405, 6225.750969961332, 6068.4841788448475, 6212.627242365473, 6227.96886015567, 6237.126802247598, 6253.530985176221, 5460.972695136499, 6152.661603611844, 6180.7527698891545, 6189.412005859436, 6190.81427557174, 5978.372270911492, 6018.638881667114, 6026.126211699191, 6052.303985041776, 6077.787277445268, 6122.032243765608, 6126.853582554517, 6131.162586540493, 6131.651934473353, 6144.695739097839, 6004.819855404345, 6008.218931538872, 6015.789447369321, 6017.15759793638, 6052.878942421215, 5965.403459654, 6041.6375017499095, 6071.089336599545, 6112.266528016667, 6120.663363515049, 5870.119482077723, 5935.0, 5939.940600593939, 5941.673207973603, 5961.552883533839], "value": 5701.422550914396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.3527884567377, 497.75112443778113, 506.8428787076007, 520.3417676639052, 523.7983376400085, 30408.54387184194, 30669.539956900637, 39307.99999999996, 40751.0, 41069.0, 34889.82555087221, 41816.58183418165, 41957.58042419575, 41988.95027624311, 42163.78918105405, 7907.2488113629115, 9032.77418064547, 9269.768255793591, 9287.442753434781, 9307.395019323756, 8178.0, 8384.371172162113, 10867.891321086807, 11169.49737261821, 11209.215354925158, 11040.227184097117, 11080.335179889193, 11110.777784444306, 11121.110311175087, 11140.275882067639, 8150.5517196554165, 11066.944665276702, 11133.554657813636, 11144.665660030212, 11148.386838723867, 8226.794330141734, 8354.498730076155, 8364.832703345959, 8368.24685778283, 10712.035916767529, 35890.64109358925, 38070.048248793726, 39990.600093998975, 40004.599954000376, 40126.59873401258, 3544.7873127612424, 3716.8141592920515, 4009.498812648419, 4063.1061166543313, 4082.5509193988637, 24777.62833557498, 28969.56545651817, 30307.0, 30322.393552129055, 30355.848220758755, 3131.592892923928, 3226.8547915343865, 3269.591301087364, 3270.329582435595, 3315.1049216711353, 440333.0, 444240.0, 445379.5462045403, 446083.0, 446765.0, 48492.51507484951, 56128.50971922236, 56868.14697779537, 56875.0, 56991.0, 52652.210216846775, 61601.76796464046, 61626.69186654038, 61695.0, 61718.0, 15258.313375898111, 15883.761743573856, 15886.52340429789, 15904.284307205971, 15920.920395397949, 11026.338419694845, 11345.943270283597, 12002.699932501582, 12100.394980251129, 12344.135910486359, 11449.313041217554, 13680.65798355049, 13698.45206191741, 13702.040857139904, 15165.772513412308, 5971.701414929236, 6599.1091202687985, 6902.0, 6969.23338432772, 6996.580205187705, 830.6718846055895, 855.6149732620346, 886.6807949138305, 895.789489469974, 915.1489115122866, 27986.580201296998, 28197.0, 28977.7102228975, 29800.10599682013, 29999.400011999638, 1060.3425875956802, 1067.5729708116814, 1088.2056099047738, 1099.769048499808, 1208.510553225945, 15053.0, 15142.54572362831, 15174.317155728018, 15581.688366232613, 15595.922020390053, 232228.0, 232456.0, 232702.0, 232880.0, 233016.0, 48861.511384886406, 58373.416265837644, 58497.70751146302, 58629.41370586325, 58642.706786465795, 1419.836718777333, 1436.7485690004207, 1457.4024649893493, 1459.153690859299, 1466.296177834624, 23567.0, 27185.72814271832, 28858.42283154283, 29573.408531829675, 29632.259193519472, 48087.03825923532, 48442.5155748438, 48564.0, 48607.75696121497, 48738.0, 499133.0, 502035.0, 502587.0, 503689.0, 504193.0, 37391.0, 37886.62113378831, 38041.42937855879, 38209.617903821716, 38291.85124446271, 43703.0, 43834.780826095666, 44599.77700111479, 45054.0, 45147.32279015883, 34797.434115465374, 36274.8186259067, 36469.45295820618, 37651.81174094112, 37836.0, 27321.86339068292, 28852.855735721187, 33739.81910633116, 34171.65828341685, 35502.8224858874, 34170.658293416745, 34532.30935381228, 34752.0, 34833.825830870686, 34958.65041349656, 29455.85272073626, 31068.533971989986, 31085.378292434478, 31163.84418077986, 31180.53229201609, 18758.531036723645, 20255.392338229878, 23034.308970730235, 23175.88412057929, 23486.530269394174], "value": 18691.545537241545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.52247555702047, 380.14277803552983, 381.0264773503699, 388.84251877989414, 388.9241597888413, 14520.854791452095, 15653.84346156538, 17784.911075444637, 20474.976251187454, 20860.8956955215, 21392.786072139275, 21798.0, 21801.90990450479, 22001.694419809854, 22152.667709984322, 5566.582506312023, 5648.152777083439, 5897.764089436418, 5907.911381329283, 5921.467067963882, 5476.616636835423, 5731.226284451608, 5961.433663801932, 5963.9403605964035, 5973.044312909935, 3383.424817780983, 4094.976255936016, 5561.277033985576, 5639.746211420496, 6576.0, 5963.642181469082, 6244.500439964837, 6588.4729221662155, 6626.73493060277, 6629.436497897685, 5884.852878678024, 5885.970570147122, 5895.734691938873, 5902.763889444417, 5906.3207731110615, 11182.32906025641, 12886.677833054155, 13151.605451836365, 13236.272005039718, 13464.057515973886, 2558.411565339982, 2645.7486538778785, 2648.3908700998877, 2654.429297700984, 2684.6644169478814, 9873.160781333596, 10358.119559837423, 10642.414667193301, 10854.945725271402, 16073.517794466185, 1571.88210884183, 1816.9727454088068, 1820.1354356680604, 1820.1354356680604, 1851.7777866656088, 137459.0, 141268.2936585321, 143134.56865431316, 146796.26601867029, 146859.53140468567, 9677.854832177523, 11386.544538218379, 11433.771324573629, 11496.655100346836, 11739.530418783153, 14969.101853888584, 14976.625584360478, 14993.100413974978, 15000.624984375478, 15021.399144034334, 8307.626156822836, 8520.531370774543, 8533.957330213309, 8677.479351238946, 8709.477431354138, 8359.707410240733, 8360.874586881202, 8387.580620968927, 8516.403851730443, 8539.914600854036, 4066.8816075579452, 4532.297493888453, 4643.95356046442, 4652.209124448852, 4710.552497512799, 1915.3240914200076, 1980.544474770811, 1991.7908619595023, 1996.301294546897, 1998.1707591349718, 942.528735632184, 948.9940662897351, 973.9238141853292, 992.9921130053002, 1026.7484466305802, 18305.450836474927, 19214.519637009187, 21502.191565702145, 21758.02088906003, 21783.455413614785, 963.3064193780467, 978.5107446276861, 1022.3814592171777, 1058.5554067291755, 1069.9144068474504, 10623.025552845216, 11011.61459348935, 11274.0, 11309.09527237819, 11415.429228538706, 698061.0, 702990.0, 713718.0, 713873.0, 714448.0, 125208.1218781719, 137127.0, 140096.59903400837, 146044.0, 150345.0, 938.3056538161848, 948.7248697877538, 971.9271054670928, 974.4056125763278, 976.9413835169912, 18230.270789168284, 18344.816551834843, 18434.63130737351, 18461.446156615322, 18511.889286642843, 49533.009339812284, 59590.70204648949, 61577.99999999821, 61667.0, 62203.377966219756, 85102.0, 87556.5622171885, 87735.68396474185, 87760.1223987752, 89678.0, 8075.475094118863, 8091.109977902308, 8286.0, 8298.419110662437, 8346.666133354598, 12792.296423696785, 13034.957203423894, 13309.267990260629, 13310.201387916755, 13407.932960335136, 11236.0, 11328.150388720715, 11547.653570392902, 11552.711182220512, 11576.479058442223, 9992.500374981077, 11011.953864382871, 11057.170712196777, 11136.10911127124, 11517.481713322753, 10731.0, 10924.126069914546, 11023.669289921316, 11087.611933582286, 11115.88884111181, 7919.920800791919, 7928.246816552418, 8122.39082068859, 8140.7557773264525, 8306.04480484752, 7946.40401969843, 10148.23888208402, 10401.791964160826, 10752.51613677402, 10815.405152716676], "value": 9626.082923759153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.8880645145161, 1464.633841539615, 1470.404486183096, 1485.3167542930257, 1495.7905893174957, 8061.234182752636, 8443.197896199852, 8462.87305690415, 8466.407351485406, 8476.194761497663, 7344.706211751537, 7634.656440460179, 7980.800479988004, 8223.136570660085, 8228.91771082289, 2238.6418173092347, 2277.487565297811, 2282.224043825099, 2286.8170546356337, 2293.3693234360517, 2064.122747832173, 2247.505548779266, 2303.009705826494, 2309.7921187093157, 2313.826463015272, 2048.672212446009, 2069.4515953272394, 2218.101668824129, 2283.703118594589, 2294.6443301288245, 2237.8209743220505, 2262.592733308004, 2267.365137761421, 2268.1494439585153, 2275.112706044644, 2282.2696737044153, 2299.9655005174936, 2307.9538409231723, 2308.6190778521523, 2310.145246258895, 8181.71364002263, 8369.121242269595, 8379.413441059129, 8382.287505562035, 8390.790230244233, 4970.329005584236, 5113.054084994288, 5124.5131712487255, 5125.487451254882, 5129.384473863161, 3209.7271731902583, 3280.2291461506525, 3435.793852368866, 3487.459443786192, 3493.423585108454, 1207.565276500459, 1233.1244816180522, 1239.8388209532702, 1248.332142303863, 1269.641483612535, 10717.517711702993, 10735.980081892285, 10749.462526873547, 10756.515956781963, 10768.892311076946, 4283.1433713257475, 4503.842365517191, 4607.101615185074, 4614.561616646413, 4632.2125238709505, 9314.673986410578, 9426.62293508252, 9455.149036586603, 9455.669051583161, 9476.668316608886, 5189.273501709688, 5189.481051894856, 5191.987562425291, 5198.896022079537, 5276.182191760283, 4630.490646028934, 4637.049404871993, 4669.813207471731, 4708.270218116198, 4715.221988371949, 3685.94471082934, 3722.274156539503, 3771.396576547794, 3806.2197249563774, 3809.695224382043, 1079.924405291622, 1147.4893672315739, 1235.0613533714263, 1238.5231685801032, 1259.1123258103016, 747.6971826410313, 765.8714152686339, 775.1241097559835, 788.3653658804717, 801.3909428834128, 5373.892522149535, 5478.91781623276, 5513.94724877215, 5530.446955304437, 5646.463585959327, 900.9594568244445, 910.1308250620641, 912.6623149434752, 933.3932943586723, 950.7432993091827, 3094.9535756963664, 3642.9453558196647, 3748.981255093707, 3749.2314075614436, 3760.9623903761158, 9462.432254064779, 9914.40513569188, 9946.850797238047, 10041.096301332915, 10057.748556286151, 9624.470654113951, 9859.605615775288, 9895.257855660855, 9948.602055917827, 9953.601855925826, 7654.119776225805, 7840.647170877324, 7841.333486653698, 7867.095284042294, 7872.0, 5345.38528069277, 5377.354717433933, 5437.619366644455, 5486.1222204448695, 5495.395506494203, 8976.0, 9083.409578377385, 9104.044075372256, 9183.908160918305, 9298.302627302844, 8862.822743544964, 9162.725118246462, 9297.953510232675, 9382.202512786489, 9391.624335026523, 6192.628442293297, 7037.577745335297, 7210.783676489504, 7213.9278607213255, 7236.167840698387, 7464.216257292906, 7748.573828439265, 7805.843883122192, 7917.327027202522, 7920.762377128695, 7022.859542809218, 7038.94415837608, 7058.223595404399, 7118.537295075804, 7251.746188883364, 6153.38466153399, 6967.895481567679, 6974.0, 6993.370596646327, 6995.650217489207, 6077.756889724362, 6267.874642507216, 6324.462420694109, 6378.489720822416, 6391.073294372197, 4823.252395878644, 4924.8392243129865, 4931.260310953386, 4942.629302802232, 5074.873128171826, 4898.21628539432, 4937.629677774109, 5034.421041580119, 5040.747962601782, 5066.9239961401345], "value": 4353.563679883402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.5101551734468, 363.95450568678916, 368.70872011111226, 373.4920508108973, 374.69649583837094, 4461.709988850726, 5033.6728112672745, 5276.551493123089, 5305.681659100456, 5327.786888524459, 4956.306117143603, 5197.402298735647, 5198.686584469912, 5240.423553409122, 5264.236685680574, 3400.9829950850212, 3818.599047100049, 3917.2763983847017, 4032.717709760318, 4085.0, 4057.1885622875543, 4062.9639441942263, 4085.1829634073156, 4104.363823607346, 4106.671466282705, 3618.2763447310645, 3670.6696397324235, 4085.0, 4088.121053973395, 4112.2803509385885, 3268.0, 3661.919733678571, 3930.371140617516, 3959.010247438126, 4024.6579040781567, 3258.771885967983, 3563.1982803868923, 3572.3034008368377, 3608.332458495187, 3625.5649322081254, 4409.5007697382725, 4577.702449340783, 4700.529947005306, 4724.763761811896, 4726.26742854858, 4232.873013809591, 4331.7834108294455, 4600.9769951150365, 4724.858254252378, 4823.758812059383, 4956.529129732669, 4991.575716064139, 5549.722513874331, 5578.9163162552595, 5655.1517272409055, 3766.4350347448103, 4051.4530538377235, 4063.2889244382113, 4082.8775136745944, 4107.938380924288, 4606.677532572688, 5078.847634570969, 5258.107081450713, 5420.864478388033, 5880.529557635379, 3489.5986961499243, 3726.8509259629855, 3938.330483817758, 4066.369712694537, 4105.3020986432375, 3452.4648679454726, 4139.027328577782, 4170.601903905266, 4173.165366926627, 4176.893123322322, 4259.914801703949, 4699.365585645963, 4702.553257440538, 4719.174144524694, 4725.936664250585, 4729.0, 5525.530329922001, 5611.7474713637985, 5637.492625663628, 5645.407232240637, 1203.7171264752776, 1256.5036810459817, 1276.3873340796283, 1277.565627686591, 1278.6957303550328, 763.812271917163, 811.9106898241189, 862.0388267082159, 867.869819527076, 868.96524139035, 4369.759663218553, 4424.557544245549, 4605.6776025678555, 4928.028788484635, 4937.136001199776, 4399.844076402604, 4662.487126416091, 5060.9381324298265, 5386.13821788512, 5432.70120143388, 4472.658202539225, 4653.790579423934, 4717.599004084623, 4856.660033797671, 4886.0, 2507.160101366063, 2697.9460410791676, 2824.884170752541, 2868.3976364963173, 2885.9422811544073, 5532.336119665585, 5650.0, 5681.772729090872, 5683.829485115453, 5694.60137790359, 4610.596879979611, 5338.092524270884, 5341.973290133525, 5586.888262234814, 5637.492625663628, 5633.492985631313, 5648.265725455664, 5679.233303503974, 5736.508507788005, 5745.569082318842, 4874.926876096933, 5107.770150343318, 5353.78584856617, 5357.973210133924, 5362.436944120967, 4499.91000179988, 4967.3424717775815, 5113.5966095934855, 5464.207689885024, 5485.424030476743, 4825.565699087099, 4845.781939812647, 5829.970850145722, 5848.473637372486, 5881.353051164283, 3209.743220542398, 3353.312570922906, 3734.8048624439916, 3833.849845046531, 3859.864904728321, 5152.6650767699975, 5704.664455014302, 5726.828195154152, 5741.942580574141, 5764.434826502166, 4547.795349209227, 5191.792328306977, 5538.6122971391615, 5548.667079975215, 5561.332640083216, 5497.560195184456, 5530.695811730394, 5533.446655334596, 5536.7785288588, 5543.695096769717, 3891.221755648938, 5014.974925125351, 5392.946070539245, 5412.945870541244, 5438.102713052302, 5262.921101174326, 5292.867678308073, 5612.214289999485, 5635.718214089197, 5675.31896172462, 4468.888277793081, 5505.532029777353, 5529.778808847601, 5532.806351777668, 5538.196961440488], "value": 4004.3763327948204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.1109318897969, 721.5634541102629, 752.180123665205, 775.6936010275941, 840.1682334488854, 13637.113587616797, 14182.00725949184, 14189.219592922385, 14199.361028753705, 14218.715625687493, 14186.21975791331, 14363.497277595287, 14368.71262574748, 14389.78415323771, 14393.208373539452, 677.5866721300004, 695.7703957693949, 699.3286445012768, 853.3557164340914, 854.5599016506504, 869.695606537713, 882.3911501064246, 889.9866502002475, 895.8297923394534, 895.9641614335419, 936.7985883035146, 937.4984383354872, 938.3431597881477, 938.9718258506958, 939.2532936315646, 727.8471520980601, 741.8664640364732, 889.2574700125404, 890.0743227043866, 892.2638822971074, 669.621663759974, 678.5284227461916, 686.8935315026179, 697.006765359366, 697.1146643762394, 14884.404623815035, 14996.47512337063, 14998.250087495582, 15004.399824007027, 15042.398304067825, 12441.253524788452, 13043.282619455926, 13117.803232951514, 13247.536336228282, 13322.400491977884, 12485.375731213493, 13029.86970130296, 13055.412506437233, 13242.86757132426, 13718.17690938547, 4110.91778164438, 4444.088961762831, 4463.419755431805, 4467.1735728889935, 4714.599259062984, 101108.9889101107, 104484.0, 105096.47451762692, 105954.47022764914, 107392.0, 10383.792324153626, 10390.948045259725, 10785.29895556802, 10818.891811081945, 11010.39442830636, 20423.489412764502, 20563.588728225353, 20716.067776950073, 20804.687929681066, 20850.58298834015, 6612.504062195355, 7561.432892533082, 7572.323292573858, 7588.886166707503, 7764.417668674872, 3774.509313789245, 4272.700910936204, 4272.786360681954, 4325.43769309994, 4478.328250762412, 3401.3367393358058, 3440.724742020632, 3488.8255587220538, 3508.964910350915, 3736.439534069911, 710.2506855267638, 712.4158190284021, 720.8594324106749, 730.8684436801427, 732.3262598409476, 622.5237693164732, 685.3934268172603, 693.8577591593711, 735.4961851131992, 738.4609235258291, 9995.150412215044, 10382.221333400024, 10408.843867341995, 10437.739056523496, 10580.894191058145, 692.6363659079024, 704.830840598263, 712.5653351455608, 721.3039416962656, 728.2899173305984, 4643.489216186217, 4970.627202959792, 4976.0, 4981.875453113628, 4985.52637499437, 91675.0, 93838.53080734552, 95242.523787382, 95764.52117739366, 97549.0, 91808.0, 94116.52941735384, 95142.0, 96318.0, 98286.0, 76574.617126914, 79161.60419197867, 79444.92368448645, 80309.59845200737, 80357.0, 8422.915770842214, 9670.0, 9720.270979676694, 9777.560009799434, 9825.606975720892, 44738.3289250655, 45876.77061614671, 52874.73562632162, 55249.44750552604, 55764.60588485158, 66694.66610667856, 68149.65925170343, 69251.30748692449, 69924.0, 70575.64712176406, 12723.0, 13281.535146269835, 13289.534866279633, 13350.465981360638, 13568.59294221175, 14723.263836808332, 14820.481283155037, 14851.777223341875, 14938.850611493746, 15539.922300388425, 11706.88293117058, 13586.388612512263, 13714.0, 13838.4464621414, 14309.856901430852, 13232.603021909357, 13236.602901912958, 13547.661308467366, 13776.380062896993, 14222.146671199762, 13162.670933226746, 13349.599512014654, 13406.664833379244, 13528.458861645424, 13800.93099534496, 9450.43297402158, 10866.239363244496, 11001.22991390595, 11217.943910280397, 11488.655340339803, 10855.348679079281, 10974.615888443866, 11005.119590432907, 11280.605178818701, 11564.0], "value": 7551.373610565259, "unit": "score"}], "name": "dromaeo_css", "value": 7162.89149117921, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 112.0, 112.0, 113.0, 112.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 109.0, 148.0, 117.0, 132.0, 131.0, 111.0, 130.0, 109.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 183.0, 185.0, 185.0, 181.0, 184.0, 182.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 87.0, 62.0, 59.0, 59.0, 59.0, 74.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 86.0, 71.0, 68.0, 68.0, 82.0, 68.0, 68.0, 84.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 86.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 86.0, 89.0, 85.0, 85.0, 86.0, 86.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 71.0, 75.0, 73.0, 68.0, 70.0, 70.0, 71.0, 72.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 88.0, 86.0, 98.0, 101.0, 100.0, 101.0, 91.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 141.0, 160.0, 151.0, 150.0, 138.0, 152.0, 205.0, 158.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 177.0, 171.0, 177.0, 172.0, 173.0, 176.0, 175.0, 175.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 79.0, 82.0, 83.0, 73.0, 66.0, 67.0, 68.0, 67.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1447.6, "alertThreshold": 2.0}]} 20:19:10 INFO - Return code: 0 20:19:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:19:10 ERROR - # TBPL SUCCESS # 20:19:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:19:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:19:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:19:10 INFO - 2017-01-20 20:19:10.791 screenresolution[1650:10009] starting screenresolution argv=screenresolution get 20:19:10 INFO - 2017-01-20 20:19:10.793 screenresolution[1650:10009] Display 0: 1600x1200x32@60 20:19:10 INFO - 2017-01-20 20:19:10.800 screenresolution[1651:10012] starting screenresolution argv=screenresolution list 20:19:10 INFO - Available Modes on Display 0 20:19:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:19:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:19:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:19:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:19:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:19:11 INFO - Intel Iris: 20:19:11 INFO - Chipset Model: Intel Iris 20:19:11 INFO - Type: GPU 20:19:11 INFO - Bus: Built-In 20:19:11 INFO - VRAM (Dynamic, Max): 1536 MB 20:19:11 INFO - Vendor: Intel (0x8086) 20:19:11 INFO - Device ID: 0x0a2e 20:19:11 INFO - Revision ID: 0x0009 20:19:11 INFO - Displays: 20:19:11 INFO - Display: 20:19:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:19:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:19:11 INFO - Display Serial Number: 1600x1200 60 20:19:11 INFO - Main Display: Yes 20:19:11 INFO - Mirror: Off 20:19:11 INFO - Online: Yes 20:19:11 INFO - Rotation: Supported 20:19:11 INFO - Return code: 0 20:19:11 INFO - Running post-action listener: _resource_record_post_action 20:19:11 INFO - [mozharness: 2017-01-21 04:19:11.037105Z] Finished run-tests step (success) 20:19:11 INFO - Running post-run listener: _resource_record_post_run 20:19:11 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 38794240; Write bytes: 552286208; Read time: 377; Write time: 1765 20:19:11 INFO - TinderboxPrint: CPU usage
54.0% 20:19:11 INFO - TinderboxPrint: I/O read bytes / time
38,794,240 / 377 20:19:11 INFO - TinderboxPrint: I/O write bytes / time
552,286,208 / 1,765 20:19:11 INFO - TinderboxPrint: CPU idle
2,215.4 (46.0%) 20:19:11 INFO - TinderboxPrint: CPU system
960.1 (19.9%) 20:19:11 INFO - TinderboxPrint: CPU user
1,638.2 (34.0%) 20:19:11 INFO - TinderboxPrint: Swap in / out
289,464,320 / 0 20:19:11 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 252563968; Write bytes: 242829312; Read time: 18083; Write time: 606 20:19:11 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31300608; Write bytes: 295829504; Read time: 285; Write time: 1123 20:19:11 INFO - Running post-run listener: _upload_blobber_files 20:19:11 INFO - Blob upload gear active. 20:19:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:19:11 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 20:19:11 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'] 20:19:11 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 20:19:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:12 INFO - (blobuploader) - INFO - Done attempting. 20:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:13 INFO - (blobuploader) - INFO - Done attempting. 20:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:14 INFO - (blobuploader) - INFO - Done attempting. 20:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:16 INFO - (blobuploader) - INFO - Done attempting. 20:19:16 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:16 INFO - Return code: 0 20:19:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952674116994816315f03497ada8ee182e46fc14dc9d323592df9219ea30a866c31b76b6b901f2a4c83d1a2e7e0f90654bea00b892e3821c702ab19c749a66e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca0671834c8d83fe96e45b1e8fbf8c64f560f802421a228e77498be19aca36c74173d9b97e2f831626e9c9c606de287d6f49ba62a576e740b4974c01eda25b02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1ddeb17579a60b8516dd2d12f87050ac17f1eef37777fc60879cfa6df550d4acd1d2186f36ca9b4fa419dfa04408e6748f952a95bd79237596c3c3ef969d3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14da30259240962f2bf7762dc12e2cd489b81e2128f83dbe913ae5913769fefa2e44f35f5b38505327e7c715ab226d707ba9476b24dc1823e4b3d131ea09ce40"} 20:19:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:16 INFO - Contents: 20:19:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952674116994816315f03497ada8ee182e46fc14dc9d323592df9219ea30a866c31b76b6b901f2a4c83d1a2e7e0f90654bea00b892e3821c702ab19c749a66e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca0671834c8d83fe96e45b1e8fbf8c64f560f802421a228e77498be19aca36c74173d9b97e2f831626e9c9c606de287d6f49ba62a576e740b4974c01eda25b02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1ddeb17579a60b8516dd2d12f87050ac17f1eef37777fc60879cfa6df550d4acd1d2186f36ca9b4fa419dfa04408e6748f952a95bd79237596c3c3ef969d3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14da30259240962f2bf7762dc12e2cd489b81e2128f83dbe913ae5913769fefa2e44f35f5b38505327e7c715ab226d707ba9476b24dc1823e4b3d131ea09ce40"} 20:19:16 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:16 INFO - Copying logs to upload dir... 20:19:16 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.977701 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-20 20:19:16.861290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 20:19:16.864327) ========= 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.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/952674116994816315f03497ada8ee182e46fc14dc9d323592df9219ea30a866c31b76b6b901f2a4c83d1a2e7e0f90654bea00b892e3821c702ab19c749a66e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca0671834c8d83fe96e45b1e8fbf8c64f560f802421a228e77498be19aca36c74173d9b97e2f831626e9c9c606de287d6f49ba62a576e740b4974c01eda25b02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1ddeb17579a60b8516dd2d12f87050ac17f1eef37777fc60879cfa6df550d4acd1d2186f36ca9b4fa419dfa04408e6748f952a95bd79237596c3c3ef969d3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14da30259240962f2bf7762dc12e2cd489b81e2128f83dbe913ae5913769fefa2e44f35f5b38505327e7c715ab226d707ba9476b24dc1823e4b3d131ea09ce40"} build_url:https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011024 build_url: 'https://queue.taskcluster.net/v1/task/B8UVHxAKQgWdf2PfXnE1Gw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952674116994816315f03497ada8ee182e46fc14dc9d323592df9219ea30a866c31b76b6b901f2a4c83d1a2e7e0f90654bea00b892e3821c702ab19c749a66e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca0671834c8d83fe96e45b1e8fbf8c64f560f802421a228e77498be19aca36c74173d9b97e2f831626e9c9c606de287d6f49ba62a576e740b4974c01eda25b02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1ddeb17579a60b8516dd2d12f87050ac17f1eef37777fc60879cfa6df550d4acd1d2186f36ca9b4fa419dfa04408e6748f952a95bd79237596c3c3ef969d3b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14da30259240962f2bf7762dc12e2cd489b81e2128f83dbe913ae5913769fefa2e44f35f5b38505327e7c715ab226d707ba9476b24dc1823e4b3d131ea09ce40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 20:19:16.898373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 20:19:16.898778) ========= 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.Z0btKytX24/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.UWGobqv2Lt/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005287 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 20:19:16.946832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 20:19:16.947147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 20:19:16.947438) ========= ========= Total master_lag: 0.18 =========