builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0248 starttime: 1485373597.53 results: success (0) buildid: 20170125102631 builduid: 3603bffc2ae14d0095d0ec2975493d4d revision: 24d9eb148461bb4789848b9880867c63c783a2ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.526175) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.527180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.527959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.553705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.554130) ========= 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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 11:46:37-- 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% 157M=0s 2017-01-25 11:46:37 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.722861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.723201) ========= 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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.020838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:37.771939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:46:37.772311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 24d9eb148461bb4789848b9880867c63c783a2ca --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 24d9eb148461bb4789848b9880867c63c783a2ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 11:46:37,866 truncating revision to first 12 chars 2017-01-25 11:46:37,866 Setting DEBUG logging. 2017-01-25 11:46:37,866 attempt 1/10 2017-01-25 11:46:37,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/24d9eb148461?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 11:46:39,198 unpacking tar archive at: mozilla-central-24d9eb148461/testing/mozharness/ program finished with exit code 0 elapsedTime=1.602398 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:46:39.401912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:39.402690) ========= script_repo_revision: 24d9eb148461bb4789848b9880867c63c783a2ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:39.403590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:39.404315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:39.425154) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 11:46:39.425483) ========= /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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:46:39 INFO - MultiFileLogger online at 20170125 11:46:39 in /builds/slave/test 11:46:39 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 11:46:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:39 INFO - {'append_to_log': False, 11:46:39 INFO - 'base_work_dir': '/builds/slave/test', 11:46:39 INFO - 'blob_upload_branch': 'Firefox', 11:46:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:39 INFO - 'branch': 'Firefox', 11:46:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:39 INFO - 'config_files': ('talos/mac_config.py',), 11:46:39 INFO - 'default_actions': ('clobber', 11:46:39 INFO - 'read-buildbot-config', 11:46:39 INFO - 'download-and-extract', 11:46:39 INFO - 'populate-webroot', 11:46:39 INFO - 'create-virtualenv', 11:46:39 INFO - 'install', 11:46:39 INFO - 'run-tests'), 11:46:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:39 INFO - 'download_minidump_stackwalk': True, 11:46:39 INFO - 'download_symbols': 'ondemand', 11:46:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:39 INFO - 'installer_path': 'installer.exe', 11:46:39 INFO - 'log_level': 'info', 11:46:39 INFO - 'log_name': 'talos', 11:46:39 INFO - 'log_to_console': True, 11:46:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:46:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:46:39 INFO - 'opt_config_files': (), 11:46:39 INFO - 'pip_index': False, 11:46:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:39 INFO - 'cmd': ('bash', 11:46:39 INFO - '-c', 11:46:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:39 INFO - 'enabled': True, 11:46:39 INFO - 'halt_on_failure': False, 11:46:39 INFO - 'name': 'check_screen_resolution'},), 11:46:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:39 INFO - 'cmd': ('bash', 11:46:39 INFO - '-c', 11:46:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:39 INFO - 'enabled': True, 11:46:39 INFO - 'halt_on_failure': False, 11:46:39 INFO - 'name': 'check_screen_resolution'},), 11:46:39 INFO - 'run_cmd_checks_enabled': True, 11:46:39 INFO - 'sps_profile': False, 11:46:39 INFO - 'sps_profile_interval': 0, 11:46:39 INFO - 'suite': 'dromaeojs', 11:46:39 INFO - 'system_bits': '32', 11:46:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:39 INFO - 'title': 't-yosemite-r7-0248', 11:46:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:39 INFO - 'use_talos_json': True, 11:46:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:39 INFO - 'work_dir': 'build'} 11:46:39 INFO - [mozharness: 2017-01-25 19:46:39.638443Z] Running clobber step. 11:46:39 INFO - Running pre-action listener: _resource_record_pre_action 11:46:39 INFO - Running main action method: clobber 11:46:39 INFO - rmtree: /builds/slave/test/build 11:46:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:41 INFO - Running post-action listener: _resource_record_post_action 11:46:41 INFO - [mozharness: 2017-01-25 19:46:41.283884Z] Finished clobber step (success) 11:46:41 INFO - [mozharness: 2017-01-25 19:46:41.284195Z] Running read-buildbot-config step. 11:46:41 INFO - Running pre-action listener: _resource_record_pre_action 11:46:41 INFO - Running main action method: read_buildbot_config 11:46:41 INFO - Using buildbot properties: 11:46:41 INFO - { 11:46:41 INFO - "project": "", 11:46:41 INFO - "product": "firefox", 11:46:41 INFO - "script_repo_revision": "production", 11:46:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:46:41 INFO - "repository": "", 11:46:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:46:41 INFO - "buildid": "20170125102631", 11:46:41 INFO - "pgo_build": "False", 11:46:41 INFO - "basedir": "/builds/slave/test", 11:46:41 INFO - "buildnumber": 72, 11:46:41 INFO - "slavename": "t-yosemite-r7-0248", 11:46:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:46:41 INFO - "platform": "yosemite_r7", 11:46:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:46:41 INFO - "branch": "mozilla-central", 11:46:41 INFO - "repo_path": "mozilla-central", 11:46:41 INFO - "revision": "24d9eb148461bb4789848b9880867c63c783a2ca", 11:46:41 INFO - "stage_platform": "macosx64", 11:46:41 INFO - "builduid": "3603bffc2ae14d0095d0ec2975493d4d", 11:46:41 INFO - "slavebuilddir": "test" 11:46:41 INFO - } 11:46:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 11:46:41 INFO - Running post-action listener: _resource_record_post_action 11:46:41 INFO - [mozharness: 2017-01-25 19:46:41.290096Z] Finished read-buildbot-config step (success) 11:46:41 INFO - [mozharness: 2017-01-25 19:46:41.290254Z] Running download-and-extract step. 11:46:41 INFO - Running pre-action listener: _resource_record_pre_action 11:46:41 INFO - Running main action method: download_and_extract 11:46:41 INFO - mkdir: /builds/slave/test/build/tests 11:46:41 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')]} 11:46:41 INFO - trying https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 11:46:41 INFO - Downloading https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 11:46:42 INFO - Downloaded 1199 bytes. 11:46:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:46:42 INFO - Using the following test package requirements: 11:46:42 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:46:42 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 11:46:42 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 11:46:42 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'jsshell-mac.zip'], 11:46:42 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 11:46:42 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:46:42 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 11:46:42 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 11:46:42 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 11:46:42 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:46:42 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 11:46:42 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:46:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:46:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:46:42 INFO - Fetch https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:46:43 INFO - Expected file size: 16351498 11:46:43 INFO - Obtained file size: 16351498 11:46:50 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:46:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:46:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:46:50 INFO - Fetch https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:46:51 INFO - Expected file size: 16351498 11:46:51 INFO - Obtained file size: 16351498 11:46:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 11:46:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:46:57 INFO - Fetch https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 11:46:59 INFO - Expected file size: 14403435 11:46:59 INFO - Obtained file size: 14403435 11:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:59 INFO - trying https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:46:59 INFO - Downloading https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 11:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 11:47:01 INFO - Downloaded 69895666 bytes. 11:47:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:47:01 INFO - mkdir: /builds/slave/test/properties 11:47:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:01 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:01 INFO - Contents: 11:47:01 INFO - build_url:https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:47:02 INFO - Running post-action listener: _resource_record_post_action 11:47:02 INFO - Running post-action listener: set_extra_try_arguments 11:47:02 INFO - [mozharness: 2017-01-25 19:47:02.051129Z] Finished download-and-extract step (success) 11:47:02 INFO - [mozharness: 2017-01-25 19:47:02.051261Z] Running populate-webroot step. 11:47:02 INFO - Running pre-action listener: _resource_record_pre_action 11:47:02 INFO - Running main action method: populate_webroot 11:47:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:02 INFO - '--tppagecycles', 11:47:02 INFO - '7'], 11:47:02 INFO - 'tests': ['tsvgm']}}, 11:47:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['damp', 'tps']}, 11:47:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'tests': ['damp', 'tps']}, 11:47:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['dromaeo_dom']}, 11:47:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['basic_compositor_video']}, 11:47:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['tsvgx', 11:47:02 INFO - 'tsvgr_opacity', 11:47:02 INFO - 'tart', 11:47:02 INFO - 'tscrollx', 11:47:02 INFO - 'cart', 11:47:02 INFO - 'tsvg_static']}, 11:47:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:02 INFO - 'tsvgr_opacity', 11:47:02 INFO - 'tart', 11:47:02 INFO - 'tscrollx', 11:47:02 INFO - 'cart', 11:47:02 INFO - 'tsvg_static']}, 11:47:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'talos_options': ['--disable-e10s'], 11:47:02 INFO - 'tests': ['tp5o']}, 11:47:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:47:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'talos_options': ['--disable-e10s', 11:47:02 INFO - '--xperf_path', 11:47:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:02 INFO - 'tests': ['tp5n']}, 11:47:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:47:02 INFO - 'talos_options': ['--xperf_path', 11:47:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:02 INFO - 'tests': ['tp5n']}}, 11:47:02 INFO - 'talos.zip': {'path': '', 11:47:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:02 INFO - Running post-action listener: _resource_record_post_action 11:47:02 INFO - [mozharness: 2017-01-25 19:47:02.070133Z] Finished populate-webroot step (success) 11:47:02 INFO - [mozharness: 2017-01-25 19:47:02.070247Z] Running create-virtualenv step. 11:47:02 INFO - Running pre-action listener: _resource_record_pre_action 11:47:02 INFO - Running main action method: create_virtualenv 11:47:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:02 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 11:47:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:02 INFO - Using real prefix '/tools/python27' 11:47:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:05 INFO - Installing pip.................done. 11:47:05 INFO - Return code: 0 11:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:05 INFO - Reading from file tmpfile_stdout 11:47:05 INFO - Output received: 11:47:05 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) 11:47:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:05 INFO - 'HOME': '/Users/cltbld', 11:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:05 INFO - 'LOGNAME': 'cltbld', 11:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:05 INFO - 'MOZ_NO_REMOTE': '1', 11:47:05 INFO - 'NO_EM_RESTART': '1', 11:47:05 INFO - 'PAGER': '/bin/cat', 11:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:05 INFO - 'PWD': '/builds/slave/test', 11:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:05 INFO - 'SHELL': '/bin/bash', 11:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:05 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:05 INFO - 'USER': 'cltbld', 11:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:05 INFO - 'XPC_FLAGS': '0x0', 11:47:05 INFO - 'XPC_SERVICE_NAME': '0', 11:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:06 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 11:47:06 INFO - Cleaning up... 11:47:06 INFO - Return code: 0 11:47:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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', '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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:47: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 psutil>=3.1.1 11:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:06 INFO - 'HOME': '/Users/cltbld', 11:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:06 INFO - 'LOGNAME': 'cltbld', 11:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:06 INFO - 'MOZ_NO_REMOTE': '1', 11:47:06 INFO - 'NO_EM_RESTART': '1', 11:47:06 INFO - 'PAGER': '/bin/cat', 11:47:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:06 INFO - 'PWD': '/builds/slave/test', 11:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:06 INFO - 'SHELL': '/bin/bash', 11:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:06 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:06 INFO - 'USER': 'cltbld', 11:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:06 INFO - 'XPC_FLAGS': '0x0', 11:47:06 INFO - 'XPC_SERVICE_NAME': '0', 11:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:06 INFO - Downloading/unpacking psutil>=3.1.1 11:47:06 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 11:47:06 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 11:47:06 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 11:47:06 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 11:47:06 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 11:47:06 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 11:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:10 INFO - Installing collected packages: psutil 11:47:10 INFO - Running setup.py install for psutil 11:47:10 INFO - building 'psutil._psutil_osx' extension 11:47:10 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 11:47:10 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 11:47:10 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 11:47:10 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 11:47:10 INFO - building 'psutil._psutil_posix' extension 11:47:10 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 11:47:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:47:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:47:10 INFO - ^ 11:47:10 INFO - 1 warning generated. 11:47:10 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 11:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:11 INFO - Successfully installed psutil 11:47:11 INFO - Cleaning up... 11:47:11 INFO - Return code: 0 11:47:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:11 INFO - 'HOME': '/Users/cltbld', 11:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:11 INFO - 'LOGNAME': 'cltbld', 11:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:11 INFO - 'MOZ_NO_REMOTE': '1', 11:47:11 INFO - 'NO_EM_RESTART': '1', 11:47:11 INFO - 'PAGER': '/bin/cat', 11:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:11 INFO - 'PWD': '/builds/slave/test', 11:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:11 INFO - 'SHELL': '/bin/bash', 11:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:11 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:11 INFO - 'USER': 'cltbld', 11:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:11 INFO - 'XPC_FLAGS': '0x0', 11:47:11 INFO - 'XPC_SERVICE_NAME': '0', 11:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:47:11 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 11:47:11 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 11:47:11 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 11:47:11 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 11:47:11 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 11:47:11 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 11:47:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:47:14 INFO - Installing collected packages: mozsystemmonitor 11:47:14 INFO - Running setup.py install for mozsystemmonitor 11:47:14 INFO - Successfully installed mozsystemmonitor 11:47:14 INFO - Cleaning up... 11:47:14 INFO - Return code: 0 11:47:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:47:14 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')]} 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:14 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')]} 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:14 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:14 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 11:47:14 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 11:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:14 INFO - 'HOME': '/Users/cltbld', 11:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:14 INFO - 'LOGNAME': 'cltbld', 11:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:14 INFO - 'MOZ_NO_REMOTE': '1', 11:47:14 INFO - 'NO_EM_RESTART': '1', 11:47:14 INFO - 'PAGER': '/bin/cat', 11:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:14 INFO - 'PWD': '/builds/slave/test', 11:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:14 INFO - 'SHELL': '/bin/bash', 11:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:14 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:14 INFO - 'USER': 'cltbld', 11:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:14 INFO - 'XPC_FLAGS': '0x0', 11:47:14 INFO - 'XPC_SERVICE_NAME': '0', 11:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:17 INFO - warning: no files found matching '*.txt' 11:47:17 INFO - no previously-included directories found matching 'build' 11:47:17 INFO - no previously-included directories found matching 'dist' 11:47:17 INFO - no previously-included directories found matching '.git*' 11:47:17 INFO - Installing collected packages: jsonschema, functools32 11:47:17 INFO - Running setup.py install for functools32 11:47:17 INFO - warning: no files found matching '*.txt' 11:47:17 INFO - no previously-included directories found matching 'build' 11:47:17 INFO - no previously-included directories found matching 'dist' 11:47:17 INFO - no previously-included directories found matching '.git*' 11:47:17 INFO - Successfully installed jsonschema functools32 11:47:17 INFO - Cleaning up... 11:47:18 INFO - Return code: 0 11:47:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:18 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 11:47:18 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 11:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:18 INFO - 'HOME': '/Users/cltbld', 11:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:18 INFO - 'LOGNAME': 'cltbld', 11:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:18 INFO - 'MOZ_NO_REMOTE': '1', 11:47:18 INFO - 'NO_EM_RESTART': '1', 11:47:18 INFO - 'PAGER': '/bin/cat', 11:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:18 INFO - 'PWD': '/builds/slave/test', 11:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:18 INFO - 'SHELL': '/bin/bash', 11:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:18 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:18 INFO - 'USER': 'cltbld', 11:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:18 INFO - 'XPC_FLAGS': '0x0', 11:47:18 INFO - 'XPC_SERVICE_NAME': '0', 11:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:47:18 INFO - Cleaning up... 11:47:18 INFO - Return code: 0 11:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:18 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 11:47:18 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 11:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:18 INFO - 'HOME': '/Users/cltbld', 11:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:18 INFO - 'LOGNAME': 'cltbld', 11:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:18 INFO - 'MOZ_NO_REMOTE': '1', 11:47:18 INFO - 'NO_EM_RESTART': '1', 11:47:18 INFO - 'PAGER': '/bin/cat', 11:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:18 INFO - 'PWD': '/builds/slave/test', 11:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:18 INFO - 'SHELL': '/bin/bash', 11:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:18 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:18 INFO - 'USER': 'cltbld', 11:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:18 INFO - 'XPC_FLAGS': '0x0', 11:47:18 INFO - 'XPC_SERVICE_NAME': '0', 11:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:21 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 11:47:22 INFO - Downloading docopt-0.6.1.tar.gz 11:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:22 INFO - Running setup.py install for blobuploader 11:47:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:22 INFO - Running setup.py install for requests 11:47:23 INFO - Running setup.py install for docopt 11:47:23 INFO - Successfully installed blobuploader requests docopt 11:47:23 INFO - Cleaning up... 11:47:23 INFO - Return code: 0 11:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:23 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:23 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 11:47:23 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 11:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:23 INFO - 'HOME': '/Users/cltbld', 11:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:23 INFO - 'LOGNAME': 'cltbld', 11:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:23 INFO - 'MOZ_NO_REMOTE': '1', 11:47:23 INFO - 'NO_EM_RESTART': '1', 11:47:23 INFO - 'PAGER': '/bin/cat', 11:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:23 INFO - 'PWD': '/builds/slave/test', 11:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:23 INFO - 'SHELL': '/bin/bash', 11:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:23 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:23 INFO - 'USER': 'cltbld', 11:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:23 INFO - 'XPC_FLAGS': '0x0', 11:47:23 INFO - 'XPC_SERVICE_NAME': '0', 11:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:23 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-luYnHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:23 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ALYCTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:23 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Nisy1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:23 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Bfm77q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-96xXjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-oLIm6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-9nRJgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-fTnRUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-dBKbIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-v0nk0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Fwyh0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-kPAk0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-3bAjeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:24 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Sjq1ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:25 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-2zBmTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:25 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-I37ISI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:25 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-dem1Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:25 INFO - Running setup.py install for manifestparser 11:47:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:25 INFO - Running setup.py install for mozcrash 11:47:25 INFO - Running setup.py install for mozdebug 11:47:25 INFO - Running setup.py install for mozdevice 11:47:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:25 INFO - Running setup.py install for mozfile 11:47:26 INFO - Running setup.py install for mozhttpd 11:47:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Running setup.py install for mozinfo 11:47:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Running setup.py install for mozInstall 11:47:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Running setup.py install for mozleak 11:47:26 INFO - Running setup.py install for mozlog 11:47:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:26 INFO - Running setup.py install for moznetwork 11:47:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Running setup.py install for mozprocess 11:47:27 INFO - Running setup.py install for mozprofile 11:47:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Running setup.py install for mozrunner 11:47:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Running setup.py install for mozscreenshot 11:47:27 INFO - Running setup.py install for moztest 11:47:27 INFO - Running setup.py install for mozversion 11:47:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:27 INFO - Cleaning up... 11:47:27 INFO - Return code: 0 11:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:27 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:27 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 11:47:27 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 11:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:27 INFO - 'HOME': '/Users/cltbld', 11:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:27 INFO - 'LOGNAME': 'cltbld', 11:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:27 INFO - 'MOZ_NO_REMOTE': '1', 11:47:27 INFO - 'NO_EM_RESTART': '1', 11:47:27 INFO - 'PAGER': '/bin/cat', 11:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:27 INFO - 'PWD': '/builds/slave/test', 11:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:27 INFO - 'SHELL': '/bin/bash', 11:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:27 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:27 INFO - 'USER': 'cltbld', 11:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:27 INFO - 'XPC_FLAGS': '0x0', 11:47:27 INFO - 'XPC_SERVICE_NAME': '0', 11:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-V1abva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-mhR94j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-8HJGfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-0UcnuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-tiZTzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-s3T850-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-uvnI04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:28 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)) 11:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-is8GqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-_8f0bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-G7g3Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ZbU61P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Q3AciS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-bUZb4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Rg7hH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ZSefk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-004bxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-llHSpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:32 INFO - Downloading blessings-1.6.tar.gz 11:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:32 INFO - Installing collected packages: blessings 11:47:32 INFO - Running setup.py install for blessings 11:47:32 INFO - Successfully installed blessings 11:47:32 INFO - Cleaning up... 11:47:33 INFO - Return code: 0 11:47:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:33 INFO - Reading from file tmpfile_stdout 11:47:33 INFO - Current package versions: 11:47:33 INFO - blessings == 1.6 11:47:33 INFO - blobuploader == 1.2.4 11:47:33 INFO - docopt == 0.6.1 11:47:33 INFO - functools32 == 3.2.3-2 11:47:33 INFO - jsonschema == 2.5.1 11:47:33 INFO - manifestparser == 1.1 11:47:33 INFO - mozInstall == 1.12 11:47:33 INFO - mozcrash == 1.0 11:47:33 INFO - mozdebug == 0.1 11:47:33 INFO - mozdevice == 0.49 11:47:33 INFO - mozfile == 1.2 11:47:33 INFO - mozhttpd == 0.7 11:47:33 INFO - mozinfo == 0.9 11:47:33 INFO - mozleak == 0.1 11:47:33 INFO - mozlog == 3.4 11:47:33 INFO - moznetwork == 0.27 11:47:33 INFO - mozprocess == 0.24 11:47:33 INFO - mozprofile == 0.28 11:47:33 INFO - mozrunner == 6.13 11:47:33 INFO - mozscreenshot == 0.1 11:47:33 INFO - mozsystemmonitor == 0.3 11:47:33 INFO - moztest == 0.8 11:47:33 INFO - mozversion == 1.4 11:47:33 INFO - psutil == 3.1.1 11:47:33 INFO - requests == 1.2.3 11:47:33 INFO - wsgiref == 0.1.2 11:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:34 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:34 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 11:47:34 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 11:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:34 INFO - 'HOME': '/Users/cltbld', 11:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:34 INFO - 'LOGNAME': 'cltbld', 11:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:34 INFO - 'MOZ_NO_REMOTE': '1', 11:47:34 INFO - 'NO_EM_RESTART': '1', 11:47:34 INFO - 'PAGER': '/bin/cat', 11:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:34 INFO - 'PWD': '/builds/slave/test', 11:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:34 INFO - 'SHELL': '/bin/bash', 11:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:34 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:34 INFO - 'USER': 'cltbld', 11:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:34 INFO - 'XPC_FLAGS': '0x0', 11:47:34 INFO - 'XPC_SERVICE_NAME': '0', 11:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 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)) 11:47:34 INFO - Cleaning up... 11:47:34 INFO - Return code: 0 11:47:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:34 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')]} 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:34 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')]} 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:34 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 0x1072abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9e8c82e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, '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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 11:47:34 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 11:47:34 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 11:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:34 INFO - 'HOME': '/Users/cltbld', 11:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:34 INFO - 'LOGNAME': 'cltbld', 11:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:34 INFO - 'MOZ_NO_REMOTE': '1', 11:47:34 INFO - 'NO_EM_RESTART': '1', 11:47:34 INFO - 'PAGER': '/bin/cat', 11:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:34 INFO - 'PWD': '/builds/slave/test', 11:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:34 INFO - 'SHELL': '/bin/bash', 11:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:34 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:34 INFO - 'USER': 'cltbld', 11:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:34 INFO - 'XPC_FLAGS': '0x0', 11:47:34 INFO - 'XPC_SERVICE_NAME': '0', 11:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:35 INFO - Cleaning up... 11:47:35 INFO - Return code: 0 11:47:35 INFO - Running post-action listener: _resource_record_post_action 11:47:35 INFO - Running post-action listener: _start_resource_monitoring 11:47:35 INFO - Starting resource monitoring. 11:47:35 INFO - [mozharness: 2017-01-25 19:47:35.196338Z] Finished create-virtualenv step (success) 11:47:35 INFO - [mozharness: 2017-01-25 19:47:35.197313Z] Running install step. 11:47:35 INFO - Running pre-action listener: _resource_record_pre_action 11:47:35 INFO - Running main action method: install 11:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:35 INFO - Reading from file tmpfile_stdout 11:47:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:35 INFO - Reading from file tmpfile_stdout 11:47:35 INFO - Output received: 11:47:35 INFO - Usage: mozinstall [options] installer 11:47:35 INFO - Options: 11:47:35 INFO - -h, --help show this help message and exit 11:47:35 INFO - -d DEST, --destination=DEST 11:47:35 INFO - Directory to install application into. [default: 11:47:35 INFO - "/builds/slave/test"] 11:47:35 INFO - --app=APP Application being installed. [default: firefox] 11:47:35 INFO - mkdir: /builds/slave/test/build/application 11:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:47:57 INFO - Reading from file tmpfile_stdout 11:47:57 INFO - Output received: 11:47:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:47:57 INFO - Running post-action listener: _resource_record_post_action 11:47:57 INFO - [mozharness: 2017-01-25 19:47:57.353244Z] Finished install step (success) 11:47:57 INFO - [mozharness: 2017-01-25 19:47:57.353404Z] Running run-tests step. 11:47:57 INFO - Running pre-action listener: _resource_record_pre_action 11:47:57 INFO - Running main action method: run_tests 11:47:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:57 INFO - 2017-01-25 11:47:57.368 screenresolution[2157:19823] starting screenresolution argv=screenresolution get 11:47:57 INFO - 2017-01-25 11:47:57.370 screenresolution[2157:19823] Display 0: 1600x1200x32@60 11:47:57 INFO - 2017-01-25 11:47:57.376 screenresolution[2158:19825] starting screenresolution argv=screenresolution list 11:47:57 INFO - Available Modes on Display 0 11:47:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:57 INFO - Intel Iris: 11:47:57 INFO - Chipset Model: Intel Iris 11:47:57 INFO - Type: GPU 11:47:57 INFO - Bus: Built-In 11:47:57 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:57 INFO - Vendor: Intel (0x8086) 11:47:57 INFO - Device ID: 0x0a2e 11:47:57 INFO - Revision ID: 0x0009 11:47:57 INFO - Displays: 11:47:57 INFO - Display: 11:47:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:57 INFO - Display Serial Number: 1600x1200 60 11:47:57 INFO - Main Display: Yes 11:47:57 INFO - Mirror: Off 11:47:57 INFO - Online: Yes 11:47:57 INFO - Rotation: Supported 11:47:57 INFO - Return code: 0 11:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:57 INFO - Python 2.7.3 11:47:57 INFO - Return code: 0 11:47:57 INFO - grabbing minidump binary from tooltool 11:47:57 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')]} 11:47:57 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 0x107089d30>, '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 0x106fb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10707ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:57 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 11:47:57 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 11:47:57 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 11:47:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:57 INFO - Return code: 0 11:47:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:47:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:47:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:57 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/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--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 11:47:57 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/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0248 --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 11:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jY4qkb1XTw/Render', 11:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:57 INFO - 'HOME': '/Users/cltbld', 11:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:57 INFO - 'LOGNAME': 'cltbld', 11:47:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:57 INFO - 'MOZ_NO_REMOTE': '1', 11:47:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:57 INFO - 'NO_EM_RESTART': '1', 11:47:57 INFO - 'PAGER': '/bin/cat', 11:47:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:57 INFO - 'PWD': '/builds/slave/test', 11:47:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:57 INFO - 'SHELL': '/bin/bash', 11:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m7iEKDQOlp/Listeners', 11:47:57 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 11:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:57 INFO - 'USER': 'cltbld', 11:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:57 INFO - 'XPC_FLAGS': '0x0', 11:47:57 INFO - 'XPC_SERVICE_NAME': '0', 11:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:57 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/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--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 11:47:57 INFO - mozversion application_buildid: 20170125102631 11:47:57 INFO - mozversion application_changeset: 24d9eb148461bb4789848b9880867c63c783a2ca 11:47:57 INFO - mozversion application_display_name: Nightly 11:47:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:57 INFO - mozversion application_name: Firefox 11:47:57 INFO - mozversion application_remotingname: firefox 11:47:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:47:57 INFO - mozversion application_vendor: Mozilla 11:47:57 INFO - mozversion application_version: 54.0a1 11:47:57 INFO - mozversion platform_buildid: 20170125102631 11:47:57 INFO - mozversion platform_changeset: 24d9eb148461bb4789848b9880867c63c783a2ca 11:47:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:47:57 INFO - mozversion platform_version: 54.0a1 11:47:57 INFO - using testdate: 1485373677 11:47:57 INFO - actual date: 1485373677 11:47:57 INFO - starting webserver on 'localhost:54563' 11:47:57 INFO - SUITE-START | Running 2 tests 11:47:57 INFO - TEST-START | dromaeo_css 11:47:57 INFO - operating with platform_type : mac_ 11:47:57 INFO - Initialising browser for dromaeo_css test... 11:47:57 INFO - TEST-INFO | started process 2168 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp8CkR25/profile http://localhost:54563/getInfo.html) 11:48:00 INFO - PROCESS | 2168 | __metrics Screen width/height:1600/1200 11:48:00 INFO - PROCESS | 2168 | colorDepth:24 11:48:00 INFO - PROCESS | 2168 | Browser inner width/height: 1024/689 11:48:00 INFO - PROCESS | 2168 | __metrics 11:48:00 INFO - PROCESS | 2168 | 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" 11:48:00 INFO - PROCESS | 2168 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:01 INFO - TEST-INFO | 2168: exit 0 11:48:01 INFO - Browser initialized. 11:48:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:01 INFO - TEST-INFO | started process 2170 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp8CkR25/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:13 INFO - PROCESS | 2170 | RSS: Main: 235565056 11:48:13 INFO - PROCESS | 2170 | 11:51:15 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54563/tests/dromaeo/cssquery-ext.html) 11:51:17 INFO - PROCESS | 2170 | RSS: Main: 447430656 11:51:17 INFO - PROCESS | 2170 | 11:53:03 INFO - PROCESS | 2170 | ************************* 11:53:03 INFO - PROCESS | 2170 | A coding exception was thrown and uncaught in a Task. 11:53:03 INFO - PROCESS | 2170 | 11:53:03 ERROR - PROCESS | 2170 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:53:03 INFO - PROCESS | 2170 | Full stack: 11:53:03 INFO - PROCESS | 2170 | ************************* 11:54:21 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-ext.html (next: http://localhost:54563/tests/dromaeo/cssquery-jquery.html) 11:54:21 INFO - PROCESS | 2170 | RSS: Main: 378576896 11:54:21 INFO - PROCESS | 2170 | 11:57:24 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54563/tests/dromaeo/cssquery-mootools.html) 11:57:24 INFO - PROCESS | 2170 | RSS: Main: 339390464 11:57:24 INFO - PROCESS | 2170 | 12:00:27 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54563/tests/dromaeo/cssquery-prototype.html) 12:00:27 INFO - PROCESS | 2170 | RSS: Main: 347160576 12:00:27 INFO - PROCESS | 2170 | 12:03:31 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54563/tests/dromaeo/cssquery-yui.html) 12:03:31 INFO - PROCESS | 2170 | RSS: Main: 335097856 12:03:31 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:54563/tests/dromaeo/cssquery-yui.html (next: http://localhost:54563/tests/dromaeo/cssquery-dojo.html) 12:06:35 INFO - PROCESS | 2170 | RSS: Main: 416559104 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | __start_tp_report 12:06:35 INFO - PROCESS | 2170 | _x_x_mozilla_page_load 12:06:35 INFO - PROCESS | 2170 | _x_x_mozilla_page_load_details 12:06:35 INFO - PROCESS | 2170 | |i|pagename|runs| 12:06:35 INFO - PROCESS | 2170 | |0;dojo.html;3276.6231883333426;3278.4426647469927;3284.5073239014146;3310.5696259486263;3332.150301673073;5517.917231241525;5569.275994120769;5610.046292130338;5637.436256374361;5680.914786278204;5583.609147359676;5624.859378515539;5626.718664066791;5630.40880707526;5633.887322253552;5069.543741063304;5070.163423035195;5113.897722045557;5156.92264616031;5160.225966105077;5161.741912904358;5178.741062946857;5225.79096836128;5226.137687281594;5237.476252374751;5034.723090230036;5126.154184559543;5217.478252174771;5221.738913054332;5260.289860868772;4744.813796550862;4964.90070198594;5211.817586384458;5235.869103272411;5237.3453318335205;535.1366009219796;5056.140456122468;5156.587473002151;5187.0922588546855;5243.554297884684;4631.745254011028;5571.944280557183;5585.385607583163;5673.432656734335;5678.858028549278;6216.937830621681;6242.188515492957;6255.812325630239;6259.937400625981;6276.3409841966395;6196.915539780565;6197.163382943335;6215.720292586844;6218.564700470969;6242.282137554194;5635.746391412396;5675.659460432387;5683.090705487102;5688.459596338383;5728.169415434739;6272.341404152498;6277.278113016971;6282.340354262828;6288.434040936338;6290.182276304051;6109.6639684817765;6113.663748493786;6115.327313995457;6115.571909966348;6120.908186377208;6026.367231440723;6133.172021777093;6149.692515374213;6161.045038019114;6191.938080619136;6161.815145545641;6177.6911154443;6194.845128871724;6202.503799696104;6213.97469417541;6212.4408803207925;6220.34686357935;6222.222222222223;6233.189685340967;6233.563650544418;4012.478377810866;4769.189237829577;4887.3890763654545;4890.290907818347;4951;4346.8043938022865;4377;4398.934015989763;4413.8234470621455;4484.304932735431;5554.805581804618;5739.225204597409;5756.3380211276235;5757.683327417032;5762.9914764915975;6147.831911936718;6155.138280640714;6190.3190649028575;6210.813675589739;6228.096925945712;5554.028045092093;5729.4843464088435;5769.1634712967225;5776.740046697909;5792.102224155263;4505.5719706627815;5322.414534401213;5360.946390536123;5361.517463428232;5370.2750128732905;6219.626822390671;6240.31356550779;6244.063390491281;6263.217097862676;6264.31092579825;6241.282252540835;6244.843878903063;6248.187735594343;6251.218597675291;6257.311695713377;6301.684915754102;6327.050942358683;6329.082283069021;6334.588251763621;6406;5932.940670593239;6064.848378790565;6089.2997305310455;6118.877622447615;6189.102580125947;4918.532739389752;6181.350958149509;6193.761247750558;6201.720922558406;6204.7828326008375;5938.881222375615;6051.394860513913;6089.391060894052;6096.29892562361;6107.755689772359;5819.418058194146;5876.08920617305;5891;5935.376785437639;6078.300995385587;4892.290617860462;5789.53683705311;5811.709414529341;5813;5845.678487683218;5924.4667979882015;5945.375735547878;5957.404259574181;5959.970200148971;5973.581849270509;5728.140778883034;5766.077427611562;5799.159121927212;5806.622569532967;5809.564282678901 12:06:35 INFO - PROCESS | 2170 | |1;ext.html;438.75429759334753;444.42003185842464;495.8165478772854;499.54541367355716;505.2572718104386;39415.60584394155;40824.59175408245;41237.38143927843;41246;42804.57195428045;37291.25417491649;38473.80763096188;41397.17205655885;41699.16601667972;41870;8299.253067223948;8520.318374530054;9133;9360.485173315465;9379.812403751921;8329.20872517113;8410.243078122967;8418.957905210465;10901;11247.437628118561;11298.435078246055;11340.546378144863;11342.659720208407;11349.943250283779;11372.31766094037;9536.904630953672;11269.549218031269;11325;11359.318440893572;11370.147238957028;8190.836183276301;8429.283510901581;10933.726656833564;11170.27393219438;11229.157813164045;39847.8007609963;40315.798421008;40354;40422;40477.190456190714;3991.600839916014;4029.8992525186814;4038.6567141792984;4039.6162364575316;4162.229987452331;30387.696123038706;30523.694763052306;30523.847380763174;30604.38791224163;30608.387832243454;3118.158097313735;3260.934781304384;3349.1627093226693;3355.681210285019;3359.5800524934384;438356.80821596005;438587;438833;439996;442001;59859;60571;60690.393096069354;60729.39270607237;60777.78444431087;62860.68569657122;63239;63272.683636581525;63393.09820705386;63413;15766;16011.519654410153;16030.599235019217;16041.358345666044;16044.759328609847;12469.438875250635;12539.811902821464;12549.811752823714;12553.937230313973;12574.245545267313;13549.322533873465;15380.30788614515;15733.68532629341;17236.18886658908;19121.631186632563;7020.438364930793;8844.911550884408;8864.20222180007;8893.866592001124;8938.597763100675;870.8388948044632;874.3791907745572;896.8116695494019;913.9680111196076;923.1737594852569;28941;29874.253143671584;30038;30188.396232075236;30442.847785761373;1020.5662593397776;1033.617561502249;1039.7574897996972;1066.2376400873413;1067.236925598201;11831.763364732657;12430.564930227398;13597.32013399326;14019.719605608036;14347.210903400204;642496;645332;647046.0010899126;647501.0499789978;648172;51646;51985.7400712994;52067.73966130145;52144.739276304135;52324.738376307876;1228.6866848953816;1428.2002078835885;1430.4850253908585;1455.4905782976086;1456.4174330267977;26296.34259143537;27291;27377.452450951267;27743.30641733973;27798;47174.29238561356;47796.566103016965;47896.281555776;47930.520694792605;48014;580254;582317;585958;586217;586677;24421.267361979168;25136.24591262265;25221.991120355713;25575.360615984006;25590.744092558834;34715.65284347225;40449;41871.16257674769;42315;43245.3513197296;30582.694173057986;34842.12894677552;34876.47685284672;34956.47565286574;35891;30486.7805287786;34281.82859085689;34578.135546611535;35669.286614267054;35794.284114317044;35039.47440788339;35115.64884351226;35160;35601.82199088988;36348.818255908554;30275.394492110474;31866.840665796524;32071.518927215642;32160.83919580387;32323.86866459757;19304.710429343853;23775.405614859075;23797.286081417584;23957.16149934744;24528.754712452646 12:06:35 INFO - PROCESS | 2170 | |2;jquery.html;371.1630273732732;391.9274934137184;394.7651147567198;400.9498812648418;420.0255407454706;14973.700525989474;19419.90290048548;19605.901970490144;19669.606607867834;20195.798042019574;20286.638372749894;20733;21121.366359009255;21415.357539273846;21926.561468770615;5678.290213723285;5805.709714514268;5939.07944268639;5969.611975221618;5986.191864098357;5433.673979561219;5869.647821130746;5935.792247271346;5950.166976623276;5958.672273024982;5761.395053519383;5879.7648094076185;5894.793682221123;5902.940970590304;5903.645781253117;5966.254218222723;6131.632102073845;6135.631862088267;6138.202033735586;6148.6618235997;5822;5860.384659610765;5910.231669882931;5939.940600593982;6003.6697981611;13801.792973105412;13865.653358666013;13886.722265554734;19502.609947800964;26122.34694132643;2639.3797457597448;2653.668291463567;2655.74770396812;2703.9729602704115;2708.9864550677316;10113.595456181743;10120.898791012143;10216.94891525545;10531.684049478528;10673.412962287071;1813.4287699374786;1882.3411805867975;1890.3383815664545;1896.6017136401372;1928.4118343905104;133438;138822;140898.29550852283;142892.99999999895;143255.2837235807;11606.129540284344;11664.300141991507;11814;11903.404829758478;12032.27806331623;15448.845511544965;15504.30230639624;15509.224538773016;15511.767323490156;15522.379104835905;8269.336191186354;8277.668893244323;8591.484510929364;8710.608022638997;8736.563171841382;8316.708915187939;8317.8336433271;8320.70877519284;8477.279431248413;8482.491050536988;4118.979405102956;4675.696079754873;4713.95286047142;4735.12400205963;4879.365412586752;1955.559999000242;2011.3965810256864;2012.3962811156593;2013.808688174621;2019.7677267114177;1001.7545701303081;1005.7636455432968;1020.9795804083876;1031.6286136990677;1062.8724553053682;20987;21501.462463438227;21899.562008759734;21949.231776887733;22070.57223705391;867.9392442529089;973.4694591447678;1000.8248556502729;1030.4744580263969;1061.9628313009007;8827.249683776823;10327.277090603737;10331.845022324671;11010.559577616805;11457.54169833214;498811;686531;697103;706584;709479;94349;142531;147036.26481867736;147310;153652;973.532704301939;986.8273052215977;990.5988074829705;1002.7844013537125;1004.9648262310784;18558.979256141043;18633.53416164607;18845.24619015224;18968.905155474135;19022.244438890277;57244.71377643085;57414;58904.41095588989;59202;59211.70394148002;84116.53242539216;85374.31631153225;86010.56994714987;86131.56934215539;86689;7215.963920180366;7553.622318884144;8204.548749818818;8287.875681864898;8716.78208044804;12563.560275390317;13278.203307801563;13337.799933000819;13807.964402669639;13919.025668203129;10910.890891091305;11184.888151118384;11433.371164586028;11469.369184694922;11522.711932201762;9014.639414423349;10708.839367409651;11305.604303849326;11545.249558778652;11609.709757255798;9365;10792.298500597437;11360.375179365214;11829.231099978473;12033;6802.911534154511;7311.963440182765;7472.551646901204;7734.458587898793;7779.18318576564;10383.740406489898;11275.379854108103;11520.53917843277;11662.358570278717;11719.824202636797 12:06:35 INFO - PROCESS | 2170 | |3;mootools.html;1454.9927250363746;1460.664047269128;1468.1191285228865;1485.4726572066916;1486.7100915321514;7872.252136047074;8249.092599814023;8288.378371622122;8299.792505187366;8302.501849889011;7264.455165862555;7448.404127669787;7450.10598728152;7918.564478953655;8065.677372905091;2271.114265436477;2316.5521549031855;2324.360800779782;2324.9883750581225;2326.150954901457;2305.170138750049;2338.1348900906605;2341.426350544119;2346.9647955280684;2349.34218418843;2276.6926464927187;2277.7836105569945;2308.3998160478313;2310;2310.9537809243807;2262.3552287598036;2281.9543609127722;2286.2455389721354;2287.5424915017065;2288.9084436622516;2259.435141214696;2279.8176145908287;2318.2349824558023;2319.791218790317;2319.9792091479694;8249;8297.211764882326;8325.8334833303;8327.583620818996;8329.750107496724;4984;5143.074246635604;5149.150390185652;5152.330197074356;5155.922661160085;3276.2300859298048;3360.8823691170937;3467.791932484059;3536.840842162083;3545.769524980868;1060.1412855587;1211.5517258614282;1218.6161359171833;1219.378117160246;1270.380265161926;10556.997085276964;10686.465676716132;10695.625653102104;10709.892901070967;10711.089557387631;4368.453943257093;4563.361129441881;4649.093426781813;4657.46439159501;4665.113628410591;9323.440593564408;9330.160285574331;9330.673426430043;9337.393069450463;9339.90660093404;5157.226416037549;5189.377274727057;5196.948030519722;5198.2202669599865;5203.271541984125;4553.907062305089;4643.582077613031;4707.058588282357;4741.051789642016;4753.83361582343;3754.7934863582764;3805.1818858944907;3828.444875493038;3876.7673939563715;3890.3969884667354;1070.743021674808;1254.7678679444332;1256.359256779031;1261.5710658376197;1268.2770820632336;783.61211200455;872.3631748823394;877.6621000914694;896.1486587741672;941.9481928493861;5474.753636086386;5553.888922221533;5669.036263835158;5752.201351991868;5827.59206855516;987;998.7652901568125;1003.2826529031777;1015.6902144845893;1035.2804800663616;3322.235885746292;3408.3353746019784;3763.360228761117;3791.5829258781514;3821.197548514843;8978.191962723386;9197.862032069525;9581.425114493153;9905.306628536078;9939.353941993748;9229.307801914883;9673.177779888647;9809.852852207223;9834.409935403899;9836.311458197857;7506.43701722373;7691.384809190133;7725.652345644347;7727.49771264866;7735.265149810759;5610.635308704921;5627.90255900112;5634.492895639412;5732.3121225453215;5901.439363260483;9073.455592664197;9178.265738741018;9185.49479778592;9205.079492050741;9207.309451791009;8904;9112.225460835904;9298.395604285699;9375.531223438937;9375.671851485165;6206.441420272197;6245.219347581552;6573.967130164318;7189.2810718927685;7256.2743725627015;7833.216678332121;7858.882116768367;7929.960350198212;7957.681692732457;7969.920300796918;5974.940250597612;7047.7180912762915;7088.822779430556;7097.858042839011;7145.1783044948415;6858.759943401957;6947.965260173667;6951.6871740770775;6978.825529361807;6984.825379365557;6262.311145774052;6421.004744264646;6433.517486188461;6440.967795160994;6443.6455994920725;4837.105135549935;4960.578350840219;5035.219540971008;5103.055934652101;5105.617078719037;4932.556069953722;4934.259861020875;5138.614603904647;5166.638335316492;5232.424433312256 12:06:35 INFO - PROCESS | 2170 | |4;prototype.html;296.9138949704585;343.8315225539485;346.9410200265955;361.9384704600218;364.9270145970803;5238.659487133334;5298.814541491049;5366.799612159016;5375.623706340558;5412.539934105601;4266.573342665732;4624.421947256593;4757.8096876125;4938.234573641092;4966.701997880121;4009.5188577370755;4112.403701463286;4114.19773144237;4150.169966006795;4157.771322577272;3590.461430785377;3818.5990471000423;3893.98053009736;4080.6327430531246;4112.670986321102;3692.390755525335;3938.5076865391825;3966.226585815767;4096.583016020547;4112.876613701579;3069.6930306969125;3408.84660190292;3648.963510364889;3961.7821019843755;3987.983064318609;3092.9845350773103;3159.6208454985317;3240.7731458797894;3435.6600925639023;3451.2752322012407;4233.386159006926;4320.697551171419;5131.794728210867;5146.511081447294;5193.870153246161;3389.762716609838;4023.919521609581;4316.3741257517795;4569.337446070301;4576.199165146086;4844.709317440965;5595.7481913313595;5609.439056094398;5611.831645050655;5631.521320687746;3751.268502641986;3796.4305354196817;3800.391937290048;3841.3661745811905;3858.536975562922;4916.827911023132;5058.721770302632;5072.416672082758;5650.0674291993655;5773.1051686988585;3655.817209139532;3854.1328201154515;3873.748206366577;3874.6319099685484;3875.1668391296007;3620.601733809279;3917.0794863207125;3948.6841052715713;3954.62431069048;3955.7056906993876;4085.775282359439;4342.5006124296115;4504.324351347324;4537.844523851144;4597.885052873638;4469.128519938646;5065.696058236517;5590.273264475592;5603.887922241533;5614.494695477427;1084.7125511739396;1122.9444322336976;1179.3867189061639;1185.3480585678014;1210.661014915825;804.899387576553;816.4121832280748;825.5129473610599;826.1696994520469;827.3257295304428;4409.612435626572;4899.559039686445;5140.126178549655;5157.432682404932;5172.870678233075;4863.8540843774745;4890.926636100461;5627.8593035174445;5664.461876121844;5682.6306290091015;4525.336864855261;4817.9518204818205;4974.875628109254;5116.872078198075;5148.322872106483;2588.1236103824576;2590.7797837184053;2602;2826.2227887330737;2847.5870998705486;4553.681242313072;5089.854782673869;5390.9191362129595;5599.536204070196;5602.467765562265;4993.875153121201;5480.91778623321;5492.5605951523785;5569.997400467954;5577.721113944286;4953.826616068421;5145.228215767665;5349.358077030781;5412.810551630752;5526.778928842882;4138.322277570135;4247.218072162738;4690.882727931829;5205.219217117463;5407.405185429679;4338.592081394856;4805.8558243252755;4884.413870335582;5284.150547308412;5376.919346209888;4443.8000289986385;4971.726555039508;5050.419201791841;5472.2065300531995;5607.719614019365;3349.2631621044306;3541.6646216367076;3559;3650.233450975325;3652.520729104717;4627.375304334007;4883.755812209446;4922.532359425849;5348.839534813962;5388.1981369686755;4729.597984171384;4740.336352910665;5155.767990440514;5259.15853463444;5268.710220937885;4671.789769460314;4800.991791723777;4954.5813388761635;5258.631895767259;5263.894722105613;5059.721715305694;5095.293076819307;5136.563392111563;5144.562712169508;5247.790088396421;4376.562343765598;5289.117431000037;5439.48324909133;5450.945490545202;5459.617826752089;5355.625106242525;5391.083515802245;5406.864828379322;5445.646033007842;5456.372517160577 12:06:35 INFO - PROCESS | 2170 | |5;yui.html;718.5544962123488;722.8832147507784;785.6817988714569;812.2567850416868;827.9668813247471;14204.502842400518;14799.704005919875;15108.093514389131;15117.319720612571;15132.546023619281;14138.78791818121;14682.926585367084;14705.632359191026;14720.705585888276;14794.96435249533;855.2601999270632;879.3756432932626;884.1644645809712;884.9336299777542;886.7295474880159;684.6474065856063;706.4595584377955;707.7381368893491;840.5335039053323;870.4864130163203;917.8669092981513;926.3978414030867;927.6799504171084;929.2101713543468;929.9070092990714;920.7974245665977;923.2429407885537;925.5279807298259;925.6852670092134;930.762655522844;443.6960681932886;537.3900622793119;672.7645324136562;688.4148473797283;692.536000879407;15061.17163556004;15447.613809654737;15649.765253521206;15657;15718.764218536731;13314.400851961685;13329.86670133296;13424.865751342459;13477;13479.66300842477;12740.171888827197;12831.486740530368;12840.293783841886;12987.545435909698;13069.477220911152;4403.713758605681;4417.734935903856;4448;4469.240229161051;4526.54734526548;110076.9999999992;115569;115603.42198288954;117135.8286417142;117553.41223293914;10657.73355666099;11450.484728187252;11467;11469.254498457574;11736.119791015708;20871.37385878426;22520.32439026799;22522.436939076655;22532.324030279116;22575.661365079537;7655.043119610049;7980.840383192303;7988.161243069394;8020.759377218693;8021.3181879539725;4137.793110344471;4273.658107351404;4282.785860706952;4314.331278651751;4442.155990361821;3420.281740834403;3462.567179102612;3483.912902177415;3501.457274122515;3519.04985653872;631.8767840271103;638.4158494977137;641.1856941684129;645.5642441352162;646.2761706888315;572.644960124717;575.7035126909645;590.6101972697999;607.7933502609046;623.2085251730277;8006.679732810739;8034.879476807852;8185.3451723861945;8248.505089694638;9431.151196392357;552.204825051924;554.2406902543541;574.5662025170969;609.0863704443335;667.8029981155571;4128.525219599725;4290.978545107255;4370.584794444522;4394.1651086293505;4411.713238639478;86950.56524717336;100061;101906;103814.48092759488;106121;91276;91330.54334728284;92148.1777733332;92374;93044;68723.65638171877;69283.3071669297;78265.60867195627;80417;80798;10488.895111049098;10982.176336774613;11174.380398745096;11277.32336059839;11495.597654082067;44596.55403445924;48833.2675009868;49385;50834.62897879861;52802.47197528129;57370.426295736506;65770;66142.00786988295;67454.32545674677;67478;13031.413586388824;13100.410481528164;13210.669733256746;13224.627719931355;13741.381637826122;14376.496822611158;14631.85368146305;14676.486322978644;14932.477363292233;15005.474808381654;13533.526326578523;14055.367508461939;14123.64690882736;14185.716285674434;14315;13517.459301627825;13622.86377136216;13876.791848122084;14084.577462676136;14345.569632910612;11556.537738490366;13268.13757105785;13288.335583220607;13489.325533723471;13760.449582017007;10946.616868409568;11144.665660030212;11568.652940411801;11658.125640576822;11829.526818927146;8866.024737278765;10435.895641043493;10779.892201078203;10887.18346124028;10887.455627218766 12:06:35 INFO - PROCESS | 2170 | __end_tp_report 12:06:35 INFO - PROCESS | 2170 | __start_cc_report 12:06:35 INFO - PROCESS | 2170 | _x_x_mozilla_cycle_collect,2458 12:06:35 INFO - PROCESS | 2170 | __end_cc_report 12:06:35 INFO - PROCESS | 2170 | __startTimestamp1485374795543__endTimestamp 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | ------- Summary: start ------- 12:06:35 INFO - PROCESS | 2170 | Number of tests: 6 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#0] dojo.html Cycles:165 Average:5635.02 Median:5809.56 stddev:778.15 (13.4%) stddev-sans-first:758.23 12:06:35 INFO - PROCESS | 2170 | Values: 3276.6 3278.4 3284.5 3310.6 3332.2 5517.9 5569.3 5610.0 5637.4 5680.9 5583.6 5624.9 5626.7 5630.4 5633.9 5069.5 5070.2 5113.9 5156.9 5160.2 5161.7 5178.7 5225.8 5226.1 5237.5 5034.7 5126.2 5217.5 5221.7 5260.3 4744.8 4964.9 5211.8 5235.9 5237.3 535.1 5056.1 5156.6 5187.1 5243.6 4631.7 5571.9 5585.4 5673.4 5678.9 6216.9 6242.2 6255.8 6259.9 6276.3 6196.9 6197.2 6215.7 6218.6 6242.3 5635.7 5675.7 5683.1 5688.5 5728.2 6272.3 6277.3 6282.3 6288.4 6290.2 6109.7 6113.7 6115.3 6115.6 6120.9 6026.4 6133.2 6149.7 6161.0 6191.9 6161.8 6177.7 6194.8 6202.5 6214.0 6212.4 6220.3 6222.2 6233.2 6233.6 4012.5 4769.2 4887.4 4890.3 4951.0 4346.8 4377.0 4398.9 4413.8 4484.3 5554.8 5739.2 5756.3 5757.7 5763.0 6147.8 6155.1 6190.3 6210.8 6228.1 5554.0 5729.5 5769.2 5776.7 5792.1 4505.6 5322.4 5360.9 5361.5 5370.3 6219.6 6240.3 6244.1 6263.2 6264.3 6241.3 6244.8 6248.2 6251.2 6257.3 6301.7 6327.1 6329.1 6334.6 6406.0 5932.9 6064.8 6089.3 6118.9 6189.1 4918.5 6181.4 6193.8 6201.7 6204.8 5938.9 6051.4 6089.4 6096.3 6107.8 5819.4 5876.1 5891.0 5935.4 6078.3 4892.3 5789.5 5811.7 5813.0 5845.7 5924.5 5945.4 5957.4 5960.0 5973.6 5728.1 5766.1 5799.2 5806.6 5809.6 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#1] ext.html Cycles:180 Average:68207.66 Median:35635.55 stddev:150757.03 (423.1%) stddev-sans-first:151094.08 12:06:35 INFO - PROCESS | 2170 | Values: 438.8 444.4 495.8 499.5 505.3 39415.6 40824.6 41237.4 41246.0 42804.6 37291.3 38473.8 41397.2 41699.2 41870.0 8299.3 8520.3 9133.0 9360.5 9379.8 8329.2 8410.2 8419.0 10901.0 11247.4 11298.4 11340.5 11342.7 11349.9 11372.3 9536.9 11269.5 11325.0 11359.3 11370.1 8190.8 8429.3 10933.7 11170.3 11229.2 39847.8 40315.8 40354.0 40422.0 40477.2 3991.6 4029.9 4038.7 4039.6 4162.2 30387.7 30523.7 30523.8 30604.4 30608.4 3118.2 3260.9 3349.2 3355.7 3359.6 438356.8 438587.0 438833.0 439996.0 442001.0 59859.0 60571.0 60690.4 60729.4 60777.8 62860.7 63239.0 63272.7 63393.1 63413.0 15766.0 16011.5 16030.6 16041.4 16044.8 12469.4 12539.8 12549.8 12553.9 12574.2 13549.3 15380.3 15733.7 17236.2 19121.6 7020.4 8844.9 8864.2 8893.9 8938.6 870.8 874.4 896.8 914.0 923.2 28941.0 29874.3 30038.0 30188.4 30442.8 1020.6 1033.6 1039.8 1066.2 1067.2 11831.8 12430.6 13597.3 14019.7 14347.2 642496.0 645332.0 647046.0 647501.0 648172.0 51646.0 51985.7 52067.7 52144.7 52324.7 1228.7 1428.2 1430.5 1455.5 1456.4 26296.3 27291.0 27377.5 27743.3 27798.0 47174.3 47796.6 47896.3 47930.5 48014.0 580254.0 582317.0 585958.0 586217.0 586677.0 24421.3 25136.2 25222.0 25575.4 25590.7 34715.7 40449.0 41871.2 42315.0 43245.4 30582.7 34842.1 34876.5 34956.5 35891.0 30486.8 34281.8 34578.1 35669.3 35794.3 35039.5 35115.6 35160.0 35601.8 36348.8 30275.4 31866.8 32071.5 32160.8 32323.9 19304.7 23775.4 23797.3 23957.2 24528.8 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#2] jquery.html Cycles:180 Average:37800.26 Median:21700.51 stddev:111309.96 (512.9%) stddev-sans-first:111586.73 12:06:35 INFO - PROCESS | 2170 | Values: 371.2 391.9 394.8 400.9 420.0 14973.7 19419.9 19605.9 19669.6 20195.8 20286.6 20733.0 21121.4 21415.4 21926.6 5678.3 5805.7 5939.1 5969.6 5986.2 5433.7 5869.6 5935.8 5950.2 5958.7 5761.4 5879.8 5894.8 5902.9 5903.6 5966.3 6131.6 6135.6 6138.2 6148.7 5822.0 5860.4 5910.2 5939.9 6003.7 13801.8 13865.7 13886.7 19502.6 26122.3 2639.4 2653.7 2655.7 2704.0 2709.0 10113.6 10120.9 10216.9 10531.7 10673.4 1813.4 1882.3 1890.3 1896.6 1928.4 133438.0 138822.0 140898.3 142893.0 143255.3 11606.1 11664.3 11814.0 11903.4 12032.3 15448.8 15504.3 15509.2 15511.8 15522.4 8269.3 8277.7 8591.5 8710.6 8736.6 8316.7 8317.8 8320.7 8477.3 8482.5 4119.0 4675.7 4714.0 4735.1 4879.4 1955.6 2011.4 2012.4 2013.8 2019.8 1001.8 1005.8 1021.0 1031.6 1062.9 20987.0 21501.5 21899.6 21949.2 22070.6 867.9 973.5 1000.8 1030.5 1062.0 8827.2 10327.3 10331.8 11010.6 11457.5 498811.0 686531.0 697103.0 706584.0 709479.0 94349.0 142531.0 147036.3 147310.0 153652.0 973.5 986.8 990.6 1002.8 1005.0 18559.0 18633.5 18845.2 18968.9 19022.2 57244.7 57414.0 58904.4 59202.0 59211.7 84116.5 85374.3 86010.6 86131.6 86689.0 7216.0 7553.6 8204.5 8287.9 8716.8 12563.6 13278.2 13337.8 13808.0 13919.0 10910.9 11184.9 11433.4 11469.4 11522.7 9014.6 10708.8 11305.6 11545.2 11609.7 9365.0 10792.3 11360.4 11829.2 12033.0 6802.9 7312.0 7472.6 7734.5 7779.2 10383.7 11275.4 11520.5 11662.4 11719.8 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#3] mootools.html Cycles:180 Average:5372.78 Median:5200.75 stddev:2883.13 (55.4%) stddev-sans-first:2876.18 12:06:35 INFO - PROCESS | 2170 | Values: 1455.0 1460.7 1468.1 1485.5 1486.7 7872.3 8249.1 8288.4 8299.8 8302.5 7264.5 7448.4 7450.1 7918.6 8065.7 2271.1 2316.6 2324.4 2325.0 2326.2 2305.2 2338.1 2341.4 2347.0 2349.3 2276.7 2277.8 2308.4 2310.0 2311.0 2262.4 2282.0 2286.2 2287.5 2288.9 2259.4 2279.8 2318.2 2319.8 2320.0 8249.0 8297.2 8325.8 8327.6 8329.8 4984.0 5143.1 5149.2 5152.3 5155.9 3276.2 3360.9 3467.8 3536.8 3545.8 1060.1 1211.6 1218.6 1219.4 1270.4 10557.0 10686.5 10695.6 10709.9 10711.1 4368.5 4563.4 4649.1 4657.5 4665.1 9323.4 9330.2 9330.7 9337.4 9339.9 5157.2 5189.4 5196.9 5198.2 5203.3 4553.9 4643.6 4707.1 4741.1 4753.8 3754.8 3805.2 3828.4 3876.8 3890.4 1070.7 1254.8 1256.4 1261.6 1268.3 783.6 872.4 877.7 896.1 941.9 5474.8 5553.9 5669.0 5752.2 5827.6 987.0 998.8 1003.3 1015.7 1035.3 3322.2 3408.3 3763.4 3791.6 3821.2 8978.2 9197.9 9581.4 9905.3 9939.4 9229.3 9673.2 9809.9 9834.4 9836.3 7506.4 7691.4 7725.7 7727.5 7735.3 5610.6 5627.9 5634.5 5732.3 5901.4 9073.5 9178.3 9185.5 9205.1 9207.3 8904.0 9112.2 9298.4 9375.5 9375.7 6206.4 6245.2 6574.0 7189.3 7256.3 7833.2 7858.9 7930.0 7957.7 7969.9 5974.9 7047.7 7088.8 7097.9 7145.2 6858.8 6948.0 6951.7 6978.8 6984.8 6262.3 6421.0 6433.5 6441.0 6443.6 4837.1 4960.6 5035.2 5103.1 5105.6 4932.6 4934.3 5138.6 5166.6 5232.4 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#4] prototype.html Cycles:180 Average:4309.99 Median:4811.90 stddev:1308.24 (27.2%) stddev-sans-first:1276.76 12:06:35 INFO - PROCESS | 2170 | Values: 296.9 343.8 346.9 361.9 364.9 5238.7 5298.8 5366.8 5375.6 5412.5 4266.6 4624.4 4757.8 4938.2 4966.7 4009.5 4112.4 4114.2 4150.2 4157.8 3590.5 3818.6 3894.0 4080.6 4112.7 3692.4 3938.5 3966.2 4096.6 4112.9 3069.7 3408.8 3649.0 3961.8 3988.0 3093.0 3159.6 3240.8 3435.7 3451.3 4233.4 4320.7 5131.8 5146.5 5193.9 3389.8 4023.9 4316.4 4569.3 4576.2 4844.7 5595.7 5609.4 5611.8 5631.5 3751.3 3796.4 3800.4 3841.4 3858.5 4916.8 5058.7 5072.4 5650.1 5773.1 3655.8 3854.1 3873.7 3874.6 3875.2 3620.6 3917.1 3948.7 3954.6 3955.7 4085.8 4342.5 4504.3 4537.8 4597.9 4469.1 5065.7 5590.3 5603.9 5614.5 1084.7 1122.9 1179.4 1185.3 1210.7 804.9 816.4 825.5 826.2 827.3 4409.6 4899.6 5140.1 5157.4 5172.9 4863.9 4890.9 5627.9 5664.5 5682.6 4525.3 4818.0 4974.9 5116.9 5148.3 2588.1 2590.8 2602.0 2826.2 2847.6 4553.7 5089.9 5390.9 5599.5 5602.5 4993.9 5480.9 5492.6 5570.0 5577.7 4953.8 5145.2 5349.4 5412.8 5526.8 4138.3 4247.2 4690.9 5205.2 5407.4 4338.6 4805.9 4884.4 5284.2 5376.9 4443.8 4971.7 5050.4 5472.2 5607.7 3349.3 3541.7 3559.0 3650.2 3652.5 4627.4 4883.8 4922.5 5348.8 5388.2 4729.6 4740.3 5155.8 5259.2 5268.7 4671.8 4801.0 4954.6 5258.6 5263.9 5059.7 5095.3 5136.6 5144.6 5247.8 4376.6 5289.1 5439.5 5450.9 5459.6 5355.6 5391.1 5406.9 5445.6 5456.4 12:06:35 INFO - PROCESS | 2170 | 12:06:35 INFO - PROCESS | 2170 | [#5] yui.html Cycles:180 Average:20636.08 Median:4278.22 stddev:29882.29 (698.5%) stddev-sans-first:29928.69 12:06:35 INFO - PROCESS | 2170 | Values: 718.6 722.9 785.7 812.3 828.0 14204.5 14799.7 15108.1 15117.3 15132.5 14138.8 14682.9 14705.6 14720.7 14795.0 855.3 879.4 884.2 884.9 886.7 684.6 706.5 707.7 840.5 870.5 917.9 926.4 927.7 929.2 929.9 920.8 923.2 925.5 925.7 930.8 443.7 537.4 672.8 688.4 692.5 15061.2 15447.6 15649.8 15657.0 15718.8 13314.4 13329.9 13424.9 13477.0 13479.7 12740.2 12831.5 12840.3 12987.5 13069.5 4403.7 4417.7 4448.0 4469.2 4526.5 110077.0 115569.0 115603.4 117135.8 117553.4 10657.7 11450.5 11467.0 11469.3 11736.1 20871.4 22520.3 22522.4 22532.3 22575.7 7655.0 7980.8 7988.2 8020.8 8021.3 4137.8 4273.7 4282.8 4314.3 4442.2 3420.3 3462.6 3483.9 3501.5 3519.0 631.9 638.4 641.2 645.6 646.3 572.6 575.7 590.6 607.8 623.2 8006.7 8034.9 8185.3 8248.5 9431.2 552.2 554.2 574.6 609.1 667.8 4128.5 4291.0 4370.6 4394.2 4411.7 86950.6 100061.0 101906.0 103814.5 106121.0 91276.0 91330.5 92148.2 92374.0 93044.0 68723.7 69283.3 78265.6 80417.0 80798.0 10488.9 10982.2 11174.4 11277.3 11495.6 44596.6 48833.3 49385.0 50834.6 52802.5 57370.4 65770.0 66142.0 67454.3 67478.0 13031.4 13100.4 13210.7 13224.6 13741.4 14376.5 14631.9 14676.5 14932.5 15005.5 13533.5 14055.4 14123.6 14185.7 14315.0 13517.5 13622.9 13876.8 14084.6 14345.6 11556.5 13268.1 13288.3 13489.3 13760.4 10946.6 11144.7 11568.7 11658.1 11829.5 8866.0 10435.9 10779.9 10887.2 10887.5 12:06:35 INFO - PROCESS | 2170 | -------- Summary: end -------- 12:06:35 INFO - PROCESS | 2170 | 12:06:36 INFO - TEST-INFO | 2170: exit 0 12:06:36 INFO - TEST-OK | dromaeo_css | took 1118241ms 12:06:36 INFO - TEST-START | kraken 12:06:36 INFO - operating with platform_type : mac_ 12:06:36 INFO - Initialising browser for kraken test... 12:06:36 INFO - TEST-INFO | started process 2173 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp5NzEP7/profile http://localhost:54563/getInfo.html) 12:06:38 INFO - PROCESS | 2173 | __metrics Screen width/height:1600/1200 12:06:38 INFO - PROCESS | 2173 | colorDepth:24 12:06:38 INFO - PROCESS | 2173 | Browser inner width/height: 1024/689 12:06:38 INFO - PROCESS | 2173 | __metrics 12:06:38 INFO - PROCESS | 2173 | 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" 12:06:38 INFO - PROCESS | 2173 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:39 INFO - TEST-INFO | 2173: exit 0 12:06:39 INFO - Browser initialized. 12:06:39 INFO - Running cycle 1/1 for kraken test... 12:06:39 INFO - TEST-INFO | started process 2174 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp5NzEP7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:51 INFO - PROCESS | 2174 | RSS: Main: 228560896 12:06:51 INFO - PROCESS | 2174 | 12:06:53 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54563/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:54 INFO - PROCESS | 2174 | RSS: Main: 288800768 12:06:54 INFO - PROCESS | 2174 | 12:06:57 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54563/tests/kraken/driver.html?testName=audio-dft) 12:06:57 INFO - PROCESS | 2174 | RSS: Main: 291491840 12:06:57 INFO - PROCESS | 2174 | 12:07:01 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54563/tests/kraken/driver.html?testName=audio-fft) 12:07:02 INFO - PROCESS | 2174 | RSS: Main: 382074880 12:07:02 INFO - PROCESS | 2174 | 12:07:04 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54563/tests/kraken/driver.html?testName=audio-oscillator) 12:07:04 INFO - PROCESS | 2174 | RSS: Main: 283152384 12:07:04 INFO - PROCESS | 2174 | 12:07:06 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:07 INFO - PROCESS | 2174 | RSS: Main: 286605312 12:07:07 INFO - PROCESS | 2174 | 12:07:10 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54563/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:10 INFO - PROCESS | 2174 | RSS: Main: 328814592 12:07:10 INFO - PROCESS | 2174 | 12:07:13 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54563/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:14 INFO - PROCESS | 2174 | RSS: Main: 330407936 12:07:14 INFO - PROCESS | 2174 | 12:07:17 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54563/tests/kraken/driver.html?testName=json-parse-financial) 12:07:17 INFO - PROCESS | 2174 | RSS: Main: 328564736 12:07:17 INFO - PROCESS | 2174 | 12:07:19 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:19 INFO - PROCESS | 2174 | RSS: Main: 305397760 12:07:19 INFO - PROCESS | 2174 | 12:07:22 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:22 INFO - PROCESS | 2174 | RSS: Main: 309452800 12:07:22 INFO - PROCESS | 2174 | 12:07:24 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:25 INFO - PROCESS | 2174 | RSS: Main: 311242752 12:07:25 INFO - PROCESS | 2174 | 12:07:28 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:29 INFO - PROCESS | 2174 | RSS: Main: 327974912 12:07:29 INFO - PROCESS | 2174 | 12:07:32 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:32 INFO - PROCESS | 2174 | RSS: Main: 322379776 12:07:32 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54563/tests/kraken/driver.html?testName=ai-astar) 12:07:34 INFO - PROCESS | 2174 | RSS: Main: 366731264 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | __start_tp_report 12:07:34 INFO - PROCESS | 2174 | _x_x_mozilla_page_load 12:07:34 INFO - PROCESS | 2174 | _x_x_mozilla_page_load_details 12:07:34 INFO - PROCESS | 2174 | |i|pagename|runs| 12:07:34 INFO - PROCESS | 2174 | |0;ai-astar;111;113;113;113;111;113;112;112;112;114 12:07:34 INFO - PROCESS | 2174 | |1;audio-beat-detection;141;106;108;147;110;111;108;103;125;111 12:07:34 INFO - PROCESS | 2174 | |2;audio-dft;185;181;178;197;262;184;183;180;181;184 12:07:34 INFO - PROCESS | 2174 | |3;audio-fft;79;59;76;113;84;63;59;59;74;60 12:07:34 INFO - PROCESS | 2174 | |4;audio-oscillator;90;69;86;69;68;68;83;66;69;84 12:07:34 INFO - PROCESS | 2174 | |5;imaging-gaussian-blur;87;84;87;85;87;83;87;85;87;85 12:07:34 INFO - PROCESS | 2174 | |6;imaging-darkroom;96;95;96;96;97;96;96;96;97;96 12:07:34 INFO - PROCESS | 2174 | |7;imaging-desaturate;88;85;84;87;87;87;99;126;87;86 12:07:34 INFO - PROCESS | 2174 | |8;json-parse-financial;58;56;55;55;56;56;54;55;56;56 12:07:34 INFO - PROCESS | 2174 | |9;json-stringify-tinderbox;67;70;72;80;79;101;109;111;61;75 12:07:34 INFO - PROCESS | 2174 | |10;stanford-crypto-aes;87;87;87;86;88;90;90;88;87;87 12:07:34 INFO - PROCESS | 2174 | |11;stanford-crypto-ccm;141;141;140;140;150;159;135;144;201;154 12:07:34 INFO - PROCESS | 2174 | |12;stanford-crypto-pbkdf2;173;172;174;173;175;173;168;178;174;178 12:07:34 INFO - PROCESS | 2174 | |13;stanford-crypto-sha256-iterative;70;74;67;72;81;88;87;89;65;67 12:07:34 INFO - PROCESS | 2174 | __end_tp_report 12:07:34 INFO - PROCESS | 2174 | __start_cc_report 12:07:34 INFO - PROCESS | 2174 | _x_x_mozilla_cycle_collect,2007 12:07:34 INFO - PROCESS | 2174 | __end_cc_report 12:07:34 INFO - PROCESS | 2174 | __startTimestamp1485374854857__endTimestamp 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | ------- Summary: start ------- 12:07:34 INFO - PROCESS | 2174 | Number of tests: 14 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 12:07:34 INFO - PROCESS | 2174 | Values: 111.0 113.0 113.0 113.0 111.0 113.0 112.0 112.0 112.0 114.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:111.00 stddev:15.42 (13.9%) stddev-sans-first:13.69 12:07:34 INFO - PROCESS | 2174 | Values: 141.0 106.0 108.0 147.0 110.0 111.0 108.0 103.0 125.0 111.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#2] audio-dft Cycles:10 Average:191.50 Median:184.00 stddev:25.30 (13.8%) stddev-sans-first:26.73 12:07:34 INFO - PROCESS | 2174 | Values: 185.0 181.0 178.0 197.0 262.0 184.0 183.0 180.0 181.0 184.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#3] audio-fft Cycles:10 Average:72.60 Median:68.50 stddev:17.07 (24.9%) stddev-sans-first:17.95 12:07:34 INFO - PROCESS | 2174 | Values: 79.0 59.0 76.0 113.0 84.0 63.0 59.0 59.0 74.0 60.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:9.30 (12.2%) stddev-sans-first:8.17 12:07:34 INFO - PROCESS | 2174 | Values: 90.0 69.0 86.0 69.0 68.0 68.0 83.0 66.0 69.0 84.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.51 12:07:34 INFO - PROCESS | 2174 | Values: 87.0 84.0 87.0 85.0 87.0 83.0 87.0 85.0 87.0 85.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:07:34 INFO - PROCESS | 2174 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:87.00 stddev:12.77 (14.7%) stddev-sans-first:13.48 12:07:34 INFO - PROCESS | 2174 | Values: 88.0 85.0 84.0 87.0 87.0 87.0 99.0 126.0 87.0 86.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.06 (1.9%) stddev-sans-first:0.73 12:07:34 INFO - PROCESS | 2174 | Values: 58.0 56.0 55.0 55.0 56.0 56.0 54.0 55.0 56.0 56.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:71.00 stddev:17.95 (25.3%) stddev-sans-first:18.14 12:07:34 INFO - PROCESS | 2174 | Values: 67.0 70.0 72.0 80.0 79.0 101.0 109.0 111.0 61.0 75.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:1.34 (1.5%) stddev-sans-first:1.39 12:07:34 INFO - PROCESS | 2174 | Values: 87.0 87.0 87.0 86.0 88.0 90.0 90.0 88.0 87.0 87.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:147.00 stddev:19.20 (13.1%) stddev-sans-first:20.06 12:07:34 INFO - PROCESS | 2174 | Values: 141.0 141.0 140.0 140.0 150.0 159.0 135.0 144.0 201.0 154.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:2.90 (1.7%) stddev-sans-first:3.06 12:07:34 INFO - PROCESS | 2174 | Values: 173.0 172.0 174.0 173.0 175.0 173.0 168.0 178.0 174.0 178.0 12:07:34 INFO - PROCESS | 2174 | 12:07:34 INFO - PROCESS | 2174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:77.50 stddev:9.42 (12.2%) stddev-sans-first:9.73 12:07:34 INFO - PROCESS | 2174 | Values: 70.0 74.0 67.0 72.0 81.0 88.0 87.0 89.0 65.0 67.0 12:07:34 INFO - PROCESS | 2174 | -------- Summary: end -------- 12:07:34 INFO - PROCESS | 2174 | 12:07:35 INFO - TEST-INFO | 2174: exit 0 12:07:35 INFO - TEST-OK | kraken | took 59601ms 12:07:35 INFO - SUITE-END | took 1177s 12:07:36 INFO - Completed test suite (00:19:38) 12:07:36 INFO - javascript benchmark 12:07:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.6231883333426, 3278.4426647469927, 3284.5073239014146, 3310.5696259486263, 3332.150301673073, 5517.917231241525, 5569.275994120769, 5610.046292130338, 5637.436256374361, 5680.914786278204, 5583.609147359676, 5624.859378515539, 5626.718664066791, 5630.40880707526, 5633.887322253552, 5069.543741063304, 5070.163423035195, 5113.897722045557, 5156.92264616031, 5160.225966105077, 5161.741912904358, 5178.741062946857, 5225.79096836128, 5226.137687281594, 5237.476252374751, 5034.723090230036, 5126.154184559543, 5217.478252174771, 5221.738913054332, 5260.289860868772, 4744.813796550862, 4964.90070198594, 5211.817586384458, 5235.869103272411, 5237.3453318335205, 535.1366009219796, 5056.140456122468, 5156.587473002151, 5187.0922588546855, 5243.554297884684, 4631.745254011028, 5571.944280557183, 5585.385607583163, 5673.432656734335, 5678.858028549278, 6216.937830621681, 6242.188515492957, 6255.812325630239, 6259.937400625981, 6276.3409841966395, 6196.915539780565, 6197.163382943335, 6215.720292586844, 6218.564700470969, 6242.282137554194, 5635.746391412396, 5675.659460432387, 5683.090705487102, 5688.459596338383, 5728.169415434739, 6272.341404152498, 6277.278113016971, 6282.340354262828, 6288.434040936338, 6290.182276304051, 6109.6639684817765, 6113.663748493786, 6115.327313995457, 6115.571909966348, 6120.908186377208, 6026.367231440723, 6133.172021777093, 6149.692515374213, 6161.045038019114, 6191.938080619136, 6161.815145545641, 6177.6911154443, 6194.845128871724, 6202.503799696104, 6213.97469417541, 6212.4408803207925, 6220.34686357935, 6222.222222222223, 6233.189685340967, 6233.563650544418, 4012.478377810866, 4769.189237829577, 4887.3890763654545, 4890.290907818347, 4951.0, 4346.8043938022865, 4377.0, 4398.934015989763, 4413.8234470621455, 4484.304932735431, 5554.805581804618, 5739.225204597409, 5756.3380211276235, 5757.683327417032, 5762.9914764915975, 6147.831911936718, 6155.138280640714, 6190.3190649028575, 6210.813675589739, 6228.096925945712, 5554.028045092093, 5729.4843464088435, 5769.1634712967225, 5776.740046697909, 5792.102224155263, 4505.5719706627815, 5322.414534401213, 5360.946390536123, 5361.517463428232, 5370.2750128732905, 6219.626822390671, 6240.31356550779, 6244.063390491281, 6263.217097862676, 6264.31092579825, 6241.282252540835, 6244.843878903063, 6248.187735594343, 6251.218597675291, 6257.311695713377, 6301.684915754102, 6327.050942358683, 6329.082283069021, 6334.588251763621, 6406.0, 5932.940670593239, 6064.848378790565, 6089.2997305310455, 6118.877622447615, 6189.102580125947, 4918.532739389752, 6181.350958149509, 6193.761247750558, 6201.720922558406, 6204.7828326008375, 5938.881222375615, 6051.394860513913, 6089.391060894052, 6096.29892562361, 6107.755689772359, 5819.418058194146, 5876.08920617305, 5891.0, 5935.376785437639, 6078.300995385587, 4892.290617860462, 5789.53683705311, 5811.709414529341, 5813.0, 5845.678487683218, 5924.4667979882015, 5945.375735547878, 5957.404259574181, 5959.970200148971, 5973.581849270509, 5728.140778883034, 5766.077427611562, 5799.159121927212, 5806.622569532967, 5809.564282678901], "value": 5585.933478494325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.75429759334753, 444.42003185842464, 495.8165478772854, 499.54541367355716, 505.2572718104386, 39415.60584394155, 40824.59175408245, 41237.38143927843, 41246.0, 42804.57195428045, 37291.25417491649, 38473.80763096188, 41397.17205655885, 41699.16601667972, 41870.0, 8299.253067223948, 8520.318374530054, 9133.0, 9360.485173315465, 9379.812403751921, 8329.20872517113, 8410.243078122967, 8418.957905210465, 10901.0, 11247.437628118561, 11298.435078246055, 11340.546378144863, 11342.659720208407, 11349.943250283779, 11372.31766094037, 9536.904630953672, 11269.549218031269, 11325.0, 11359.318440893572, 11370.147238957028, 8190.836183276301, 8429.283510901581, 10933.726656833564, 11170.27393219438, 11229.157813164045, 39847.8007609963, 40315.798421008, 40354.0, 40422.0, 40477.190456190714, 3991.600839916014, 4029.8992525186814, 4038.6567141792984, 4039.6162364575316, 4162.229987452331, 30387.696123038706, 30523.694763052306, 30523.847380763174, 30604.38791224163, 30608.387832243454, 3118.158097313735, 3260.934781304384, 3349.1627093226693, 3355.681210285019, 3359.5800524934384, 438356.80821596005, 438587.0, 438833.0, 439996.0, 442001.0, 59859.0, 60571.0, 60690.393096069354, 60729.39270607237, 60777.78444431087, 62860.68569657122, 63239.0, 63272.683636581525, 63393.09820705386, 63413.0, 15766.0, 16011.519654410153, 16030.599235019217, 16041.358345666044, 16044.759328609847, 12469.438875250635, 12539.811902821464, 12549.811752823714, 12553.937230313973, 12574.245545267313, 13549.322533873465, 15380.30788614515, 15733.68532629341, 17236.18886658908, 19121.631186632563, 7020.438364930793, 8844.911550884408, 8864.20222180007, 8893.866592001124, 8938.597763100675, 870.8388948044632, 874.3791907745572, 896.8116695494019, 913.9680111196076, 923.1737594852569, 28941.0, 29874.253143671584, 30038.0, 30188.396232075236, 30442.847785761373, 1020.5662593397776, 1033.617561502249, 1039.7574897996972, 1066.2376400873413, 1067.236925598201, 11831.763364732657, 12430.564930227398, 13597.32013399326, 14019.719605608036, 14347.210903400204, 642496.0, 645332.0, 647046.0010899126, 647501.0499789978, 648172.0, 51646.0, 51985.7400712994, 52067.73966130145, 52144.739276304135, 52324.738376307876, 1228.6866848953816, 1428.2002078835885, 1430.4850253908585, 1455.4905782976086, 1456.4174330267977, 26296.34259143537, 27291.0, 27377.452450951267, 27743.30641733973, 27798.0, 47174.29238561356, 47796.566103016965, 47896.281555776, 47930.520694792605, 48014.0, 580254.0, 582317.0, 585958.0, 586217.0, 586677.0, 24421.267361979168, 25136.24591262265, 25221.991120355713, 25575.360615984006, 25590.744092558834, 34715.65284347225, 40449.0, 41871.16257674769, 42315.0, 43245.3513197296, 30582.694173057986, 34842.12894677552, 34876.47685284672, 34956.47565286574, 35891.0, 30486.7805287786, 34281.82859085689, 34578.135546611535, 35669.286614267054, 35794.284114317044, 35039.47440788339, 35115.64884351226, 35160.0, 35601.82199088988, 36348.818255908554, 30275.394492110474, 31866.840665796524, 32071.518927215642, 32160.83919580387, 32323.86866459757, 19304.710429343853, 23775.405614859075, 23797.286081417584, 23957.16149934744, 24528.754712452646], "value": 19469.360772496486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1630273732732, 391.9274934137184, 394.7651147567198, 400.9498812648418, 420.0255407454706, 14973.700525989474, 19419.90290048548, 19605.901970490144, 19669.606607867834, 20195.798042019574, 20286.638372749894, 20733.0, 21121.366359009255, 21415.357539273846, 21926.561468770615, 5678.290213723285, 5805.709714514268, 5939.07944268639, 5969.611975221618, 5986.191864098357, 5433.673979561219, 5869.647821130746, 5935.792247271346, 5950.166976623276, 5958.672273024982, 5761.395053519383, 5879.7648094076185, 5894.793682221123, 5902.940970590304, 5903.645781253117, 5966.254218222723, 6131.632102073845, 6135.631862088267, 6138.202033735586, 6148.6618235997, 5822.0, 5860.384659610765, 5910.231669882931, 5939.940600593982, 6003.6697981611, 13801.792973105412, 13865.653358666013, 13886.722265554734, 19502.609947800964, 26122.34694132643, 2639.3797457597448, 2653.668291463567, 2655.74770396812, 2703.9729602704115, 2708.9864550677316, 10113.595456181743, 10120.898791012143, 10216.94891525545, 10531.684049478528, 10673.412962287071, 1813.4287699374786, 1882.3411805867975, 1890.3383815664545, 1896.6017136401372, 1928.4118343905104, 133438.0, 138822.0, 140898.29550852283, 142892.99999999895, 143255.2837235807, 11606.129540284344, 11664.300141991507, 11814.0, 11903.404829758478, 12032.27806331623, 15448.845511544965, 15504.30230639624, 15509.224538773016, 15511.767323490156, 15522.379104835905, 8269.336191186354, 8277.668893244323, 8591.484510929364, 8710.608022638997, 8736.563171841382, 8316.708915187939, 8317.8336433271, 8320.70877519284, 8477.279431248413, 8482.491050536988, 4118.979405102956, 4675.696079754873, 4713.95286047142, 4735.12400205963, 4879.365412586752, 1955.559999000242, 2011.3965810256864, 2012.3962811156593, 2013.808688174621, 2019.7677267114177, 1001.7545701303081, 1005.7636455432968, 1020.9795804083876, 1031.6286136990677, 1062.8724553053682, 20987.0, 21501.462463438227, 21899.562008759734, 21949.231776887733, 22070.57223705391, 867.9392442529089, 973.4694591447678, 1000.8248556502729, 1030.4744580263969, 1061.9628313009007, 8827.249683776823, 10327.277090603737, 10331.845022324671, 11010.559577616805, 11457.54169833214, 498811.0, 686531.0, 697103.0, 706584.0, 709479.0, 94349.0, 142531.0, 147036.26481867736, 147310.0, 153652.0, 973.532704301939, 986.8273052215977, 990.5988074829705, 1002.7844013537125, 1004.9648262310784, 18558.979256141043, 18633.53416164607, 18845.24619015224, 18968.905155474135, 19022.244438890277, 57244.71377643085, 57414.0, 58904.41095588989, 59202.0, 59211.70394148002, 84116.53242539216, 85374.31631153225, 86010.56994714987, 86131.56934215539, 86689.0, 7215.963920180366, 7553.622318884144, 8204.548749818818, 8287.875681864898, 8716.78208044804, 12563.560275390317, 13278.203307801563, 13337.799933000819, 13807.964402669639, 13919.025668203129, 10910.890891091305, 11184.888151118384, 11433.371164586028, 11469.369184694922, 11522.711932201762, 9014.639414423349, 10708.839367409651, 11305.604303849326, 11545.249558778652, 11609.709757255798, 9365.0, 10792.298500597437, 11360.375179365214, 11829.231099978473, 12033.0, 6802.911534154511, 7311.963440182765, 7472.551646901204, 7734.458587898793, 7779.18318576564, 10383.740406489898, 11275.379854108103, 11520.53917843277, 11662.358570278717, 11719.824202636797], "value": 9755.405584539085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.9927250363746, 1460.664047269128, 1468.1191285228865, 1485.4726572066916, 1486.7100915321514, 7872.252136047074, 8249.092599814023, 8288.378371622122, 8299.792505187366, 8302.501849889011, 7264.455165862555, 7448.404127669787, 7450.10598728152, 7918.564478953655, 8065.677372905091, 2271.114265436477, 2316.5521549031855, 2324.360800779782, 2324.9883750581225, 2326.150954901457, 2305.170138750049, 2338.1348900906605, 2341.426350544119, 2346.9647955280684, 2349.34218418843, 2276.6926464927187, 2277.7836105569945, 2308.3998160478313, 2310.0, 2310.9537809243807, 2262.3552287598036, 2281.9543609127722, 2286.2455389721354, 2287.5424915017065, 2288.9084436622516, 2259.435141214696, 2279.8176145908287, 2318.2349824558023, 2319.791218790317, 2319.9792091479694, 8249.0, 8297.211764882326, 8325.8334833303, 8327.583620818996, 8329.750107496724, 4984.0, 5143.074246635604, 5149.150390185652, 5152.330197074356, 5155.922661160085, 3276.2300859298048, 3360.8823691170937, 3467.791932484059, 3536.840842162083, 3545.769524980868, 1060.1412855587, 1211.5517258614282, 1218.6161359171833, 1219.378117160246, 1270.380265161926, 10556.997085276964, 10686.465676716132, 10695.625653102104, 10709.892901070967, 10711.089557387631, 4368.453943257093, 4563.361129441881, 4649.093426781813, 4657.46439159501, 4665.113628410591, 9323.440593564408, 9330.160285574331, 9330.673426430043, 9337.393069450463, 9339.90660093404, 5157.226416037549, 5189.377274727057, 5196.948030519722, 5198.2202669599865, 5203.271541984125, 4553.907062305089, 4643.582077613031, 4707.058588282357, 4741.051789642016, 4753.83361582343, 3754.7934863582764, 3805.1818858944907, 3828.444875493038, 3876.7673939563715, 3890.3969884667354, 1070.743021674808, 1254.7678679444332, 1256.359256779031, 1261.5710658376197, 1268.2770820632336, 783.61211200455, 872.3631748823394, 877.6621000914694, 896.1486587741672, 941.9481928493861, 5474.753636086386, 5553.888922221533, 5669.036263835158, 5752.201351991868, 5827.59206855516, 987.0, 998.7652901568125, 1003.2826529031777, 1015.6902144845893, 1035.2804800663616, 3322.235885746292, 3408.3353746019784, 3763.360228761117, 3791.5829258781514, 3821.197548514843, 8978.191962723386, 9197.862032069525, 9581.425114493153, 9905.306628536078, 9939.353941993748, 9229.307801914883, 9673.177779888647, 9809.852852207223, 9834.409935403899, 9836.311458197857, 7506.43701722373, 7691.384809190133, 7725.652345644347, 7727.49771264866, 7735.265149810759, 5610.635308704921, 5627.90255900112, 5634.492895639412, 5732.3121225453215, 5901.439363260483, 9073.455592664197, 9178.265738741018, 9185.49479778592, 9205.079492050741, 9207.309451791009, 8904.0, 9112.225460835904, 9298.395604285699, 9375.531223438937, 9375.671851485165, 6206.441420272197, 6245.219347581552, 6573.967130164318, 7189.2810718927685, 7256.2743725627015, 7833.216678332121, 7858.882116768367, 7929.960350198212, 7957.681692732457, 7969.920300796918, 5974.940250597612, 7047.7180912762915, 7088.822779430556, 7097.858042839011, 7145.1783044948415, 6858.759943401957, 6947.965260173667, 6951.6871740770775, 6978.825529361807, 6984.825379365557, 6262.311145774052, 6421.004744264646, 6433.517486188461, 6440.967795160994, 6443.6455994920725, 4837.105135549935, 4960.578350840219, 5035.219540971008, 5103.055934652101, 5105.617078719037, 4932.556069953722, 4934.259861020875, 5138.614603904647, 5166.638335316492, 5232.424433312256], "value": 4392.995886090298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9138949704585, 343.8315225539485, 346.9410200265955, 361.9384704600218, 364.9270145970803, 5238.659487133334, 5298.814541491049, 5366.799612159016, 5375.623706340558, 5412.539934105601, 4266.573342665732, 4624.421947256593, 4757.8096876125, 4938.234573641092, 4966.701997880121, 4009.5188577370755, 4112.403701463286, 4114.19773144237, 4150.169966006795, 4157.771322577272, 3590.461430785377, 3818.5990471000423, 3893.98053009736, 4080.6327430531246, 4112.670986321102, 3692.390755525335, 3938.5076865391825, 3966.226585815767, 4096.583016020547, 4112.876613701579, 3069.6930306969125, 3408.84660190292, 3648.963510364889, 3961.7821019843755, 3987.983064318609, 3092.9845350773103, 3159.6208454985317, 3240.7731458797894, 3435.6600925639023, 3451.2752322012407, 4233.386159006926, 4320.697551171419, 5131.794728210867, 5146.511081447294, 5193.870153246161, 3389.762716609838, 4023.919521609581, 4316.3741257517795, 4569.337446070301, 4576.199165146086, 4844.709317440965, 5595.7481913313595, 5609.439056094398, 5611.831645050655, 5631.521320687746, 3751.268502641986, 3796.4305354196817, 3800.391937290048, 3841.3661745811905, 3858.536975562922, 4916.827911023132, 5058.721770302632, 5072.416672082758, 5650.0674291993655, 5773.1051686988585, 3655.817209139532, 3854.1328201154515, 3873.748206366577, 3874.6319099685484, 3875.1668391296007, 3620.601733809279, 3917.0794863207125, 3948.6841052715713, 3954.62431069048, 3955.7056906993876, 4085.775282359439, 4342.5006124296115, 4504.324351347324, 4537.844523851144, 4597.885052873638, 4469.128519938646, 5065.696058236517, 5590.273264475592, 5603.887922241533, 5614.494695477427, 1084.7125511739396, 1122.9444322336976, 1179.3867189061639, 1185.3480585678014, 1210.661014915825, 804.899387576553, 816.4121832280748, 825.5129473610599, 826.1696994520469, 827.3257295304428, 4409.612435626572, 4899.559039686445, 5140.126178549655, 5157.432682404932, 5172.870678233075, 4863.8540843774745, 4890.926636100461, 5627.8593035174445, 5664.461876121844, 5682.6306290091015, 4525.336864855261, 4817.9518204818205, 4974.875628109254, 5116.872078198075, 5148.322872106483, 2588.1236103824576, 2590.7797837184053, 2602.0, 2826.2227887330737, 2847.5870998705486, 4553.681242313072, 5089.854782673869, 5390.9191362129595, 5599.536204070196, 5602.467765562265, 4993.875153121201, 5480.91778623321, 5492.5605951523785, 5569.997400467954, 5577.721113944286, 4953.826616068421, 5145.228215767665, 5349.358077030781, 5412.810551630752, 5526.778928842882, 4138.322277570135, 4247.218072162738, 4690.882727931829, 5205.219217117463, 5407.405185429679, 4338.592081394856, 4805.8558243252755, 4884.413870335582, 5284.150547308412, 5376.919346209888, 4443.8000289986385, 4971.726555039508, 5050.419201791841, 5472.2065300531995, 5607.719614019365, 3349.2631621044306, 3541.6646216367076, 3559.0, 3650.233450975325, 3652.520729104717, 4627.375304334007, 4883.755812209446, 4922.532359425849, 5348.839534813962, 5388.1981369686755, 4729.597984171384, 4740.336352910665, 5155.767990440514, 5259.15853463444, 5268.710220937885, 4671.789769460314, 4800.991791723777, 4954.5813388761635, 5258.631895767259, 5263.894722105613, 5059.721715305694, 5095.293076819307, 5136.563392111563, 5144.562712169508, 5247.790088396421, 4376.562343765598, 5289.117431000037, 5439.48324909133, 5450.945490545202, 5459.617826752089, 5355.625106242525, 5391.083515802245, 5406.864828379322, 5445.646033007842, 5456.372517160577], "value": 3901.258803864272, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.5544962123488, 722.8832147507784, 785.6817988714569, 812.2567850416868, 827.9668813247471, 14204.502842400518, 14799.704005919875, 15108.093514389131, 15117.319720612571, 15132.546023619281, 14138.78791818121, 14682.926585367084, 14705.632359191026, 14720.705585888276, 14794.96435249533, 855.2601999270632, 879.3756432932626, 884.1644645809712, 884.9336299777542, 886.7295474880159, 684.6474065856063, 706.4595584377955, 707.7381368893491, 840.5335039053323, 870.4864130163203, 917.8669092981513, 926.3978414030867, 927.6799504171084, 929.2101713543468, 929.9070092990714, 920.7974245665977, 923.2429407885537, 925.5279807298259, 925.6852670092134, 930.762655522844, 443.6960681932886, 537.3900622793119, 672.7645324136562, 688.4148473797283, 692.536000879407, 15061.17163556004, 15447.613809654737, 15649.765253521206, 15657.0, 15718.764218536731, 13314.400851961685, 13329.86670133296, 13424.865751342459, 13477.0, 13479.66300842477, 12740.171888827197, 12831.486740530368, 12840.293783841886, 12987.545435909698, 13069.477220911152, 4403.713758605681, 4417.734935903856, 4448.0, 4469.240229161051, 4526.54734526548, 110076.9999999992, 115569.0, 115603.42198288954, 117135.8286417142, 117553.41223293914, 10657.73355666099, 11450.484728187252, 11467.0, 11469.254498457574, 11736.119791015708, 20871.37385878426, 22520.32439026799, 22522.436939076655, 22532.324030279116, 22575.661365079537, 7655.043119610049, 7980.840383192303, 7988.161243069394, 8020.759377218693, 8021.3181879539725, 4137.793110344471, 4273.658107351404, 4282.785860706952, 4314.331278651751, 4442.155990361821, 3420.281740834403, 3462.567179102612, 3483.912902177415, 3501.457274122515, 3519.04985653872, 631.8767840271103, 638.4158494977137, 641.1856941684129, 645.5642441352162, 646.2761706888315, 572.644960124717, 575.7035126909645, 590.6101972697999, 607.7933502609046, 623.2085251730277, 8006.679732810739, 8034.879476807852, 8185.3451723861945, 8248.505089694638, 9431.151196392357, 552.204825051924, 554.2406902543541, 574.5662025170969, 609.0863704443335, 667.8029981155571, 4128.525219599725, 4290.978545107255, 4370.584794444522, 4394.1651086293505, 4411.713238639478, 86950.56524717336, 100061.0, 101906.0, 103814.48092759488, 106121.0, 91276.0, 91330.54334728284, 92148.1777733332, 92374.0, 93044.0, 68723.65638171877, 69283.3071669297, 78265.60867195627, 80417.0, 80798.0, 10488.895111049098, 10982.176336774613, 11174.380398745096, 11277.32336059839, 11495.597654082067, 44596.55403445924, 48833.2675009868, 49385.0, 50834.62897879861, 52802.47197528129, 57370.426295736506, 65770.0, 66142.00786988295, 67454.32545674677, 67478.0, 13031.413586388824, 13100.410481528164, 13210.669733256746, 13224.627719931355, 13741.381637826122, 14376.496822611158, 14631.85368146305, 14676.486322978644, 14932.477363292233, 15005.474808381654, 13533.526326578523, 14055.367508461939, 14123.64690882736, 14185.716285674434, 14315.0, 13517.459301627825, 13622.86377136216, 13876.791848122084, 14084.577462676136, 14345.569632910612, 11556.537738490366, 13268.13757105785, 13288.335583220607, 13489.325533723471, 13760.449582017007, 10946.616868409568, 11144.665660030212, 11568.652940411801, 11658.125640576822, 11829.526818927146, 8866.024737278765, 10435.895641043493, 10779.892201078203, 10887.18346124028, 10887.455627218766], "value": 7478.262801171032, "unit": "score"}], "name": "dromaeo_css", "value": 7171.083034857714, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 111.0, 113.0, 112.0, 112.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 108.0, 147.0, 110.0, 111.0, 108.0, 103.0, 125.0, 111.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 178.0, 197.0, 262.0, 184.0, 183.0, 180.0, 181.0, 184.0], "value": 191.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 76.0, 113.0, 84.0, 63.0, 59.0, 59.0, 74.0, 60.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 86.0, 69.0, 68.0, 68.0, 83.0, 66.0, 69.0, 84.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 83.0, 87.0, 85.0, 87.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 84.0, 87.0, 87.0, 87.0, 99.0, 126.0, 87.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 55.0, 56.0, 56.0, 54.0, 55.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 72.0, 80.0, 79.0, 101.0, 109.0, 111.0, 61.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 88.0, 90.0, 90.0, 88.0, 87.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 140.0, 140.0, 150.0, 159.0, 135.0, 144.0, 201.0, 154.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 174.0, 173.0, 175.0, 173.0, 168.0, 178.0, 174.0, 178.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 67.0, 72.0, 81.0, 88.0, 87.0, 89.0, 65.0, 67.0], "value": 76.0, "unit": "score"}], "name": "kraken", "value": 1468.3000000000002, "alertThreshold": 2.0}]} 12:07:36 INFO - Return code: 0 12:07:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:07:36 ERROR - # TBPL SUCCESS # 12:07:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:07:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:07:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:07:36 INFO - 2017-01-25 12:07:36.199 screenresolution[2178:22097] starting screenresolution argv=screenresolution get 12:07:36 INFO - 2017-01-25 12:07:36.201 screenresolution[2178:22097] Display 0: 1600x1200x32@60 12:07:36 INFO - 2017-01-25 12:07:36.208 screenresolution[2179:22100] starting screenresolution argv=screenresolution list 12:07:36 INFO - Available Modes on Display 0 12:07:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:07:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:07:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:07:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:07:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:07:36 INFO - Intel Iris: 12:07:36 INFO - Chipset Model: Intel Iris 12:07:36 INFO - Type: GPU 12:07:36 INFO - Bus: Built-In 12:07:36 INFO - VRAM (Dynamic, Max): 1536 MB 12:07:36 INFO - Vendor: Intel (0x8086) 12:07:36 INFO - Device ID: 0x0a2e 12:07:36 INFO - Revision ID: 0x0009 12:07:36 INFO - Displays: 12:07:36 INFO - Display: 12:07:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:07:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:07:36 INFO - Display Serial Number: 1600x1200 60 12:07:36 INFO - Main Display: Yes 12:07:36 INFO - Mirror: Off 12:07:36 INFO - Online: Yes 12:07:36 INFO - Rotation: Supported 12:07:36 INFO - Return code: 0 12:07:36 INFO - Running post-action listener: _resource_record_post_action 12:07:36 INFO - [mozharness: 2017-01-25 20:07:36.442389Z] Finished run-tests step (success) 12:07:36 INFO - Running post-run listener: _resource_record_post_run 12:07:36 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 585728; Write bytes: 550876672; Read time: 6; Write time: 1645 12:07:36 INFO - TinderboxPrint: CPU usage
53.6% 12:07:36 INFO - TinderboxPrint: I/O read bytes / time
585,728 / 6 12:07:36 INFO - TinderboxPrint: I/O write bytes / time
550,876,672 / 1,645 12:07:36 INFO - TinderboxPrint: CPU idle
2,229.7 (46.4%) 12:07:36 INFO - TinderboxPrint: CPU system
956.8 (19.9%) 12:07:36 INFO - TinderboxPrint: CPU user
1,615.3 (33.6%) 12:07:36 INFO - TinderboxPrint: Swap in / out
251,019,264 / 0 12:07:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251253248; Write bytes: 243843072; Read time: 18128; Write time: 513 12:07:36 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 512000; Write bytes: 297735680; Read time: 5; Write time: 1098 12:07:36 INFO - Running post-run listener: _upload_blobber_files 12:07:36 INFO - Blob upload gear active. 12:07:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:36 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 12:07:36 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'] 12:07:36 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 12:07:37 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:38 INFO - (blobuploader) - INFO - Done attempting. 12:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:39 INFO - (blobuploader) - INFO - Done attempting. 12:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:07:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:40 INFO - (blobuploader) - INFO - Done attempting. 12:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:42 INFO - (blobuploader) - INFO - Done attempting. 12:07:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:42 INFO - Return code: 0 12:07:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468425a429ab1fa18c9143daa84ad78d5b1fe1ee0ec0996aa914c63015e1b220be4603f301c9c99e1784c4a08c75da0ca6b4fc43e70ffbfb4dc42e576c032ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4df834884a991bec4c792de37a68f45e71b8bae471b2a90d175590cb823a412b2fdc1ca1e439c033b24e0d3e7f9c7865ff83fc94cae5df7da5c9fb2afec71f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f05e494ba3c478a90f89668810c0e9f3713f6107bc54ead891478e1f3c97efef51daef5f37a39f72781cda6fdc2f3923aa800e81f454ef195ed7d7c2b4886a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7f73fa54f44e2144fed15e13b1e6e018f7bbdbf0fb967b60633f05c61a01083c9d3711b09255229364c8d308ee4e4aaa38fb66110ad4c232fcb40095da8e8d"} 12:07:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:42 INFO - Contents: 12:07:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468425a429ab1fa18c9143daa84ad78d5b1fe1ee0ec0996aa914c63015e1b220be4603f301c9c99e1784c4a08c75da0ca6b4fc43e70ffbfb4dc42e576c032ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4df834884a991bec4c792de37a68f45e71b8bae471b2a90d175590cb823a412b2fdc1ca1e439c033b24e0d3e7f9c7865ff83fc94cae5df7da5c9fb2afec71f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f05e494ba3c478a90f89668810c0e9f3713f6107bc54ead891478e1f3c97efef51daef5f37a39f72781cda6fdc2f3923aa800e81f454ef195ed7d7c2b4886a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7f73fa54f44e2144fed15e13b1e6e018f7bbdbf0fb967b60633f05c61a01083c9d3711b09255229364c8d308ee4e4aaa38fb66110ad4c232fcb40095da8e8d"} 12:07:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:42 INFO - Copying logs to upload dir... 12:07:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.826555 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 12:07:42.290582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 12:07:42.293612) ========= 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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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/468425a429ab1fa18c9143daa84ad78d5b1fe1ee0ec0996aa914c63015e1b220be4603f301c9c99e1784c4a08c75da0ca6b4fc43e70ffbfb4dc42e576c032ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4df834884a991bec4c792de37a68f45e71b8bae471b2a90d175590cb823a412b2fdc1ca1e439c033b24e0d3e7f9c7865ff83fc94cae5df7da5c9fb2afec71f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f05e494ba3c478a90f89668810c0e9f3713f6107bc54ead891478e1f3c97efef51daef5f37a39f72781cda6fdc2f3923aa800e81f454ef195ed7d7c2b4886a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7f73fa54f44e2144fed15e13b1e6e018f7bbdbf0fb967b60633f05c61a01083c9d3711b09255229364c8d308ee4e4aaa38fb66110ad4c232fcb40095da8e8d"} build_url:https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/EDt6F89PQpiyM5-2cIO3Eg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468425a429ab1fa18c9143daa84ad78d5b1fe1ee0ec0996aa914c63015e1b220be4603f301c9c99e1784c4a08c75da0ca6b4fc43e70ffbfb4dc42e576c032ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4df834884a991bec4c792de37a68f45e71b8bae471b2a90d175590cb823a412b2fdc1ca1e439c033b24e0d3e7f9c7865ff83fc94cae5df7da5c9fb2afec71f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37f05e494ba3c478a90f89668810c0e9f3713f6107bc54ead891478e1f3c97efef51daef5f37a39f72781cda6fdc2f3923aa800e81f454ef195ed7d7c2b4886a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7f73fa54f44e2144fed15e13b1e6e018f7bbdbf0fb967b60633f05c61a01083c9d3711b09255229364c8d308ee4e4aaa38fb66110ad4c232fcb40095da8e8d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 12:07:42.327984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:07:42.328319) ========= 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.jY4qkb1XTw/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.m7iEKDQOlp/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.005421 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:07:42.376961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 12:07:42.380302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 12:07:42.380629) ========= ========= Total master_lag: 0.18 =========