builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0310 starttime: 1480808926.32 results: success (0) buildid: 20161203133938 builduid: b4a0c0f03b944b4cab8b635e1370c239 revision: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.317991) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.318481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.318765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.346960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.347229) ========= 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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 --2016-12-03 15:48:46-- 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% 8.05M=0.001s 2016-12-03 15:48:46 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082258 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.458423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.458737) ========= 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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.020079 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:46.506960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-03 15:48:46.507293) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 --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 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 2016-12-03 15:48:46,585 truncating revision to first 12 chars 2016-12-03 15:48:46,585 Setting DEBUG logging. 2016-12-03 15:48:46,586 attempt 1/10 2016-12-03 15:48:46,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6bdef7ba8b41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 15:48:48,310 unpacking tar archive at: mozilla-central-6bdef7ba8b41/testing/mozharness/ program finished with exit code 0 elapsedTime=1.984596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-03 15:48:48.516705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:48.517305) ========= script_repo_revision: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:48.517960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:48.518516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 15:48:48.544112) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-12-03 15:48:48.544532) ========= /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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:48:48 INFO - MultiFileLogger online at 20161203 15:48:48 in /builds/slave/test 15:48:48 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 15:48:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:48 INFO - {'append_to_log': False, 15:48:48 INFO - 'base_work_dir': '/builds/slave/test', 15:48:48 INFO - 'blob_upload_branch': 'Firefox', 15:48:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:48 INFO - 'branch': 'Firefox', 15:48:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:48 INFO - 'config_files': ('talos/mac_config.py',), 15:48:48 INFO - 'default_actions': ('clobber', 15:48:48 INFO - 'read-buildbot-config', 15:48:48 INFO - 'download-and-extract', 15:48:48 INFO - 'populate-webroot', 15:48:48 INFO - 'create-virtualenv', 15:48:48 INFO - 'install', 15:48:48 INFO - 'run-tests'), 15:48:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:48 INFO - 'download_minidump_stackwalk': True, 15:48:48 INFO - 'download_symbols': 'ondemand', 15:48:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:48 INFO - 'installer_path': 'installer.exe', 15:48:48 INFO - 'log_level': 'info', 15:48:48 INFO - 'log_name': 'talos', 15:48:48 INFO - 'log_to_console': True, 15:48:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:48:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:48:48 INFO - 'opt_config_files': (), 15:48:48 INFO - 'pip_index': False, 15:48:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:48:48 INFO - 'cmd': ('bash', 15:48:48 INFO - '-c', 15:48:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:48:48 INFO - 'enabled': True, 15:48:48 INFO - 'halt_on_failure': False, 15:48:48 INFO - 'name': 'check_screen_resolution'},), 15:48:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:48:48 INFO - 'cmd': ('bash', 15:48:48 INFO - '-c', 15:48:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:48:48 INFO - 'enabled': True, 15:48:48 INFO - 'halt_on_failure': False, 15:48:48 INFO - 'name': 'check_screen_resolution'},), 15:48:48 INFO - 'run_cmd_checks_enabled': True, 15:48:48 INFO - 'sps_profile': False, 15:48:48 INFO - 'sps_profile_interval': 0, 15:48:48 INFO - 'suite': 'dromaeojs', 15:48:48 INFO - 'system_bits': '32', 15:48:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:48 INFO - 'title': 't-yosemite-r7-0310', 15:48:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:48 INFO - 'use_talos_json': True, 15:48:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:48 INFO - 'work_dir': 'build'} 15:48:48 INFO - [mozharness: 2016-12-03 23:48:48.744088Z] Running clobber step. 15:48:48 INFO - Running pre-action listener: _resource_record_pre_action 15:48:48 INFO - Running main action method: clobber 15:48:48 INFO - rmtree: /builds/slave/test/build 15:48:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:49 INFO - Running post-action listener: _resource_record_post_action 15:48:49 INFO - [mozharness: 2016-12-03 23:48:49.107885Z] Finished clobber step (success) 15:48:49 INFO - [mozharness: 2016-12-03 23:48:49.108014Z] Running read-buildbot-config step. 15:48:49 INFO - Running pre-action listener: _resource_record_pre_action 15:48:49 INFO - Running main action method: read_buildbot_config 15:48:49 INFO - Using buildbot properties: 15:48:49 INFO - { 15:48:49 INFO - "project": "", 15:48:49 INFO - "product": "firefox", 15:48:49 INFO - "script_repo_revision": "production", 15:48:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:48:49 INFO - "repository": "", 15:48:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:48:49 INFO - "buildid": "20161203133938", 15:48:49 INFO - "pgo_build": "False", 15:48:49 INFO - "basedir": "/builds/slave/test", 15:48:49 INFO - "buildnumber": 15, 15:48:49 INFO - "slavename": "t-yosemite-r7-0310", 15:48:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:48:49 INFO - "platform": "yosemite_r7", 15:48:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:48:49 INFO - "branch": "mozilla-central", 15:48:49 INFO - "repo_path": "mozilla-central", 15:48:49 INFO - "revision": "6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017", 15:48:49 INFO - "stage_platform": "macosx64", 15:48:49 INFO - "builduid": "b4a0c0f03b944b4cab8b635e1370c239", 15:48:49 INFO - "slavebuilddir": "test" 15:48:49 INFO - } 15:48:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:48:49 INFO - Running post-action listener: _resource_record_post_action 15:48:49 INFO - [mozharness: 2016-12-03 23:48:49.111173Z] Finished read-buildbot-config step (success) 15:48:49 INFO - [mozharness: 2016-12-03 23:48:49.111286Z] Running download-and-extract step. 15:48:49 INFO - Running pre-action listener: _resource_record_pre_action 15:48:49 INFO - Running main action method: download_and_extract 15:48:49 INFO - mkdir: /builds/slave/test/build/tests 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:49 INFO - trying https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:48:49 INFO - Downloading https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:48:50 INFO - Downloaded 1199 bytes. 15:48:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:48:50 INFO - Using the following test package requirements: 15:48:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:48:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:48:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:48:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'jsshell-mac.zip'], 15:48:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:48:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:48:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:48:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:48:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:48:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:48:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:48:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:48:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:48:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:48:50 INFO - Fetch https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:48:52 INFO - Expected file size: 16283872 15:48:52 INFO - Obtained file size: 16283872 15:48:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:48:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:48:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:48:58 INFO - Fetch https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:48:59 INFO - Expected file size: 16283872 15:48:59 INFO - Obtained file size: 16283872 15:49:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:49:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:49:05 INFO - Fetch https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:49:07 INFO - Expected file size: 14409734 15:49:07 INFO - Obtained file size: 14409734 15:49:07 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')]} 15:49:07 INFO - trying https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:49:08 INFO - Downloading https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:49:13 INFO - Downloaded 107631449 bytes. 15:49:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:49:13 INFO - mkdir: /builds/slave/test/properties 15:49:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:13 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:13 INFO - Contents: 15:49:13 INFO - build_url:https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:49:14 INFO - Running post-action listener: _resource_record_post_action 15:49:14 INFO - Running post-action listener: set_extra_try_arguments 15:49:14 INFO - [mozharness: 2016-12-03 23:49:14.638648Z] Finished download-and-extract step (success) 15:49:14 INFO - [mozharness: 2016-12-03 23:49:14.638800Z] Running populate-webroot step. 15:49:14 INFO - Running pre-action listener: _resource_record_pre_action 15:49:14 INFO - Running main action method: populate_webroot 15:49:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:14 INFO - '--tppagecycles', 15:49:14 INFO - '7'], 15:49:14 INFO - 'tests': ['tsvgm']}}, 15:49:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['damp', 'tps']}, 15:49:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'tests': ['damp', 'tps']}, 15:49:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['dromaeo_dom']}, 15:49:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['basic_compositor_video']}, 15:49:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['a11yr', 15:49:14 INFO - 'ts_paint', 15:49:14 INFO - 'tpaint', 15:49:14 INFO - 'sessionrestore', 15:49:14 INFO - 'sessionrestore_no_auto_restore', 15:49:14 INFO - 'tabpaint']}, 15:49:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['tsvgx', 15:49:14 INFO - 'tsvgr_opacity', 15:49:14 INFO - 'tart', 15:49:14 INFO - 'tscrollx', 15:49:14 INFO - 'cart', 15:49:14 INFO - 'tsvg_static']}, 15:49:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:14 INFO - 'tsvgr_opacity', 15:49:14 INFO - 'tart', 15:49:14 INFO - 'tscrollx', 15:49:14 INFO - 'cart', 15:49:14 INFO - 'tsvg_static']}, 15:49:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'talos_options': ['--disable-e10s'], 15:49:14 INFO - 'tests': ['tp5o']}, 15:49:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:49:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'talos_options': ['--disable-e10s', 15:49:14 INFO - '--xperf_path', 15:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:14 INFO - 'tests': ['tp5n']}, 15:49:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:49:14 INFO - 'talos_options': ['--xperf_path', 15:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:14 INFO - 'tests': ['tp5n']}}, 15:49:14 INFO - 'talos.zip': {'path': '', 15:49:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:14 INFO - Running post-action listener: _resource_record_post_action 15:49:14 INFO - [mozharness: 2016-12-03 23:49:14.657056Z] Finished populate-webroot step (success) 15:49:14 INFO - [mozharness: 2016-12-03 23:49:14.657155Z] Running create-virtualenv step. 15:49:14 INFO - Running pre-action listener: _resource_record_pre_action 15:49:14 INFO - Running main action method: create_virtualenv 15:49:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:14 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 15:49:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:14 INFO - Using real prefix '/tools/python27' 15:49:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:18 INFO - Installing pip.................done. 15:49:18 INFO - Return code: 0 15:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Output received: 15:49:18 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) 15:49:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49: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', 'pip>=1.5'] in /builds/slave/test/build 15:49: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 pip>=1.5 15:49:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:18 INFO - 'HOME': '/Users/cltbld', 15:49:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:18 INFO - 'LOGNAME': 'cltbld', 15:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:18 INFO - 'MOZ_NO_REMOTE': '1', 15:49:18 INFO - 'NO_EM_RESTART': '1', 15:49:18 INFO - 'PAGER': '/bin/cat', 15:49:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:18 INFO - 'PWD': '/builds/slave/test', 15:49:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:18 INFO - 'SHELL': '/bin/bash', 15:49:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:18 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:18 INFO - 'USER': 'cltbld', 15:49:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:18 INFO - 'XPC_FLAGS': '0x0', 15:49:18 INFO - 'XPC_SERVICE_NAME': '0', 15:49:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:18 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 15:49:18 INFO - Cleaning up... 15:49:18 INFO - Return code: 0 15:49:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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', '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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49: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 psutil>=3.1.1 15:49:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:18 INFO - 'HOME': '/Users/cltbld', 15:49:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:18 INFO - 'LOGNAME': 'cltbld', 15:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:18 INFO - 'MOZ_NO_REMOTE': '1', 15:49:18 INFO - 'NO_EM_RESTART': '1', 15:49:18 INFO - 'PAGER': '/bin/cat', 15:49:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:18 INFO - 'PWD': '/builds/slave/test', 15:49:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:18 INFO - 'SHELL': '/bin/bash', 15:49:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:18 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:18 INFO - 'USER': 'cltbld', 15:49:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:18 INFO - 'XPC_FLAGS': '0x0', 15:49:18 INFO - 'XPC_SERVICE_NAME': '0', 15:49:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:19 INFO - Downloading/unpacking psutil>=3.1.1 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:19 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 15:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:22 INFO - Installing collected packages: psutil 15:49:22 INFO - Running setup.py install for psutil 15:49:22 INFO - building 'psutil._psutil_osx' extension 15:49:22 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 INFO - building 'psutil._psutil_posix' extension 15:49:23 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 15:49:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:49:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:49:23 INFO - ^ 15:49:23 INFO - 1 warning generated. 15:49:23 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 15:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:23 INFO - Successfully installed psutil 15:49:23 INFO - Cleaning up... 15:49:23 INFO - Return code: 0 15:49:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:23 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:23 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 15:49:23 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 15:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:23 INFO - 'HOME': '/Users/cltbld', 15:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:23 INFO - 'LOGNAME': 'cltbld', 15:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:23 INFO - 'MOZ_NO_REMOTE': '1', 15:49:23 INFO - 'NO_EM_RESTART': '1', 15:49:23 INFO - 'PAGER': '/bin/cat', 15:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:23 INFO - 'PWD': '/builds/slave/test', 15:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:23 INFO - 'SHELL': '/bin/bash', 15:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:23 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:23 INFO - 'USER': 'cltbld', 15:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:23 INFO - 'XPC_FLAGS': '0x0', 15:49:23 INFO - 'XPC_SERVICE_NAME': '0', 15:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:23 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 15:49:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:26 INFO - Installing collected packages: mozsystemmonitor 15:49:26 INFO - Running setup.py install for mozsystemmonitor 15:49:26 INFO - Successfully installed mozsystemmonitor 15:49:26 INFO - Cleaning up... 15:49:26 INFO - Return code: 0 15:49:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:26 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')]} 15:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:26 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')]} 15:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:26 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:26 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 15:49:26 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 15:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:26 INFO - 'HOME': '/Users/cltbld', 15:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:26 INFO - 'LOGNAME': 'cltbld', 15:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:26 INFO - 'MOZ_NO_REMOTE': '1', 15:49:26 INFO - 'NO_EM_RESTART': '1', 15:49:26 INFO - 'PAGER': '/bin/cat', 15:49:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:26 INFO - 'PWD': '/builds/slave/test', 15:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:26 INFO - 'SHELL': '/bin/bash', 15:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:26 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:26 INFO - 'USER': 'cltbld', 15:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:26 INFO - 'XPC_FLAGS': '0x0', 15:49:26 INFO - 'XPC_SERVICE_NAME': '0', 15:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:26 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 15:49:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:30 INFO - warning: no files found matching '*.txt' 15:49:30 INFO - no previously-included directories found matching 'build' 15:49:30 INFO - no previously-included directories found matching 'dist' 15:49:30 INFO - no previously-included directories found matching '.git*' 15:49:30 INFO - Installing collected packages: jsonschema, functools32 15:49:30 INFO - Running setup.py install for functools32 15:49:30 INFO - warning: no files found matching '*.txt' 15:49:30 INFO - no previously-included directories found matching 'build' 15:49:30 INFO - no previously-included directories found matching 'dist' 15:49:30 INFO - no previously-included directories found matching '.git*' 15:49:30 INFO - Successfully installed jsonschema functools32 15:49:30 INFO - Cleaning up... 15:49:30 INFO - Return code: 0 15:49:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:31 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 15:49:31 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 15:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:31 INFO - 'HOME': '/Users/cltbld', 15:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PAGER': '/bin/cat', 15:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:31 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - 'XPC_FLAGS': '0x0', 15:49:31 INFO - 'XPC_SERVICE_NAME': '0', 15:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:31 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')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:32 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:32 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 15:49:32 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 15:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:32 INFO - 'HOME': '/Users/cltbld', 15:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:32 INFO - 'LOGNAME': 'cltbld', 15:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:32 INFO - 'MOZ_NO_REMOTE': '1', 15:49:32 INFO - 'NO_EM_RESTART': '1', 15:49:32 INFO - 'PAGER': '/bin/cat', 15:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:32 INFO - 'PWD': '/builds/slave/test', 15:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:32 INFO - 'SHELL': '/bin/bash', 15:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:32 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:32 INFO - 'USER': 'cltbld', 15:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:32 INFO - 'XPC_FLAGS': '0x0', 15:49:32 INFO - 'XPC_SERVICE_NAME': '0', 15:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:35 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 INFO - Downloading docopt-0.6.1.tar.gz 15:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:36 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:36 INFO - Running setup.py install for blobuploader 15:49:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:37 INFO - Running setup.py install for requests 15:49:37 INFO - Running setup.py install for docopt 15:49:37 INFO - Successfully installed blobuploader requests docopt 15:49:37 INFO - Cleaning up... 15:49:37 INFO - Return code: 0 15:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:37 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:37 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 15:49:37 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 15:49:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:37 INFO - 'HOME': '/Users/cltbld', 15:49:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:37 INFO - 'LOGNAME': 'cltbld', 15:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:37 INFO - 'MOZ_NO_REMOTE': '1', 15:49:37 INFO - 'NO_EM_RESTART': '1', 15:49:37 INFO - 'PAGER': '/bin/cat', 15:49:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:37 INFO - 'PWD': '/builds/slave/test', 15:49:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:37 INFO - 'SHELL': '/bin/bash', 15:49:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:37 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:37 INFO - 'USER': 'cltbld', 15:49:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:37 INFO - 'XPC_FLAGS': '0x0', 15:49:37 INFO - 'XPC_SERVICE_NAME': '0', 15:49:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-oa9kTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-pSj5Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-CXOmkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Spnyrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Fx21OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-gZQI8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-PHisnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-WDeMJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:38 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-8GeLD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-2E16O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-KDgeLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-TrasyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Htl6tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-FyasxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-yeg1Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-38myVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:39 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-p3CvyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:39 INFO - Running setup.py install for manifestparser 15:49:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:40 INFO - Running setup.py install for mozcrash 15:49:40 INFO - Running setup.py install for mozdebug 15:49:40 INFO - Running setup.py install for mozdevice 15:49:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:40 INFO - Running setup.py install for mozfile 15:49:40 INFO - Running setup.py install for mozhttpd 15:49:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:40 INFO - Running setup.py install for mozinfo 15:49:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:40 INFO - Running setup.py install for mozInstall 15:49:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Running setup.py install for mozleak 15:49:41 INFO - Running setup.py install for mozlog 15:49:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Running setup.py install for moznetwork 15:49:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Running setup.py install for mozprocess 15:49:41 INFO - Running setup.py install for mozprofile 15:49:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:41 INFO - Running setup.py install for mozrunner 15:49:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:42 INFO - Running setup.py install for mozscreenshot 15:49:42 INFO - Running setup.py install for moztest 15:49:42 INFO - Running setup.py install for mozversion 15:49:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:42 INFO - Cleaning up... 15:49:42 INFO - Return code: 0 15:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:42 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:42 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 15:49:42 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 15:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:42 INFO - 'HOME': '/Users/cltbld', 15:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:42 INFO - 'LOGNAME': 'cltbld', 15:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:42 INFO - 'MOZ_NO_REMOTE': '1', 15:49:42 INFO - 'NO_EM_RESTART': '1', 15:49:42 INFO - 'PAGER': '/bin/cat', 15:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:42 INFO - 'PWD': '/builds/slave/test', 15:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:42 INFO - 'SHELL': '/bin/bash', 15:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:42 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:42 INFO - 'USER': 'cltbld', 15:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:42 INFO - 'XPC_FLAGS': '0x0', 15:49:42 INFO - 'XPC_SERVICE_NAME': '0', 15:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-AzZLmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:42 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)) 15:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-n1xmRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:42 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)) 15:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:42 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-_3d8V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-z1xmm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-M5EWFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-GsKsuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-_UmH69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ViFbr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-K4hENH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ir32u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-qDe9sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:43 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:43 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-6CYnyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-PElit9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:44 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)) 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-akpwco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:44 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)) 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-QQjS8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:44 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)) 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-RWhKTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:44 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-2v1546-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:47 INFO - Downloading blessings-1.6.tar.gz 15:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:47 INFO - Installing collected packages: blessings 15:49:47 INFO - Running setup.py install for blessings 15:49:47 INFO - Successfully installed blessings 15:49:47 INFO - Cleaning up... 15:49:47 INFO - Return code: 0 15:49:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:47 INFO - Reading from file tmpfile_stdout 15:49:47 INFO - Current package versions: 15:49:47 INFO - blessings == 1.6 15:49:47 INFO - blobuploader == 1.2.4 15:49:47 INFO - docopt == 0.6.1 15:49:47 INFO - functools32 == 3.2.3-2 15:49:47 INFO - jsonschema == 2.5.1 15:49:47 INFO - manifestparser == 1.1 15:49:47 INFO - mozInstall == 1.12 15:49:47 INFO - mozcrash == 1.0 15:49:47 INFO - mozdebug == 0.1 15:49:47 INFO - mozdevice == 0.49 15:49:47 INFO - mozfile == 1.2 15:49:47 INFO - mozhttpd == 0.7 15:49:47 INFO - mozinfo == 0.9 15:49:47 INFO - mozleak == 0.1 15:49:47 INFO - mozlog == 3.4 15:49:47 INFO - moznetwork == 0.27 15:49:47 INFO - mozprocess == 0.23 15:49:47 INFO - mozprofile == 0.28 15:49:47 INFO - mozrunner == 6.13 15:49:47 INFO - mozscreenshot == 0.1 15:49:47 INFO - mozsystemmonitor == 0.3 15:49:47 INFO - moztest == 0.7 15:49:47 INFO - mozversion == 1.4 15:49:47 INFO - psutil == 3.1.1 15:49:47 INFO - requests == 1.2.3 15:49:47 INFO - wsgiref == 0.1.2 15:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:47 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 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:47 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 15:49:47 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 15:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:47 INFO - 'HOME': '/Users/cltbld', 15:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:47 INFO - 'LOGNAME': 'cltbld', 15:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:47 INFO - 'MOZ_NO_REMOTE': '1', 15:49:47 INFO - 'NO_EM_RESTART': '1', 15:49:47 INFO - 'PAGER': '/bin/cat', 15:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:47 INFO - 'PWD': '/builds/slave/test', 15:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:47 INFO - 'SHELL': '/bin/bash', 15:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:47 INFO - 'USER': 'cltbld', 15:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:47 INFO - 'XPC_FLAGS': '0x0', 15:49:47 INFO - 'XPC_SERVICE_NAME': '0', 15:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 INFO - Cleaning up... 15:49:47 INFO - Return code: 0 15:49:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10677f3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066f5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8d84d6930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, '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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 15:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:47 INFO - 'HOME': '/Users/cltbld', 15:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:47 INFO - 'LOGNAME': 'cltbld', 15:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:47 INFO - 'MOZ_NO_REMOTE': '1', 15:49:47 INFO - 'NO_EM_RESTART': '1', 15:49:47 INFO - 'PAGER': '/bin/cat', 15:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:47 INFO - 'PWD': '/builds/slave/test', 15:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:47 INFO - 'SHELL': '/bin/bash', 15:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:49:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:47 INFO - 'USER': 'cltbld', 15:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:47 INFO - 'XPC_FLAGS': '0x0', 15:49:47 INFO - 'XPC_SERVICE_NAME': '0', 15:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:48 INFO - Cleaning up... 15:49:48 INFO - Return code: 0 15:49:48 INFO - Running post-action listener: _resource_record_post_action 15:49:48 INFO - Running post-action listener: _start_resource_monitoring 15:49:48 INFO - Starting resource monitoring. 15:49:48 INFO - [mozharness: 2016-12-03 23:49:48.279717Z] Finished create-virtualenv step (success) 15:49:48 INFO - [mozharness: 2016-12-03 23:49:48.280728Z] Running install step. 15:49:48 INFO - Running pre-action listener: _resource_record_pre_action 15:49:48 INFO - Running main action method: install 15:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:48 INFO - Reading from file tmpfile_stdout 15:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:48 INFO - Reading from file tmpfile_stdout 15:49:48 INFO - Output received: 15:49:48 INFO - Usage: mozinstall [options] installer 15:49:48 INFO - Options: 15:49:48 INFO - -h, --help show this help message and exit 15:49:48 INFO - -d DEST, --destination=DEST 15:49:48 INFO - Directory to install application into. [default: 15:49:48 INFO - "/builds/slave/test"] 15:49:48 INFO - --app=APP Application being installed. [default: firefox] 15:49:48 INFO - mkdir: /builds/slave/test/build/application 15:49:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:50:21 INFO - Reading from file tmpfile_stdout 15:50:21 INFO - Output received: 15:50:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:50:21 INFO - Running post-action listener: _resource_record_post_action 15:50:21 INFO - [mozharness: 2016-12-03 23:50:21.497744Z] Finished install step (success) 15:50:21 INFO - [mozharness: 2016-12-03 23:50:21.497903Z] Running run-tests step. 15:50:21 INFO - Running pre-action listener: _resource_record_pre_action 15:50:21 INFO - Running main action method: run_tests 15:50:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:50:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:50:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:50:21 INFO - 2016-12-03 15:50:21.512 screenresolution[1999:20971] starting screenresolution argv=screenresolution get 15:50:21 INFO - 2016-12-03 15:50:21.515 screenresolution[1999:20971] Display 0: 1600x1200x32@60 15:50:21 INFO - 2016-12-03 15:50:21.520 screenresolution[2000:20973] starting screenresolution argv=screenresolution list 15:50:21 INFO - Available Modes on Display 0 15:50:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:50:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:50:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:50:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:50:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:50:21 INFO - Intel Iris: 15:50:21 INFO - Chipset Model: Intel Iris 15:50:21 INFO - Type: GPU 15:50:21 INFO - Bus: Built-In 15:50:21 INFO - VRAM (Dynamic, Max): 1536 MB 15:50:21 INFO - Vendor: Intel (0x8086) 15:50:21 INFO - Device ID: 0x0a2e 15:50:21 INFO - Revision ID: 0x0009 15:50:21 INFO - Displays: 15:50:21 INFO - Display: 15:50:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:50:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:50:21 INFO - Display Serial Number: 1600x1200 60 15:50:21 INFO - Main Display: Yes 15:50:21 INFO - Mirror: Off 15:50:21 INFO - Online: Yes 15:50:21 INFO - Rotation: Supported 15:50:21 INFO - Return code: 0 15:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:21 INFO - Python 2.7.3 15:50:21 INFO - Return code: 0 15:50:21 INFO - grabbing minidump binary from tooltool 15:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:21 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 0x106594d30>, '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 0x1063fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10658cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:21 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 15:50:21 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 15:50:21 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 15:50:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:21 INFO - Return code: 0 15:50:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:50:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:50:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:21 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/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 15:50:21 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/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0310 --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 15:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjKO7kHpOC/Render', 15:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:21 INFO - 'HOME': '/Users/cltbld', 15:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:21 INFO - 'LOGNAME': 'cltbld', 15:50:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:21 INFO - 'MOZ_NO_REMOTE': '1', 15:50:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:21 INFO - 'NO_EM_RESTART': '1', 15:50:21 INFO - 'PAGER': '/bin/cat', 15:50:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:21 INFO - 'PWD': '/builds/slave/test', 15:50:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:21 INFO - 'SHELL': '/bin/bash', 15:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5gQIeVe2f/Listeners', 15:50:21 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 15:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:21 INFO - 'USER': 'cltbld', 15:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:21 INFO - 'XPC_FLAGS': '0x0', 15:50:21 INFO - 'XPC_SERVICE_NAME': '0', 15:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:21 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/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 15:50:22 INFO - mozversion application_buildid: 20161203133938 15:50:22 INFO - mozversion application_changeset: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 15:50:22 INFO - mozversion application_display_name: Nightly 15:50:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:22 INFO - mozversion application_name: Firefox 15:50:22 INFO - mozversion application_remotingname: firefox 15:50:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:50:22 INFO - mozversion application_vendor: Mozilla 15:50:22 INFO - mozversion application_version: 53.0a1 15:50:22 INFO - mozversion platform_buildid: 20161203133938 15:50:22 INFO - mozversion platform_changeset: 6bdef7ba8b4108a996b9f61ef9f81c5ea6c93017 15:50:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:50:22 INFO - mozversion platform_version: 53.0a1 15:50:22 INFO - using testdate: 1480809022 15:50:22 INFO - actual date: 1480809022 15:50:22 INFO - starting webserver on 'localhost:49298' 15:50:22 INFO - SUITE-START | Running 2 tests 15:50:22 INFO - TEST-START | dromaeo_css 15:50:22 INFO - operating with platform_type : mac_ 15:50:22 INFO - Initialising browser for dromaeo_css test... 15:50:22 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpM9ol7b/profile http://localhost:49298/getInfo.html) 15:50:24 INFO - PROCESS | 2010 | __metrics Screen width/height:1600/1200 15:50:24 INFO - PROCESS | 2010 | colorDepth:24 15:50:24 INFO - PROCESS | 2010 | Browser inner width/height: 1024/689 15:50:24 INFO - PROCESS | 2010 | __metrics 15:50:24 INFO - PROCESS | 2010 | 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" 15:50:24 INFO - PROCESS | 2010 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:25 INFO - TEST-INFO | 2010: exit 0 15:50:25 INFO - Browser initialized. 15:50:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:25 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpM9ol7b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:37 INFO - PROCESS | 2013 | RSS: Main: 241872896 15:50:37 INFO - PROCESS | 2013 | 15:51:29 INFO - PROCESS | 2013 | 1480809089332 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:53:41 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49298/tests/dromaeo/cssquery-ext.html) 15:53:44 INFO - PROCESS | 2013 | RSS: Main: 498745344 15:53:44 INFO - PROCESS | 2013 | 15:56:47 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-ext.html (next: http://localhost:49298/tests/dromaeo/cssquery-jquery.html) 15:56:48 INFO - PROCESS | 2013 | RSS: Main: 372215808 15:56:48 INFO - PROCESS | 2013 | 15:59:50 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49298/tests/dromaeo/cssquery-mootools.html) 15:59:51 INFO - PROCESS | 2013 | RSS: Main: 339509248 15:59:51 INFO - PROCESS | 2013 | 16:02:53 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49298/tests/dromaeo/cssquery-prototype.html) 16:02:54 INFO - PROCESS | 2013 | RSS: Main: 355037184 16:02:54 INFO - PROCESS | 2013 | 16:05:57 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49298/tests/dromaeo/cssquery-yui.html) 16:05:58 INFO - PROCESS | 2013 | RSS: Main: 333012992 16:05:58 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49298/tests/dromaeo/cssquery-yui.html (next: http://localhost:49298/tests/dromaeo/cssquery-dojo.html) 16:09:01 INFO - PROCESS | 2013 | RSS: Main: 384225280 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | __start_tp_report 16:09:01 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 16:09:01 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 16:09:01 INFO - PROCESS | 2013 | |i|pagename|runs| 16:09:01 INFO - PROCESS | 2013 | |0;dojo.html;3265.575475188225;3270.0353395748252;3284.3102948380847;3302.702756751895;3328.151321413039;5455.072637651599;5494.340679118512;5538.335399752031;5590.077637189869;5613.186088017235;5537.667739935597;5563.415841336652;5578.86052848679;5607.691576963276;5616.269884914956;5062.974685126569;5093.974530127344;5109.565686916598;5134.691918484884;5189.714565698885;5105.157648987913;5173.991071741012;5179.404368497633;5189.221616757498;5198.324217851674;5079.771410286546;5125.205593133071;5137.049645815518;5150.484951504838;5176.016556854186;5175.948240517603;5194.740262986836;5202.817901373433;5207.6615020023955;5215.6349055566125;4986.750662466862;4988.65079444439;5036.219385995177;5143.614228932845;5160.329157209576;5381.354237491487;5452.04589196889;5484.314460692413;5497.697626630534;5519.889602207973;5962.25471816023;5973.253343332083;5993.730282137314;6006.579539432241;6010.939890601126;6060.939335616249;6106.877862442726;6122.1735065766;6123.418275263843;6141.754329826802;5630.605857589971;5655.858603534944;5665.980123577713;5693.402192769782;5734;6278.058082714257;6301.928672125658;6312.0531920211415;6317.210348706411;6332.366763323631;5805.535557155417;5973;6059;6068;6103.755849766048;4726.787294571753;6014.6391216527145;6068.089786532056;6129.785457509055;6130.877382452326;4937.950620493821;6094.847628809227;6126.571140020156;6127.417895299939;6139.723712432951;6098.0852872069545;6098.54260930432;6115.449609535163;6118.755249789959;6126.509879209652;4051.716379853382;4707.458642256116;4719.976400117977;4748.050389922029;4794.352762377104;4317.697761156689;4340.5225425203835;4359.9782001090425;4360.193364227628;4394.011347446799;5535.363433205152;5568.415316391802;5580.079286917613;5580.302462192226;5595.160725891067;5908.20239267702;5944.405559444108;6006.789762358297;6146.0473626587955;6171.043488259327;5556.194351818964;5568.415316391802;5589.189567512688;5594.1888426177975;5639.43605639441;5283.630145889828;5283.9471605284225;5288.0745869472685;5291.867703307448;5294.444083371191;5872.265966754156;6279.748810047547;6301.180846490019;6306.990881459036;6325.715342809676;5622.437756224344;5722.742476588647;5734.197212390185;5771.0189267823735;5801.013827649394;5958.523318134626;6001.639901605743;6008.519318454601;6009.2188015557695;6033.728482218223;5692.345380281155;5693.459121383462;5697.914531281951;5698.0598201296325;5713.428657134254;5747.224124743107;5753.165790960371;5757.078867381367;5758.683272420057;5761.711914404347;5855.3559108498885;5882.264716910387;5891.587588868738;5892.911606325994;5892.911606325994;5873.2658417697785;5879.647221166743;5881.970590147193;5883.0293001654245;5909.261342332208;5639.577031722719;5721.57088218377;5722.427757224411;5731.996900542472;5802.216700745345;5967.343592204941;5968.731407086605;5972.790952316822;5976.7908123215475;5984.820455386345;5598.160275958476;5692.943070569241;5705.37240903492;5708.5147762439;5809.215755872903 16:09:01 INFO - PROCESS | 2013 | |1;ext.html;502.63307785316715;510.3442076931143;527.1512864288495;550.5595523581134;562.5808772464515;35920;37077;37998.430023549634;38388.616113838856;40101.7994910025;39595.0101247469;39943.400848987214;40020;40101.598984010154;40122.19755604894;8266.462679925786;8507.872381914245;9121.361504694674;9305.95347023264;9345.906540934571;10746.313421644589;11106.722331941684;11111.72220694485;11268.887311126866;11281.661550153467;11227.66317010491;11327.376994265313;11332.546698132064;11335.37655428951;11369.886301137007;11178.552857885676;11251.887481125248;11261.268017578832;11269;11277.154213434025;11006.174536909764;11075.003249707564;11079;11081.778364432666;11087.778244435147;32825.83587082073;35634.28731425357;37610.8119459401;37646;37686.81156594227;3204.1829333519804;3217.790843595159;3343.8328083595966;3432.433648448003;3593.838277277529;28911.42177156445;28940.565891511644;29132.563011554845;29187.854060729773;29922.401551969055;3132.201288671374;3140.7173354397987;3148.937021259585;3214.2928555717704;3242.62709788375;341255;342064;343508;343702.28148859594;343825;54263;54546.909061818544;54607;54619.90760184774;54621.72689136529;56915.430845691015;57063.714681427155;57200.71399642975;57212;57237.42762572404;14865.70268594622;15374.461893833663;15417.074975501506;15419;15425.382984680487;10831.404272764916;11041.33751974884;11045.83431248532;11859.34773587461;12037.398130093461;14395.352209150613;14750.55748327552;14750.631234219016;14802.925985370004;14942.402303907722;5793.7392817323325;5848.535873344835;5896.646201227854;5899.351071382144;5907.202527658797;834.4450940124871;855.7133360324236;918.6037223420363;959.7696552827272;1008.641932114089;22872.428189295402;28369.148925532267;28550.85724571364;28765.85617071943;29204;849.814508760276;954.5275088831073;1005.3867141043958;1044.8693913260843;1095.2278643556274;13877.930610347086;14439.92780036093;14646.63383415423;14932.626684332761;15011.549653510412;636256;636268;636327;636399.8140213842;637653;44383.33424998628;53598.66003349947;53811;53885.46114538883;53996.46003539993;1195.6711904226406;1237.0907383073434;1319.5909268127102;1341.8725221104175;1359.5853264754344;27590.862045689642;28528.57207141853;29792.851035744683;30043.248918777204;30050.248743780707;45036.54963450324;45630.54369456263;45782.771086144356;45792;45836.770816145705;520230;521293.1806022989;523314;523626.3818680882;523954;24329;24703.62944555797;25134.874325628254;25145.119920802685;25408.618870717324;43217.3517397233;43254;43820.56179438165;44407.77796110999;46106.53893461157;30505.08484745461;30710.925117620776;31321.74713011454;31632.367352653277;31792.523112153798;36033.27933441264;36040;36709.71515996927;36868.26263474662;37190.44214336733;35682.46476302806;35914.28171436609;36134.941108245395;36302.81848590846;36399.81800090983;31544.580493877373;32193.02265346448;32465.35069298648;32548.18629534186;32680.019599412055;24277.878610607542;24313.149039783522;24349.385884052776;24413.75586244186;24545.386365341008 16:09:01 INFO - PROCESS | 2013 | |2;jquery.html;321.3316302091648;335.6777493606138;366.54365315182594;378.7216395948977;400.0638505896204;14480.348384322704;14709.779353309708;15438.845611543895;17614.383496577622;20129.39611811648;18756.343527976525;18882.69552828253;19784.604307913833;20003.799962000376;20016.699749503732;5426.104692725696;5774.133879918004;5775.364709881909;5777.393373695764;5780.132980053005;5417.26866872971;5690;5703.800366987156;5759.16492108644;5768.826935191951;5699.772009119631;5710.114932185497;5710.371859095496;5716.742746576414;5718.914216286759;5494.725263736797;5593.608447408683;5642.294713160834;5655.1517272409055;5661.1508273758855;5001.024800163969;5005.874853128701;5009;5018.7992480300745;5018.824341148043;24619.892104855324;24772.380690482703;24888.3777905552;25147.24558263255;25221.873890630613;2169.8372622053253;2354.458474550846;2355.3405046586813;2384.1059602649007;2679.7990150738774;11665.300081995107;15252.38990440381;15293.694126117527;15384.615384615474;15692.293846776922;1800.5768644368563;1824.5073830065808;1833.5507800588807;1889.2915156816193;1936.4577918182931;60957;115671.42164289209;116516.13225701681;116848;118363;10328.539939120328;10374.325668831501;10420.95790420967;10483.108935740547;10711.94644026775;11152.386618735885;13299.800502992462;13332.73334533304;13387;13434.193948363129;6740.034384870642;8118.959405202936;8282.420230583923;8379.958100209582;8415.284700800377;8266.739873717788;8314.8337033259;8334.791630209293;8474.1949514796;8539.993101621114;5505.311836020497;6291.591046582049;6299.590526615755;6444.645544495098;6565.540412171198;1771.4508502364051;1833.3399976008893;1833.3858157517382;1836.6602178597002;1838.237131590375;737.7344156103799;821.0721884270736;912.5254867468879;922.9861552076724;930.7161315798611;20279.391618251477;21148.47128821792;21256.36230913075;21302.57394852094;21345.252916148173;891.3510006487945;921.6589861751061;932.7388331267256;959.788846453779;1042.7862288230895;10861.1854110942;11441.052836771301;11578.710532236593;11600.419979001017;11628.76742465146;558502;570564;573543;587822;588073;117217.41391293159;121978.34064978064;122768;124216;126221;992.6575331510618;999.5601935148511;1001.4942454060653;1003.9096481316717;1031.504877658728;18757.906210469406;18988;19176.945268010393;19204.327848525234;19252.614947701248;41509.58490415057;50082.74958625183;50983.745081274355;52228.73885630548;52473.47526524686;57817.13274300973;70884.29115708983;72522;73250;73738.04536387733;7445.478816482794;7636.809079772828;7931.484453510503;7976.242256985809;8188.672453101809;10645.467726613484;12659.810102848649;12873.35633218354;12895.677608059874;13209.075364724376;11047.226694131656;11216.373625824046;11368.976792088752;11425.200235983733;11467;10855.620053298097;11018.724531886766;11365.829512557153;11372.953371488875;11512.712182195512;9011.819763604823;10283;10342.844857327296;10530.736731581772;11429.59996400122;7727.459077864495;8055.516668999879;8196;8293.046299675374;8435.156484351515;8361.540115293717;8878.289736821169;10673.839892401775;11308.717282068013;11411.714707132389 16:09:01 INFO - PROCESS | 2013 | |3;mootools.html;1447.6236178593565;1476.2840022589041;1624.8456396642323;1790.8298711622392;1820.0262859370232;8119.553424561646;8507.829843403128;8519.744407667773;8524.019737730163;8532.8720069199;7435.330820226179;7657;7672.616369181546;7747.728829490969;8297.253247207766;1911.2641632971267;1942.6988816733428;2232.475368288459;2300.804431623314;2301.091069027733;2318.8724620145886;2326.8720220387872;2332.4751930815514;2334.5564342774906;2336.778006089419;2272.9204477843277;2291.2438895164555;2319.675245465636;2327.3716096653893;2329.406001469623;1964.4695932098396;2146.7334272779135;2239.1491233331312;2239.361781892153;2271.6365381538876;2196.077647388101;2197.8021978021893;2214.579229946305;2219.2343641443676;2221.022749990015;8172.141925097898;8266.057476493019;8269.131741167152;8270.958645206796;8275.420720549564;5013.799448022075;5170.242117679969;5172.534471897509;5186.299849520305;5193.5585475234275;2825.6326677531997;3362;3380.492926061086;3515.6835884770494;3519.2785478977003;1052.3896140238644;1055.1453322808472;1069.288922866293;1079.1259080145107;1084.766775143348;10860;10878.401687907162;10976.780464390748;10980.176486763445;10984.231103822656;4186.832526698898;4347.34789781529;4446.777661116931;4458.331250312414;4468.32975053738;8652.178043085896;8664.566771661392;8684.6526138955;8686.695965641173;8686.695965641173;5104.259882317117;5104.69371837691;5105.106606343875;5118.155504341742;5133.076046311699;4175.665946724254;4667.6265898728025;4798.880027999328;4801.4718380978065;4833.589144922651;3384.509246159293;3459.8270086495572;3472.826358682056;3473.392156372625;3559.394902866519;1139.8290256461432;1146.0716819376332;1148.6668866028758;1153.7577108807245;1154.8729639739622;853.423938841292;869.1916517638531;869.5999840073637;899.4783025844994;916.9862452063225;5629.971850140805;5697.430256974352;5853;5998.940010599838;6074;826.2604968553111;877.4121338702956;896.233720169259;903.8282726281985;911.1753862754218;3738.1962877981364;3742.251549690073;3819.809009549567;3823.4647149399107;3934.586868378779;9940.25448091396;10238.53926573291;10343.482825858828;10343.586256549654;10350.689479315633;8521.36089793268;10282.742931426625;10287.588496460057;10299.845502317472;10303.536340864679;7694.884576731353;7741.458097933203;7904.802379940547;7905.960470197612;7907.723229686933;4803.927941080817;5524.7348587079105;5556.333240011225;5604.243427137284;5681.829545113653;9306.813863722824;9474.478903660365;9491.240700744062;9497.287703422133;9506.429614223169;9408.388454750419;9438.905610943802;9495.810083798147;9524.428534287965;9659.937406885096;5687.20379146928;5733.541316694738;6820.795376138723;6837.487188460786;6853.623050732258;6993.055937448379;7244.420446364384;7248.927510725036;7784.41616878725;7891.092524359542;6875.278095800069;6908.896366554606;7100.289971002859;7107.253738357398;7128.4653650977425;6843.520953533205;6885.9671049341;6928.7228510859;6944.965275173794;6992.195897471653;5497.36780270274;6602.60384376939;6603.141591593062;6607.933920660732;6608.240052393844;4033.878983630496;4730.101280756645;4736.19484687597;4814;4858.611311095033;4487.012857171417;4688.156131896291;4866.489018653132;4910.165271903857;4920.114379411741 16:09:01 INFO - PROCESS | 2013 | |4;prototype.html;297.31468964037896;300.3003003003003;305.19276513621463;310.8865264178574;314.0562609358876;5417.783288668454;5436.619436639432;5437.7493176569415;5473.781048758055;5479.369872464667;5000.59995200384;5118.360204974379;5197.558207552353;5207;5383.4616538346145;4046.6560342370935;4071.837126514943;4076.388541718751;4118.073433477459;4124.566920473352;3491.9476207856774;3737.962620373802;4084.836606535735;4105.609967053125;4139.8965025874295;3397.2186397128676;3929.6659783918403;4050.2102090092444;4069.4536076291115;4077.103037331782;4073.714839961204;4095.28332541804;4110.7328023678365;4111.198316328302;4115.54728979812;3273.7068857801273;3517.26137511123;3546.414841551141;3550.6449355064547;3581.534400527915;4451.57710017551;5059.8988020239385;5113.440400677791;5185.118529849935;5269.262303277545;3872.3997780344093;4065.3901914712733;4296.355546667994;4535.593965870591;4570;4731.432228132611;5580.135079062752;5683.74423150955;5690.2033715279895;5701.971490142564;3474.8436320365645;3820.617938206185;3851.2105018471148;3857.382818749015;3866;4986.584189829978;5346.198070289449;5596.215235973225;5626.409227031144;5873.500752436005;3174.206448387903;3848.461215429842;3850.3646898261472;3879.767213967171;3898.2788184186015;3361.8737722863116;3909.6285852843935;3916.4712763776524;3916.941245881314;3920.941185882214;3837.769733815924;4294.57054294568;4506.81972721094;4600.182927743523;4600.309953506934;5286.867828304246;5392.191171324333;5634.577406694514;5705.942940570541;5707.771689132472;1268.796992481217;1272.4274076665538;1278.8017857231957;1281.6350586625401;1281.7759040116666;717.8872747241754;816.7100679258897;823.4359463767219;830.8089139497949;832.9167083291743;4618.630509559227;4803.543663351976;4825.179719447632;5265.9204863003;5284.9471505284455;4890.58430033444;5846.941530584725;5850.64896106235;5862.251576223272;5880.353161152269;4230.428892099589;4291.570842915746;5080.085584594808;5234.476552344735;5282.709450980233;2490.3276115448725;2877.8128622246822;2881.550681920351;2897.015014894946;2901.1296611017033;4612.025243717851;5678.3186017678145;5696.914546281809;5770.826875193751;5802.506786923074;5738.77044918207;6046.274447066292;6119.44924956756;6126.816195514141;6167.907481387782;5603.215549823028;6134;6150.7847225346;6151.2618485781995;6175.869325082839;5020.523050310215;5618.747156378055;5773.769049237983;5872.559558033079;5957.987142185925;5116.718580478109;5860.677662728591;5864.9706751467675;5888.234529511307;5897.7935772247765;5441.347038355423;5526.640768350045;5959.582829202088;6179.783707570214;6183.629921692778;3313.3870234006786;3899.3484430587473;3909.0877296414355;3938.369860822255;3941.7832019239218;5001.949590585872;5874.794382196603;5906.616069955611;5908.961408314125;5930.940690593039;5396.676199428047;5769.278840144982;5781.364049954417;5787.594868359174;5818.854528636818;5254.395744489432;5704.543636508986;5712.542996560348;5743.798967036134;5791.420857914175;4197.706160568731;5281.313429254173;5630.493255607015;5636.661800291996;5670.603057785916;4502.549745025472;4967.801287948441;5648.322201335866;5681.204631351697;5775.27809023872;4729.196036673705;5547.639403438763;5583.74873130702;5598.972005139948;5603.747831347518 16:09:01 INFO - PROCESS | 2013 | |5;yui.html;627.4603840697001;663.4839391989302;669.6250099944028;754.9169591344954;773.8645736996026;13832.585022449317;14897.851021489781;14917.32872020759;15692.979956302832;15710.0573965562;11620.302781833096;13992.860071399284;14062.367193476319;14134.434622615083;14144.929275353634;646.6572716460261;664.0139393001389;786.6184900323339;823.8105235795756;839.86562150056;821.4783612406105;824.3858325547476;828.9129641387658;835.3567752830317;838.7693384319331;888.2760550151638;890.0698769785557;891.1355984694835;892.6741739265186;894.8881389826272;668.9364510371507;694.3785312145601;884.3058199313508;885.844977129003;886.4592598514901;513.8124584526659;514.8326793792032;515.9277701121846;623.392192612204;642.9614223146626;14921.701565968728;15012.12348456443;15066.020708653903;15072.698546029018;15120.773188402183;11285;13660.316984150852;13766;14003.369848356848;14084.2957852107;11296.362027505966;11716.88283117175;12556.497740090386;12658.81011784824;13221.272829994346;4488.730676159441;4530.161920044769;4534.183846907556;4715.669903106784;4719.07977944301;111313.88686113116;111606.44196779045;112950;113632;115891.8410815898;10453.738656533495;10548.683539493828;10611.151107911348;10668.466576671135;10838.187135964834;20670.483237919172;20888;21076.78923210779;21127;21186.894065529574;7559.886601700979;7642.541447513167;7721.305082542598;7730.7680769577;7807.141214466405;4068.4304197412384;4149.543550209474;4316.935245971313;4325.5674432557125;4339.110482351173;3464.601570819388;3468.4103702370658;3508.7719298245534;3509.754317197772;3512.3853325667906;640.1997503121098;643.7264162730821;647.7117682631184;652.882481153397;668.4618881800197;500.25660572903405;595.627732667083;599.2210126835097;605.2676261723276;637.4613451633362;8117.756467305991;9358.407632177074;10046.799064018678;10206.285560010876;10405.739856503647;600.3006497430532;604.6372176693949;653.9084528166061;654.1528720307214;663.1809715001968;4207.179599978036;4262.147570485915;4422.646188304992;4427;4430.158269928703;111566;113182;113398.43300783444;113819;114299.71400571942;98573.7638536873;99033.64012218332;99899;100197.4970375445;102663.48668256612;88410.55794720985;88735.9999999987;89061;89397.55301223452;90429;8946.507942062988;9057.501837398742;9089.181973622406;9244.768880778034;9451.905480945377;51182.74408627933;51238.48761512486;52424.73787631038;52531.73734131305;52748;52786.457421971674;75451;78186.04534886673;79656.60171699336;80314.59842700748;12664.74670506603;12748.553800616934;12912.483500659868;13160;13439.865601343861;14024.78962815579;14212.21832799206;14214.687018346425;14278.42886284537;14513.854861451251;13554.322283885569;13659.317034148055;13760.65598360049;13809.585712428643;14238;12846.293453859753;13289.800652990407;13732.244726540137;13851.792223116863;13854.792178117135;13225.470981160646;13443;13627.250501222528;13744.518941836988;13806.792898106738;11263.49314280843;11371;11388.37363944991;11547.942260288644;11743.471543780379;11221.214514983873;11349.14881383883;11417.828732569184;11623.941880290544;11636.94181529087 16:09:01 INFO - PROCESS | 2013 | __end_tp_report 16:09:01 INFO - PROCESS | 2013 | __start_cc_report 16:09:01 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,3239 16:09:01 INFO - PROCESS | 2013 | __end_cc_report 16:09:01 INFO - PROCESS | 2013 | __startTimestamp1480810141805__endTimestamp 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | ------- Summary: start ------- 16:09:01 INFO - PROCESS | 2013 | Number of tests: 6 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#0] dojo.html Cycles:165 Average:5559.83 Median:5697.91 stddev:612.25 (10.7%) stddev-sans-first:587.08 16:09:01 INFO - PROCESS | 2013 | Values: 3265.6 3270.0 3284.3 3302.7 3328.2 5455.1 5494.3 5538.3 5590.1 5613.2 5537.7 5563.4 5578.9 5607.7 5616.3 5063.0 5094.0 5109.6 5134.7 5189.7 5105.2 5174.0 5179.4 5189.2 5198.3 5079.8 5125.2 5137.0 5150.5 5176.0 5175.9 5194.7 5202.8 5207.7 5215.6 4986.8 4988.7 5036.2 5143.6 5160.3 5381.4 5452.0 5484.3 5497.7 5519.9 5962.3 5973.3 5993.7 6006.6 6010.9 6060.9 6106.9 6122.2 6123.4 6141.8 5630.6 5655.9 5666.0 5693.4 5734.0 6278.1 6301.9 6312.1 6317.2 6332.4 5805.5 5973.0 6059.0 6068.0 6103.8 4726.8 6014.6 6068.1 6129.8 6130.9 4938.0 6094.8 6126.6 6127.4 6139.7 6098.1 6098.5 6115.4 6118.8 6126.5 4051.7 4707.5 4720.0 4748.1 4794.4 4317.7 4340.5 4360.0 4360.2 4394.0 5535.4 5568.4 5580.1 5580.3 5595.2 5908.2 5944.4 6006.8 6146.0 6171.0 5556.2 5568.4 5589.2 5594.2 5639.4 5283.6 5283.9 5288.1 5291.9 5294.4 5872.3 6279.7 6301.2 6307.0 6325.7 5622.4 5722.7 5734.2 5771.0 5801.0 5958.5 6001.6 6008.5 6009.2 6033.7 5692.3 5693.5 5697.9 5698.1 5713.4 5747.2 5753.2 5757.1 5758.7 5761.7 5855.4 5882.3 5891.6 5892.9 5892.9 5873.3 5879.6 5882.0 5883.0 5909.3 5639.6 5721.6 5722.4 5732.0 5802.2 5967.3 5968.7 5972.8 5976.8 5984.8 5598.2 5692.9 5705.4 5708.5 5809.2 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#1] ext.html Cycles:180 Average:62961.61 Median:32752.93 stddev:137839.57 (420.8%) stddev-sans-first:138146.47 16:09:01 INFO - PROCESS | 2013 | Values: 502.6 510.3 527.2 550.6 562.6 35920.0 37077.0 37998.4 38388.6 40101.8 39595.0 39943.4 40020.0 40101.6 40122.2 8266.5 8507.9 9121.4 9306.0 9345.9 10746.3 11106.7 11111.7 11268.9 11281.7 11227.7 11327.4 11332.5 11335.4 11369.9 11178.6 11251.9 11261.3 11269.0 11277.2 11006.2 11075.0 11079.0 11081.8 11087.8 32825.8 35634.3 37610.8 37646.0 37686.8 3204.2 3217.8 3343.8 3432.4 3593.8 28911.4 28940.6 29132.6 29187.9 29922.4 3132.2 3140.7 3148.9 3214.3 3242.6 341255.0 342064.0 343508.0 343702.3 343825.0 54263.0 54546.9 54607.0 54619.9 54621.7 56915.4 57063.7 57200.7 57212.0 57237.4 14865.7 15374.5 15417.1 15419.0 15425.4 10831.4 11041.3 11045.8 11859.3 12037.4 14395.4 14750.6 14750.6 14802.9 14942.4 5793.7 5848.5 5896.6 5899.4 5907.2 834.4 855.7 918.6 959.8 1008.6 22872.4 28369.1 28550.9 28765.9 29204.0 849.8 954.5 1005.4 1044.9 1095.2 13877.9 14439.9 14646.6 14932.6 15011.5 636256.0 636268.0 636327.0 636399.8 637653.0 44383.3 53598.7 53811.0 53885.5 53996.5 1195.7 1237.1 1319.6 1341.9 1359.6 27590.9 28528.6 29792.9 30043.2 30050.2 45036.5 45630.5 45782.8 45792.0 45836.8 520230.0 521293.2 523314.0 523626.4 523954.0 24329.0 24703.6 25134.9 25145.1 25408.6 43217.4 43254.0 43820.6 44407.8 46106.5 30505.1 30710.9 31321.7 31632.4 31792.5 36033.3 36040.0 36709.7 36868.3 37190.4 35682.5 35914.3 36134.9 36302.8 36399.8 31544.6 32193.0 32465.4 32548.2 32680.0 24277.9 24313.1 24349.4 24413.8 24545.4 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#2] jquery.html Cycles:180 Average:33455.85 Median:24830.38 stddev:95877.30 (386.1%) stddev-sans-first:96113.98 16:09:01 INFO - PROCESS | 2013 | Values: 321.3 335.7 366.5 378.7 400.1 14480.3 14709.8 15438.8 17614.4 20129.4 18756.3 18882.7 19784.6 20003.8 20016.7 5426.1 5774.1 5775.4 5777.4 5780.1 5417.3 5690.0 5703.8 5759.2 5768.8 5699.8 5710.1 5710.4 5716.7 5718.9 5494.7 5593.6 5642.3 5655.2 5661.2 5001.0 5005.9 5009.0 5018.8 5018.8 24619.9 24772.4 24888.4 25147.2 25221.9 2169.8 2354.5 2355.3 2384.1 2679.8 11665.3 15252.4 15293.7 15384.6 15692.3 1800.6 1824.5 1833.6 1889.3 1936.5 60957.0 115671.4 116516.1 116848.0 118363.0 10328.5 10374.3 10421.0 10483.1 10711.9 11152.4 13299.8 13332.7 13387.0 13434.2 6740.0 8119.0 8282.4 8380.0 8415.3 8266.7 8314.8 8334.8 8474.2 8540.0 5505.3 6291.6 6299.6 6444.6 6565.5 1771.5 1833.3 1833.4 1836.7 1838.2 737.7 821.1 912.5 923.0 930.7 20279.4 21148.5 21256.4 21302.6 21345.3 891.4 921.7 932.7 959.8 1042.8 10861.2 11441.1 11578.7 11600.4 11628.8 558502.0 570564.0 573543.0 587822.0 588073.0 117217.4 121978.3 122768.0 124216.0 126221.0 992.7 999.6 1001.5 1003.9 1031.5 18757.9 18988.0 19176.9 19204.3 19252.6 41509.6 50082.7 50983.7 52228.7 52473.5 57817.1 70884.3 72522.0 73250.0 73738.0 7445.5 7636.8 7931.5 7976.2 8188.7 10645.5 12659.8 12873.4 12895.7 13209.1 11047.2 11216.4 11369.0 11425.2 11467.0 10855.6 11018.7 11365.8 11373.0 11512.7 9011.8 10283.0 10342.8 10530.7 11429.6 7727.5 8055.5 8196.0 8293.0 8435.2 8361.5 8878.3 10673.8 11308.7 11411.7 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#3] mootools.html Cycles:180 Average:5348.58 Median:5104.48 stddev:2970.31 (58.2%) stddev-sans-first:2964.18 16:09:01 INFO - PROCESS | 2013 | Values: 1447.6 1476.3 1624.8 1790.8 1820.0 8119.6 8507.8 8519.7 8524.0 8532.9 7435.3 7657.0 7672.6 7747.7 8297.3 1911.3 1942.7 2232.5 2300.8 2301.1 2318.9 2326.9 2332.5 2334.6 2336.8 2272.9 2291.2 2319.7 2327.4 2329.4 1964.5 2146.7 2239.1 2239.4 2271.6 2196.1 2197.8 2214.6 2219.2 2221.0 8172.1 8266.1 8269.1 8271.0 8275.4 5013.8 5170.2 5172.5 5186.3 5193.6 2825.6 3362.0 3380.5 3515.7 3519.3 1052.4 1055.1 1069.3 1079.1 1084.8 10860.0 10878.4 10976.8 10980.2 10984.2 4186.8 4347.3 4446.8 4458.3 4468.3 8652.2 8664.6 8684.7 8686.7 8686.7 5104.3 5104.7 5105.1 5118.2 5133.1 4175.7 4667.6 4798.9 4801.5 4833.6 3384.5 3459.8 3472.8 3473.4 3559.4 1139.8 1146.1 1148.7 1153.8 1154.9 853.4 869.2 869.6 899.5 917.0 5630.0 5697.4 5853.0 5998.9 6074.0 826.3 877.4 896.2 903.8 911.2 3738.2 3742.3 3819.8 3823.5 3934.6 9940.3 10238.5 10343.5 10343.6 10350.7 8521.4 10282.7 10287.6 10299.8 10303.5 7694.9 7741.5 7904.8 7906.0 7907.7 4803.9 5524.7 5556.3 5604.2 5681.8 9306.8 9474.5 9491.2 9497.3 9506.4 9408.4 9438.9 9495.8 9524.4 9659.9 5687.2 5733.5 6820.8 6837.5 6853.6 6993.1 7244.4 7248.9 7784.4 7891.1 6875.3 6908.9 7100.3 7107.3 7128.5 6843.5 6886.0 6928.7 6945.0 6992.2 5497.4 6602.6 6603.1 6607.9 6608.2 4033.9 4730.1 4736.2 4814.0 4858.6 4487.0 4688.2 4866.5 4910.2 4920.1 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#4] prototype.html Cycles:180 Average:4554.48 Median:5117.54 stddev:1442.95 (28.2%) stddev-sans-first:1411.18 16:09:01 INFO - PROCESS | 2013 | Values: 297.3 300.3 305.2 310.9 314.1 5417.8 5436.6 5437.7 5473.8 5479.4 5000.6 5118.4 5197.6 5207.0 5383.5 4046.7 4071.8 4076.4 4118.1 4124.6 3491.9 3738.0 4084.8 4105.6 4139.9 3397.2 3929.7 4050.2 4069.5 4077.1 4073.7 4095.3 4110.7 4111.2 4115.5 3273.7 3517.3 3546.4 3550.6 3581.5 4451.6 5059.9 5113.4 5185.1 5269.3 3872.4 4065.4 4296.4 4535.6 4570.0 4731.4 5580.1 5683.7 5690.2 5702.0 3474.8 3820.6 3851.2 3857.4 3866.0 4986.6 5346.2 5596.2 5626.4 5873.5 3174.2 3848.5 3850.4 3879.8 3898.3 3361.9 3909.6 3916.5 3916.9 3920.9 3837.8 4294.6 4506.8 4600.2 4600.3 5286.9 5392.2 5634.6 5705.9 5707.8 1268.8 1272.4 1278.8 1281.6 1281.8 717.9 816.7 823.4 830.8 832.9 4618.6 4803.5 4825.2 5265.9 5284.9 4890.6 5846.9 5850.6 5862.3 5880.4 4230.4 4291.6 5080.1 5234.5 5282.7 2490.3 2877.8 2881.6 2897.0 2901.1 4612.0 5678.3 5696.9 5770.8 5802.5 5738.8 6046.3 6119.4 6126.8 6167.9 5603.2 6134.0 6150.8 6151.3 6175.9 5020.5 5618.7 5773.8 5872.6 5958.0 5116.7 5860.7 5865.0 5888.2 5897.8 5441.3 5526.6 5959.6 6179.8 6183.6 3313.4 3899.3 3909.1 3938.4 3941.8 5001.9 5874.8 5906.6 5909.0 5930.9 5396.7 5769.3 5781.4 5787.6 5818.9 5254.4 5704.5 5712.5 5743.8 5791.4 4197.7 5281.3 5630.5 5636.7 5670.6 4502.5 4967.8 5648.3 5681.2 5775.3 4729.2 5547.6 5583.7 5599.0 5603.7 16:09:01 INFO - PROCESS | 2013 | 16:09:01 INFO - PROCESS | 2013 | [#5] yui.html Cycles:180 Average:21733.98 Median:4108.99 stddev:32492.68 (790.8%) stddev-sans-first:32545.18 16:09:01 INFO - PROCESS | 2013 | Values: 627.5 663.5 669.6 754.9 773.9 13832.6 14897.9 14917.3 15693.0 15710.1 11620.3 13992.9 14062.4 14134.4 14144.9 646.7 664.0 786.6 823.8 839.9 821.5 824.4 828.9 835.4 838.8 888.3 890.1 891.1 892.7 894.9 668.9 694.4 884.3 885.8 886.5 513.8 514.8 515.9 623.4 643.0 14921.7 15012.1 15066.0 15072.7 15120.8 11285.0 13660.3 13766.0 14003.4 14084.3 11296.4 11716.9 12556.5 12658.8 13221.3 4488.7 4530.2 4534.2 4715.7 4719.1 111313.9 111606.4 112950.0 113632.0 115891.8 10453.7 10548.7 10611.2 10668.5 10838.2 20670.5 20888.0 21076.8 21127.0 21186.9 7559.9 7642.5 7721.3 7730.8 7807.1 4068.4 4149.5 4316.9 4325.6 4339.1 3464.6 3468.4 3508.8 3509.8 3512.4 640.2 643.7 647.7 652.9 668.5 500.3 595.6 599.2 605.3 637.5 8117.8 9358.4 10046.8 10206.3 10405.7 600.3 604.6 653.9 654.2 663.2 4207.2 4262.1 4422.6 4427.0 4430.2 111566.0 113182.0 113398.4 113819.0 114299.7 98573.8 99033.6 99899.0 100197.5 102663.5 88410.6 88736.0 89061.0 89397.6 90429.0 8946.5 9057.5 9089.2 9244.8 9451.9 51182.7 51238.5 52424.7 52531.7 52748.0 52786.5 75451.0 78186.0 79656.6 80314.6 12664.7 12748.6 12912.5 13160.0 13439.9 14024.8 14212.2 14214.7 14278.4 14513.9 13554.3 13659.3 13760.7 13809.6 14238.0 12846.3 13289.8 13732.2 13851.8 13854.8 13225.5 13443.0 13627.3 13744.5 13806.8 11263.5 11371.0 11388.4 11547.9 11743.5 11221.2 11349.1 11417.8 11623.9 11636.9 16:09:01 INFO - PROCESS | 2013 | -------- Summary: end -------- 16:09:01 INFO - PROCESS | 2013 | 16:09:02 INFO - TEST-INFO | 2013: exit 0 16:09:02 INFO - TEST-OK | dromaeo_css | took 1120352ms 16:09:02 INFO - TEST-START | kraken 16:09:02 INFO - operating with platform_type : mac_ 16:09:02 INFO - Initialising browser for kraken test... 16:09:02 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmp79vK7f/profile http://localhost:49298/getInfo.html) 16:09:05 INFO - PROCESS | 2020 | __metrics Screen width/height:1600/1200 16:09:05 INFO - PROCESS | 2020 | colorDepth:24 16:09:05 INFO - PROCESS | 2020 | Browser inner width/height: 1024/689 16:09:05 INFO - PROCESS | 2020 | __metrics 16:09:05 INFO - PROCESS | 2020 | 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" 16:09:05 INFO - PROCESS | 2020 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:06 INFO - TEST-INFO | 2020: exit 0 16:09:06 INFO - Browser initialized. 16:09:06 INFO - Running cycle 1/1 for kraken test... 16:09:06 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmp79vK7f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:18 INFO - PROCESS | 2021 | RSS: Main: 234774528 16:09:18 INFO - PROCESS | 2021 | 16:09:21 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:22 INFO - PROCESS | 2021 | RSS: Main: 294166528 16:09:22 INFO - PROCESS | 2021 | 16:09:24 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-dft) 16:09:25 INFO - PROCESS | 2021 | RSS: Main: 296243200 16:09:25 INFO - PROCESS | 2021 | 16:09:28 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-fft) 16:09:29 INFO - PROCESS | 2021 | RSS: Main: 388587520 16:09:29 INFO - PROCESS | 2021 | 16:09:31 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49298/tests/kraken/driver.html?testName=audio-oscillator) 16:09:31 INFO - PROCESS | 2021 | RSS: Main: 291282944 16:09:31 INFO - PROCESS | 2021 | 16:09:33 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:34 INFO - PROCESS | 2021 | RSS: Main: 294805504 16:09:34 INFO - PROCESS | 2021 | 16:09:37 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:37 INFO - PROCESS | 2021 | RSS: Main: 336379904 16:09:37 INFO - PROCESS | 2021 | 16:09:40 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49298/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:41 INFO - PROCESS | 2021 | RSS: Main: 337842176 16:09:41 INFO - PROCESS | 2021 | 16:09:44 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49298/tests/kraken/driver.html?testName=json-parse-financial) 16:09:44 INFO - PROCESS | 2021 | RSS: Main: 336961536 16:09:44 INFO - PROCESS | 2021 | 16:09:46 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:46 INFO - PROCESS | 2021 | RSS: Main: 308228096 16:09:46 INFO - PROCESS | 2021 | 16:09:48 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:49 INFO - PROCESS | 2021 | RSS: Main: 312963072 16:09:49 INFO - PROCESS | 2021 | 16:09:51 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:52 INFO - PROCESS | 2021 | RSS: Main: 313974784 16:09:52 INFO - PROCESS | 2021 | 16:09:55 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:56 INFO - PROCESS | 2021 | RSS: Main: 330088448 16:09:56 INFO - PROCESS | 2021 | 16:09:59 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:59 INFO - PROCESS | 2021 | RSS: Main: 323862528 16:09:59 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49298/tests/kraken/driver.html?testName=ai-astar) 16:10:01 INFO - PROCESS | 2021 | RSS: Main: 367857664 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | __start_tp_report 16:10:01 INFO - PROCESS | 2021 | _x_x_mozilla_page_load 16:10:01 INFO - PROCESS | 2021 | _x_x_mozilla_page_load_details 16:10:01 INFO - PROCESS | 2021 | |i|pagename|runs| 16:10:01 INFO - PROCESS | 2021 | |0;ai-astar;103;113;114;113;113;114;113;114;114;113 16:10:01 INFO - PROCESS | 2021 | |1;audio-beat-detection;149;115;114;155;116;115;126;115;139;117 16:10:01 INFO - PROCESS | 2021 | |2;audio-dft;178;185;183;181;184;184;184;182;186;193 16:10:01 INFO - PROCESS | 2021 | |3;audio-fft;80;60;59;87;62;60;58;60;72;49 16:10:01 INFO - PROCESS | 2021 | |4;audio-oscillator;86;71;85;69;67;68;81;67;69;83 16:10:01 INFO - PROCESS | 2021 | |5;imaging-gaussian-blur;89;86;89;86;87;88;89;86;90;85 16:10:01 INFO - PROCESS | 2021 | |6;imaging-darkroom;93;95;94;93;94;95;95;94;94;123 16:10:01 INFO - PROCESS | 2021 | |7;imaging-desaturate;84;85;88;86;87;84;87;85;85;84 16:10:01 INFO - PROCESS | 2021 | |8;json-parse-financial;58;56;56;57;54;57;55;55;55;56 16:10:01 INFO - PROCESS | 2021 | |9;json-stringify-tinderbox;64;67;74;76;72;70;70;72;71;72 16:10:01 INFO - PROCESS | 2021 | |10;stanford-crypto-aes;88;86;88;88;89;88;89;87;88;98 16:10:01 INFO - PROCESS | 2021 | |11;stanford-crypto-ccm;150;148;150;146;148;150;150;149;215;173 16:10:01 INFO - PROCESS | 2021 | |12;stanford-crypto-pbkdf2;174;197;234;196;207;205;175;175;174;172 16:10:01 INFO - PROCESS | 2021 | |13;stanford-crypto-sha256-iterative;70;71;71;69;69;70;68;70;68;69 16:10:01 INFO - PROCESS | 2021 | __end_tp_report 16:10:01 INFO - PROCESS | 2021 | __start_cc_report 16:10:01 INFO - PROCESS | 2021 | _x_x_mozilla_cycle_collect,2023 16:10:01 INFO - PROCESS | 2021 | __end_cc_report 16:10:01 INFO - PROCESS | 2021 | __startTimestamp1480810201827__endTimestamp 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | ------- Summary: start ------- 16:10:01 INFO - PROCESS | 2021 | Number of tests: 14 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.34 (2.9%) stddev-sans-first:0.53 16:10:01 INFO - PROCESS | 2021 | Values: 103.0 113.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 113.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:121.50 stddev:15.73 (12.9%) stddev-sans-first:14.34 16:10:01 INFO - PROCESS | 2021 | Values: 149.0 115.0 114.0 155.0 116.0 115.0 126.0 115.0 139.0 117.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:3.89 (2.1%) stddev-sans-first:3.46 16:10:01 INFO - PROCESS | 2021 | Values: 178.0 185.0 183.0 181.0 184.0 184.0 184.0 182.0 186.0 193.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#3] audio-fft Cycles:10 Average:64.70 Median:61.00 stddev:11.46 (18.8%) stddev-sans-first:10.74 16:10:01 INFO - PROCESS | 2021 | Values: 80.0 60.0 59.0 87.0 62.0 60.0 58.0 60.0 72.0 49.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.00 stddev:8.06 (10.6%) stddev-sans-first:7.42 16:10:01 INFO - PROCESS | 2021 | Values: 86.0 71.0 85.0 69.0 67.0 68.0 81.0 67.0 69.0 83.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.72 (1.9%) stddev-sans-first:1.73 16:10:01 INFO - PROCESS | 2021 | Values: 89.0 86.0 89.0 86.0 87.0 88.0 89.0 86.0 90.0 85.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:94.00 stddev:9.17 (9.8%) stddev-sans-first:9.61 16:10:01 INFO - PROCESS | 2021 | Values: 93.0 95.0 94.0 93.0 94.0 95.0 95.0 94.0 94.0 123.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.43 (1.7%) stddev-sans-first:1.41 16:10:01 INFO - PROCESS | 2021 | Values: 84.0 85.0 88.0 86.0 87.0 84.0 87.0 85.0 85.0 84.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.00 16:10:01 INFO - PROCESS | 2021 | Values: 58.0 56.0 56.0 57.0 54.0 57.0 55.0 55.0 55.0 56.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:72.00 stddev:3.39 (4.7%) stddev-sans-first:2.55 16:10:01 INFO - PROCESS | 2021 | Values: 64.0 67.0 74.0 76.0 72.0 70.0 70.0 72.0 71.0 72.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.00 stddev:3.31 (3.8%) stddev-sans-first:3.50 16:10:01 INFO - PROCESS | 2021 | Values: 88.0 86.0 88.0 88.0 89.0 88.0 89.0 87.0 88.0 98.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:150.00 stddev:21.49 (14.3%) stddev-sans-first:22.60 16:10:01 INFO - PROCESS | 2021 | Values: 150.0 148.0 150.0 146.0 148.0 150.0 150.0 149.0 215.0 173.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:196.50 stddev:20.58 (10.5%) stddev-sans-first:20.90 16:10:01 INFO - PROCESS | 2021 | Values: 174.0 197.0 234.0 196.0 207.0 205.0 175.0 175.0 174.0 172.0 16:10:01 INFO - PROCESS | 2021 | 16:10:01 INFO - PROCESS | 2021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 16:10:01 INFO - PROCESS | 2021 | Values: 70.0 71.0 71.0 69.0 69.0 70.0 68.0 70.0 68.0 69.0 16:10:01 INFO - PROCESS | 2021 | -------- Summary: end -------- 16:10:01 INFO - PROCESS | 2021 | 16:10:02 INFO - TEST-INFO | 2021: exit 0 16:10:03 INFO - TEST-OK | kraken | took 60575ms 16:10:03 INFO - SUITE-END | took 1180s 16:10:03 INFO - Completed test suite (00:19:41) 16:10:03 INFO - javascript benchmark 16:10:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.575475188225, 3270.0353395748252, 3284.3102948380847, 3302.702756751895, 3328.151321413039, 5455.072637651599, 5494.340679118512, 5538.335399752031, 5590.077637189869, 5613.186088017235, 5537.667739935597, 5563.415841336652, 5578.86052848679, 5607.691576963276, 5616.269884914956, 5062.974685126569, 5093.974530127344, 5109.565686916598, 5134.691918484884, 5189.714565698885, 5105.157648987913, 5173.991071741012, 5179.404368497633, 5189.221616757498, 5198.324217851674, 5079.771410286546, 5125.205593133071, 5137.049645815518, 5150.484951504838, 5176.016556854186, 5175.948240517603, 5194.740262986836, 5202.817901373433, 5207.6615020023955, 5215.6349055566125, 4986.750662466862, 4988.65079444439, 5036.219385995177, 5143.614228932845, 5160.329157209576, 5381.354237491487, 5452.04589196889, 5484.314460692413, 5497.697626630534, 5519.889602207973, 5962.25471816023, 5973.253343332083, 5993.730282137314, 6006.579539432241, 6010.939890601126, 6060.939335616249, 6106.877862442726, 6122.1735065766, 6123.418275263843, 6141.754329826802, 5630.605857589971, 5655.858603534944, 5665.980123577713, 5693.402192769782, 5734.0, 6278.058082714257, 6301.928672125658, 6312.0531920211415, 6317.210348706411, 6332.366763323631, 5805.535557155417, 5973.0, 6059.0, 6068.0, 6103.755849766048, 4726.787294571753, 6014.6391216527145, 6068.089786532056, 6129.785457509055, 6130.877382452326, 4937.950620493821, 6094.847628809227, 6126.571140020156, 6127.417895299939, 6139.723712432951, 6098.0852872069545, 6098.54260930432, 6115.449609535163, 6118.755249789959, 6126.509879209652, 4051.716379853382, 4707.458642256116, 4719.976400117977, 4748.050389922029, 4794.352762377104, 4317.697761156689, 4340.5225425203835, 4359.9782001090425, 4360.193364227628, 4394.011347446799, 5535.363433205152, 5568.415316391802, 5580.079286917613, 5580.302462192226, 5595.160725891067, 5908.20239267702, 5944.405559444108, 6006.789762358297, 6146.0473626587955, 6171.043488259327, 5556.194351818964, 5568.415316391802, 5589.189567512688, 5594.1888426177975, 5639.43605639441, 5283.630145889828, 5283.9471605284225, 5288.0745869472685, 5291.867703307448, 5294.444083371191, 5872.265966754156, 6279.748810047547, 6301.180846490019, 6306.990881459036, 6325.715342809676, 5622.437756224344, 5722.742476588647, 5734.197212390185, 5771.0189267823735, 5801.013827649394, 5958.523318134626, 6001.639901605743, 6008.519318454601, 6009.2188015557695, 6033.728482218223, 5692.345380281155, 5693.459121383462, 5697.914531281951, 5698.0598201296325, 5713.428657134254, 5747.224124743107, 5753.165790960371, 5757.078867381367, 5758.683272420057, 5761.711914404347, 5855.3559108498885, 5882.264716910387, 5891.587588868738, 5892.911606325994, 5892.911606325994, 5873.2658417697785, 5879.647221166743, 5881.970590147193, 5883.0293001654245, 5909.261342332208, 5639.577031722719, 5721.57088218377, 5722.427757224411, 5731.996900542472, 5802.216700745345, 5967.343592204941, 5968.731407086605, 5972.790952316822, 5976.7908123215475, 5984.820455386345, 5598.160275958476, 5692.943070569241, 5705.37240903492, 5708.5147762439, 5809.215755872903], "value": 5522.085776921453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.63307785316715, 510.3442076931143, 527.1512864288495, 550.5595523581134, 562.5808772464515, 35920.0, 37077.0, 37998.430023549634, 38388.616113838856, 40101.7994910025, 39595.0101247469, 39943.400848987214, 40020.0, 40101.598984010154, 40122.19755604894, 8266.462679925786, 8507.872381914245, 9121.361504694674, 9305.95347023264, 9345.906540934571, 10746.313421644589, 11106.722331941684, 11111.72220694485, 11268.887311126866, 11281.661550153467, 11227.66317010491, 11327.376994265313, 11332.546698132064, 11335.37655428951, 11369.886301137007, 11178.552857885676, 11251.887481125248, 11261.268017578832, 11269.0, 11277.154213434025, 11006.174536909764, 11075.003249707564, 11079.0, 11081.778364432666, 11087.778244435147, 32825.83587082073, 35634.28731425357, 37610.8119459401, 37646.0, 37686.81156594227, 3204.1829333519804, 3217.790843595159, 3343.8328083595966, 3432.433648448003, 3593.838277277529, 28911.42177156445, 28940.565891511644, 29132.563011554845, 29187.854060729773, 29922.401551969055, 3132.201288671374, 3140.7173354397987, 3148.937021259585, 3214.2928555717704, 3242.62709788375, 341255.0, 342064.0, 343508.0, 343702.28148859594, 343825.0, 54263.0, 54546.909061818544, 54607.0, 54619.90760184774, 54621.72689136529, 56915.430845691015, 57063.714681427155, 57200.71399642975, 57212.0, 57237.42762572404, 14865.70268594622, 15374.461893833663, 15417.074975501506, 15419.0, 15425.382984680487, 10831.404272764916, 11041.33751974884, 11045.83431248532, 11859.34773587461, 12037.398130093461, 14395.352209150613, 14750.55748327552, 14750.631234219016, 14802.925985370004, 14942.402303907722, 5793.7392817323325, 5848.535873344835, 5896.646201227854, 5899.351071382144, 5907.202527658797, 834.4450940124871, 855.7133360324236, 918.6037223420363, 959.7696552827272, 1008.641932114089, 22872.428189295402, 28369.148925532267, 28550.85724571364, 28765.85617071943, 29204.0, 849.814508760276, 954.5275088831073, 1005.3867141043958, 1044.8693913260843, 1095.2278643556274, 13877.930610347086, 14439.92780036093, 14646.63383415423, 14932.626684332761, 15011.549653510412, 636256.0, 636268.0, 636327.0, 636399.8140213842, 637653.0, 44383.33424998628, 53598.66003349947, 53811.0, 53885.46114538883, 53996.46003539993, 1195.6711904226406, 1237.0907383073434, 1319.5909268127102, 1341.8725221104175, 1359.5853264754344, 27590.862045689642, 28528.57207141853, 29792.851035744683, 30043.248918777204, 30050.248743780707, 45036.54963450324, 45630.54369456263, 45782.771086144356, 45792.0, 45836.770816145705, 520230.0, 521293.1806022989, 523314.0, 523626.3818680882, 523954.0, 24329.0, 24703.62944555797, 25134.874325628254, 25145.119920802685, 25408.618870717324, 43217.3517397233, 43254.0, 43820.56179438165, 44407.77796110999, 46106.53893461157, 30505.08484745461, 30710.925117620776, 31321.74713011454, 31632.367352653277, 31792.523112153798, 36033.27933441264, 36040.0, 36709.71515996927, 36868.26263474662, 37190.44214336733, 35682.46476302806, 35914.28171436609, 36134.941108245395, 36302.81848590846, 36399.81800090983, 31544.580493877373, 32193.02265346448, 32465.35069298648, 32548.18629534186, 32680.019599412055, 24277.878610607542, 24313.149039783522, 24349.385884052776, 24413.75586244186, 24545.386365341008], "value": 18832.45061776195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.3316302091648, 335.6777493606138, 366.54365315182594, 378.7216395948977, 400.0638505896204, 14480.348384322704, 14709.779353309708, 15438.845611543895, 17614.383496577622, 20129.39611811648, 18756.343527976525, 18882.69552828253, 19784.604307913833, 20003.799962000376, 20016.699749503732, 5426.104692725696, 5774.133879918004, 5775.364709881909, 5777.393373695764, 5780.132980053005, 5417.26866872971, 5690.0, 5703.800366987156, 5759.16492108644, 5768.826935191951, 5699.772009119631, 5710.114932185497, 5710.371859095496, 5716.742746576414, 5718.914216286759, 5494.725263736797, 5593.608447408683, 5642.294713160834, 5655.1517272409055, 5661.1508273758855, 5001.024800163969, 5005.874853128701, 5009.0, 5018.7992480300745, 5018.824341148043, 24619.892104855324, 24772.380690482703, 24888.3777905552, 25147.24558263255, 25221.873890630613, 2169.8372622053253, 2354.458474550846, 2355.3405046586813, 2384.1059602649007, 2679.7990150738774, 11665.300081995107, 15252.38990440381, 15293.694126117527, 15384.615384615474, 15692.293846776922, 1800.5768644368563, 1824.5073830065808, 1833.5507800588807, 1889.2915156816193, 1936.4577918182931, 60957.0, 115671.42164289209, 116516.13225701681, 116848.0, 118363.0, 10328.539939120328, 10374.325668831501, 10420.95790420967, 10483.108935740547, 10711.94644026775, 11152.386618735885, 13299.800502992462, 13332.73334533304, 13387.0, 13434.193948363129, 6740.034384870642, 8118.959405202936, 8282.420230583923, 8379.958100209582, 8415.284700800377, 8266.739873717788, 8314.8337033259, 8334.791630209293, 8474.1949514796, 8539.993101621114, 5505.311836020497, 6291.591046582049, 6299.590526615755, 6444.645544495098, 6565.540412171198, 1771.4508502364051, 1833.3399976008893, 1833.3858157517382, 1836.6602178597002, 1838.237131590375, 737.7344156103799, 821.0721884270736, 912.5254867468879, 922.9861552076724, 930.7161315798611, 20279.391618251477, 21148.47128821792, 21256.36230913075, 21302.57394852094, 21345.252916148173, 891.3510006487945, 921.6589861751061, 932.7388331267256, 959.788846453779, 1042.7862288230895, 10861.1854110942, 11441.052836771301, 11578.710532236593, 11600.419979001017, 11628.76742465146, 558502.0, 570564.0, 573543.0, 587822.0, 588073.0, 117217.41391293159, 121978.34064978064, 122768.0, 124216.0, 126221.0, 992.6575331510618, 999.5601935148511, 1001.4942454060653, 1003.9096481316717, 1031.504877658728, 18757.906210469406, 18988.0, 19176.945268010393, 19204.327848525234, 19252.614947701248, 41509.58490415057, 50082.74958625183, 50983.745081274355, 52228.73885630548, 52473.47526524686, 57817.13274300973, 70884.29115708983, 72522.0, 73250.0, 73738.04536387733, 7445.478816482794, 7636.809079772828, 7931.484453510503, 7976.242256985809, 8188.672453101809, 10645.467726613484, 12659.810102848649, 12873.35633218354, 12895.677608059874, 13209.075364724376, 11047.226694131656, 11216.373625824046, 11368.976792088752, 11425.200235983733, 11467.0, 10855.620053298097, 11018.724531886766, 11365.829512557153, 11372.953371488875, 11512.712182195512, 9011.819763604823, 10283.0, 10342.844857327296, 10530.736731581772, 11429.59996400122, 7727.459077864495, 8055.516668999879, 8196.0, 8293.046299675374, 8435.156484351515, 8361.540115293717, 8878.289736821169, 10673.839892401775, 11308.717282068013, 11411.714707132389], "value": 9388.713702224208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.6236178593565, 1476.2840022589041, 1624.8456396642323, 1790.8298711622392, 1820.0262859370232, 8119.553424561646, 8507.829843403128, 8519.744407667773, 8524.019737730163, 8532.8720069199, 7435.330820226179, 7657.0, 7672.616369181546, 7747.728829490969, 8297.253247207766, 1911.2641632971267, 1942.6988816733428, 2232.475368288459, 2300.804431623314, 2301.091069027733, 2318.8724620145886, 2326.8720220387872, 2332.4751930815514, 2334.5564342774906, 2336.778006089419, 2272.9204477843277, 2291.2438895164555, 2319.675245465636, 2327.3716096653893, 2329.406001469623, 1964.4695932098396, 2146.7334272779135, 2239.1491233331312, 2239.361781892153, 2271.6365381538876, 2196.077647388101, 2197.8021978021893, 2214.579229946305, 2219.2343641443676, 2221.022749990015, 8172.141925097898, 8266.057476493019, 8269.131741167152, 8270.958645206796, 8275.420720549564, 5013.799448022075, 5170.242117679969, 5172.534471897509, 5186.299849520305, 5193.5585475234275, 2825.6326677531997, 3362.0, 3380.492926061086, 3515.6835884770494, 3519.2785478977003, 1052.3896140238644, 1055.1453322808472, 1069.288922866293, 1079.1259080145107, 1084.766775143348, 10860.0, 10878.401687907162, 10976.780464390748, 10980.176486763445, 10984.231103822656, 4186.832526698898, 4347.34789781529, 4446.777661116931, 4458.331250312414, 4468.32975053738, 8652.178043085896, 8664.566771661392, 8684.6526138955, 8686.695965641173, 8686.695965641173, 5104.259882317117, 5104.69371837691, 5105.106606343875, 5118.155504341742, 5133.076046311699, 4175.665946724254, 4667.6265898728025, 4798.880027999328, 4801.4718380978065, 4833.589144922651, 3384.509246159293, 3459.8270086495572, 3472.826358682056, 3473.392156372625, 3559.394902866519, 1139.8290256461432, 1146.0716819376332, 1148.6668866028758, 1153.7577108807245, 1154.8729639739622, 853.423938841292, 869.1916517638531, 869.5999840073637, 899.4783025844994, 916.9862452063225, 5629.971850140805, 5697.430256974352, 5853.0, 5998.940010599838, 6074.0, 826.2604968553111, 877.4121338702956, 896.233720169259, 903.8282726281985, 911.1753862754218, 3738.1962877981364, 3742.251549690073, 3819.809009549567, 3823.4647149399107, 3934.586868378779, 9940.25448091396, 10238.53926573291, 10343.482825858828, 10343.586256549654, 10350.689479315633, 8521.36089793268, 10282.742931426625, 10287.588496460057, 10299.845502317472, 10303.536340864679, 7694.884576731353, 7741.458097933203, 7904.802379940547, 7905.960470197612, 7907.723229686933, 4803.927941080817, 5524.7348587079105, 5556.333240011225, 5604.243427137284, 5681.829545113653, 9306.813863722824, 9474.478903660365, 9491.240700744062, 9497.287703422133, 9506.429614223169, 9408.388454750419, 9438.905610943802, 9495.810083798147, 9524.428534287965, 9659.937406885096, 5687.20379146928, 5733.541316694738, 6820.795376138723, 6837.487188460786, 6853.623050732258, 6993.055937448379, 7244.420446364384, 7248.927510725036, 7784.41616878725, 7891.092524359542, 6875.278095800069, 6908.896366554606, 7100.289971002859, 7107.253738357398, 7128.4653650977425, 6843.520953533205, 6885.9671049341, 6928.7228510859, 6944.965275173794, 6992.195897471653, 5497.36780270274, 6602.60384376939, 6603.141591593062, 6607.933920660732, 6608.240052393844, 4033.878983630496, 4730.101280756645, 4736.19484687597, 4814.0, 4858.611311095033, 4487.012857171417, 4688.156131896291, 4866.489018653132, 4910.165271903857, 4920.114379411741], "value": 4323.19307346035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.31468964037896, 300.3003003003003, 305.19276513621463, 310.8865264178574, 314.0562609358876, 5417.783288668454, 5436.619436639432, 5437.7493176569415, 5473.781048758055, 5479.369872464667, 5000.59995200384, 5118.360204974379, 5197.558207552353, 5207.0, 5383.4616538346145, 4046.6560342370935, 4071.837126514943, 4076.388541718751, 4118.073433477459, 4124.566920473352, 3491.9476207856774, 3737.962620373802, 4084.836606535735, 4105.609967053125, 4139.8965025874295, 3397.2186397128676, 3929.6659783918403, 4050.2102090092444, 4069.4536076291115, 4077.103037331782, 4073.714839961204, 4095.28332541804, 4110.7328023678365, 4111.198316328302, 4115.54728979812, 3273.7068857801273, 3517.26137511123, 3546.414841551141, 3550.6449355064547, 3581.534400527915, 4451.57710017551, 5059.8988020239385, 5113.440400677791, 5185.118529849935, 5269.262303277545, 3872.3997780344093, 4065.3901914712733, 4296.355546667994, 4535.593965870591, 4570.0, 4731.432228132611, 5580.135079062752, 5683.74423150955, 5690.2033715279895, 5701.971490142564, 3474.8436320365645, 3820.617938206185, 3851.2105018471148, 3857.382818749015, 3866.0, 4986.584189829978, 5346.198070289449, 5596.215235973225, 5626.409227031144, 5873.500752436005, 3174.206448387903, 3848.461215429842, 3850.3646898261472, 3879.767213967171, 3898.2788184186015, 3361.8737722863116, 3909.6285852843935, 3916.4712763776524, 3916.941245881314, 3920.941185882214, 3837.769733815924, 4294.57054294568, 4506.81972721094, 4600.182927743523, 4600.309953506934, 5286.867828304246, 5392.191171324333, 5634.577406694514, 5705.942940570541, 5707.771689132472, 1268.796992481217, 1272.4274076665538, 1278.8017857231957, 1281.6350586625401, 1281.7759040116666, 717.8872747241754, 816.7100679258897, 823.4359463767219, 830.8089139497949, 832.9167083291743, 4618.630509559227, 4803.543663351976, 4825.179719447632, 5265.9204863003, 5284.9471505284455, 4890.58430033444, 5846.941530584725, 5850.64896106235, 5862.251576223272, 5880.353161152269, 4230.428892099589, 4291.570842915746, 5080.085584594808, 5234.476552344735, 5282.709450980233, 2490.3276115448725, 2877.8128622246822, 2881.550681920351, 2897.015014894946, 2901.1296611017033, 4612.025243717851, 5678.3186017678145, 5696.914546281809, 5770.826875193751, 5802.506786923074, 5738.77044918207, 6046.274447066292, 6119.44924956756, 6126.816195514141, 6167.907481387782, 5603.215549823028, 6134.0, 6150.7847225346, 6151.2618485781995, 6175.869325082839, 5020.523050310215, 5618.747156378055, 5773.769049237983, 5872.559558033079, 5957.987142185925, 5116.718580478109, 5860.677662728591, 5864.9706751467675, 5888.234529511307, 5897.7935772247765, 5441.347038355423, 5526.640768350045, 5959.582829202088, 6179.783707570214, 6183.629921692778, 3313.3870234006786, 3899.3484430587473, 3909.0877296414355, 3938.369860822255, 3941.7832019239218, 5001.949590585872, 5874.794382196603, 5906.616069955611, 5908.961408314125, 5930.940690593039, 5396.676199428047, 5769.278840144982, 5781.364049954417, 5787.594868359174, 5818.854528636818, 5254.395744489432, 5704.543636508986, 5712.542996560348, 5743.798967036134, 5791.420857914175, 4197.706160568731, 5281.313429254173, 5630.493255607015, 5636.661800291996, 5670.603057785916, 4502.549745025472, 4967.801287948441, 5648.322201335866, 5681.204631351697, 5775.27809023872, 4729.196036673705, 5547.639403438763, 5583.74873130702, 5598.972005139948, 5603.747831347518], "value": 4087.2393630342576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.4603840697001, 663.4839391989302, 669.6250099944028, 754.9169591344954, 773.8645736996026, 13832.585022449317, 14897.851021489781, 14917.32872020759, 15692.979956302832, 15710.0573965562, 11620.302781833096, 13992.860071399284, 14062.367193476319, 14134.434622615083, 14144.929275353634, 646.6572716460261, 664.0139393001389, 786.6184900323339, 823.8105235795756, 839.86562150056, 821.4783612406105, 824.3858325547476, 828.9129641387658, 835.3567752830317, 838.7693384319331, 888.2760550151638, 890.0698769785557, 891.1355984694835, 892.6741739265186, 894.8881389826272, 668.9364510371507, 694.3785312145601, 884.3058199313508, 885.844977129003, 886.4592598514901, 513.8124584526659, 514.8326793792032, 515.9277701121846, 623.392192612204, 642.9614223146626, 14921.701565968728, 15012.12348456443, 15066.020708653903, 15072.698546029018, 15120.773188402183, 11285.0, 13660.316984150852, 13766.0, 14003.369848356848, 14084.2957852107, 11296.362027505966, 11716.88283117175, 12556.497740090386, 12658.81011784824, 13221.272829994346, 4488.730676159441, 4530.161920044769, 4534.183846907556, 4715.669903106784, 4719.07977944301, 111313.88686113116, 111606.44196779045, 112950.0, 113632.0, 115891.8410815898, 10453.738656533495, 10548.683539493828, 10611.151107911348, 10668.466576671135, 10838.187135964834, 20670.483237919172, 20888.0, 21076.78923210779, 21127.0, 21186.894065529574, 7559.886601700979, 7642.541447513167, 7721.305082542598, 7730.7680769577, 7807.141214466405, 4068.4304197412384, 4149.543550209474, 4316.935245971313, 4325.5674432557125, 4339.110482351173, 3464.601570819388, 3468.4103702370658, 3508.7719298245534, 3509.754317197772, 3512.3853325667906, 640.1997503121098, 643.7264162730821, 647.7117682631184, 652.882481153397, 668.4618881800197, 500.25660572903405, 595.627732667083, 599.2210126835097, 605.2676261723276, 637.4613451633362, 8117.756467305991, 9358.407632177074, 10046.799064018678, 10206.285560010876, 10405.739856503647, 600.3006497430532, 604.6372176693949, 653.9084528166061, 654.1528720307214, 663.1809715001968, 4207.179599978036, 4262.147570485915, 4422.646188304992, 4427.0, 4430.158269928703, 111566.0, 113182.0, 113398.43300783444, 113819.0, 114299.71400571942, 98573.7638536873, 99033.64012218332, 99899.0, 100197.4970375445, 102663.48668256612, 88410.55794720985, 88735.9999999987, 89061.0, 89397.55301223452, 90429.0, 8946.507942062988, 9057.501837398742, 9089.181973622406, 9244.768880778034, 9451.905480945377, 51182.74408627933, 51238.48761512486, 52424.73787631038, 52531.73734131305, 52748.0, 52786.457421971674, 75451.0, 78186.04534886673, 79656.60171699336, 80314.59842700748, 12664.74670506603, 12748.553800616934, 12912.483500659868, 13160.0, 13439.865601343861, 14024.78962815579, 14212.21832799206, 14214.687018346425, 14278.42886284537, 14513.854861451251, 13554.322283885569, 13659.317034148055, 13760.65598360049, 13809.585712428643, 14238.0, 12846.293453859753, 13289.800652990407, 13732.244726540137, 13851.792223116863, 13854.792178117135, 13225.470981160646, 13443.0, 13627.250501222528, 13744.518941836988, 13806.792898106738, 11263.49314280843, 11371.0, 11388.37363944991, 11547.942260288644, 11743.471543780379, 11221.214514983873, 11349.14881383883, 11417.828732569184, 11623.941880290544, 11636.94181529087], "value": 7458.553546180135, "unit": "score"}], "name": "dromaeo_css", "value": 7105.455552254208, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 114.0, 155.0, 116.0, 115.0, 126.0, 115.0, 139.0, 117.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 185.0, 183.0, 181.0, 184.0, 184.0, 184.0, 182.0, 186.0, 193.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 87.0, 62.0, 60.0, 58.0, 60.0, 72.0, 49.0], "value": 64.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 85.0, 69.0, 67.0, 68.0, 81.0, 67.0, 69.0, 83.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 87.0, 88.0, 89.0, 86.0, 90.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 93.0, 94.0, 95.0, 95.0, 94.0, 94.0, 123.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 88.0, 86.0, 87.0, 84.0, 87.0, 85.0, 85.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 54.0, 57.0, 55.0, 55.0, 55.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 74.0, 76.0, 72.0, 70.0, 70.0, 72.0, 71.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 88.0, 89.0, 88.0, 89.0, 87.0, 88.0, 98.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 150.0, 146.0, 148.0, 150.0, 150.0, 149.0, 215.0, 173.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 197.0, 234.0, 196.0, 207.0, 205.0, 175.0, 175.0, 174.0, 172.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 69.0, 70.0, 68.0, 70.0, 68.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1465.7, "alertThreshold": 2.0}]} 16:10:03 INFO - Return code: 0 16:10:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:03 INFO - # TBPL SUCCESS # 16:10:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:10:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:10:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:10:03 INFO - 2016-12-03 16:10:03.662 screenresolution[2025:23117] starting screenresolution argv=screenresolution get 16:10:03 INFO - 2016-12-03 16:10:03.665 screenresolution[2025:23117] Display 0: 1600x1200x32@60 16:10:03 INFO - 2016-12-03 16:10:03.671 screenresolution[2026:23121] starting screenresolution argv=screenresolution list 16:10:03 INFO - Available Modes on Display 0 16:10:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:10:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:10:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:10:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:10:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:10:03 INFO - Intel Iris: 16:10:03 INFO - Chipset Model: Intel Iris 16:10:03 INFO - Type: GPU 16:10:03 INFO - Bus: Built-In 16:10:03 INFO - VRAM (Dynamic, Max): 1536 MB 16:10:03 INFO - Vendor: Intel (0x8086) 16:10:03 INFO - Device ID: 0x0a2e 16:10:03 INFO - Revision ID: 0x0009 16:10:03 INFO - Displays: 16:10:03 INFO - Display: 16:10:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:10:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:10:03 INFO - Display Serial Number: 1600x1200 60 16:10:03 INFO - Main Display: Yes 16:10:03 INFO - Mirror: Off 16:10:03 INFO - Online: Yes 16:10:03 INFO - Rotation: Supported 16:10:03 INFO - Return code: 0 16:10:03 INFO - Running post-action listener: _resource_record_post_action 16:10:03 INFO - [mozharness: 2016-12-04 00:10:03.911078Z] Finished run-tests step (success) 16:10:03 INFO - Running post-run listener: _resource_record_post_run 16:10:03 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 30501888; Write bytes: 695855616; Read time: 184; Write time: 1961 16:10:03 INFO - TinderboxPrint: CPU usage
53.6% 16:10:03 INFO - TinderboxPrint: I/O read bytes / time
30,501,888 / 184 16:10:03 INFO - TinderboxPrint: I/O write bytes / time
695,855,616 / 1,961 16:10:03 INFO - TinderboxPrint: CPU idle
2,256.1 (46.4%) 16:10:03 INFO - TinderboxPrint: CPU system
972.7 (20.0%) 16:10:03 INFO - TinderboxPrint: CPU user
1,632.8 (33.6%) 16:10:03 INFO - TinderboxPrint: Swap in / out
409,190,400 / 0 16:10:03 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 383011328; Write bytes: 377587200; Read time: 28897; Write time: 761 16:10:03 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29068288; Write bytes: 307950592; Read time: 176; Write time: 1160 16:10:04 INFO - Running post-run listener: _upload_blobber_files 16:10:04 INFO - Blob upload gear active. 16:10:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:04 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 16:10:04 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'] 16:10:04 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 16:10:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:10:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:05 INFO - (blobuploader) - INFO - Done attempting. 16:10:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:10:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:06 INFO - (blobuploader) - INFO - Done attempting. 16:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:08 INFO - (blobuploader) - INFO - Done attempting. 16:10:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:10:09 INFO - Return code: 0 16:10:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:10:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:10:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88a8335bbb17dd537d265b8b1e311c2183f969173f13c0acf00639ae0d4a9ad31a51fdc9e20c20c282faa6a2c67238f6e24312e5955a3c472bb5d92e276f259a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39472decad91f5b1a9afa7ad410d860aae10a5a9f2a9b1305df79e9b6774e158abd04bbc9999ea6f9a91f843c702af4c74f973f8b98bb4e7fe09952362b8d754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5528630e72627e8c297b2b040179fc5cf4a93d75c9126f3cb3d10952376020042cf9fe5bdc07f13c4cb04a72017c2812c6621b37674004c6badfb293f0989176"} 16:10:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:10:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:10:09 INFO - Contents: 16:10:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88a8335bbb17dd537d265b8b1e311c2183f969173f13c0acf00639ae0d4a9ad31a51fdc9e20c20c282faa6a2c67238f6e24312e5955a3c472bb5d92e276f259a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39472decad91f5b1a9afa7ad410d860aae10a5a9f2a9b1305df79e9b6774e158abd04bbc9999ea6f9a91f843c702af4c74f973f8b98bb4e7fe09952362b8d754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5528630e72627e8c297b2b040179fc5cf4a93d75c9126f3cb3d10952376020042cf9fe5bdc07f13c4cb04a72017c2812c6621b37674004c6badfb293f0989176"} 16:10:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:10:09 INFO - Copying logs to upload dir... 16:10:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:10:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.486120 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-12-03 16:10:09.071332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 16:10:09.074750) ========= 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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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/88a8335bbb17dd537d265b8b1e311c2183f969173f13c0acf00639ae0d4a9ad31a51fdc9e20c20c282faa6a2c67238f6e24312e5955a3c472bb5d92e276f259a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39472decad91f5b1a9afa7ad410d860aae10a5a9f2a9b1305df79e9b6774e158abd04bbc9999ea6f9a91f843c702af4c74f973f8b98bb4e7fe09952362b8d754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5528630e72627e8c297b2b040179fc5cf4a93d75c9126f3cb3d10952376020042cf9fe5bdc07f13c4cb04a72017c2812c6621b37674004c6badfb293f0989176"} build_url:https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/JnL-HO73SSq_j56UfID1JQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88a8335bbb17dd537d265b8b1e311c2183f969173f13c0acf00639ae0d4a9ad31a51fdc9e20c20c282faa6a2c67238f6e24312e5955a3c472bb5d92e276f259a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39472decad91f5b1a9afa7ad410d860aae10a5a9f2a9b1305df79e9b6774e158abd04bbc9999ea6f9a91f843c702af4c74f973f8b98bb4e7fe09952362b8d754", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5528630e72627e8c297b2b040179fc5cf4a93d75c9126f3cb3d10952376020042cf9fe5bdc07f13c4cb04a72017c2812c6621b37674004c6badfb293f0989176"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 16:10:09.108989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 16:10:09.109309) ========= 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.vjKO7kHpOC/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.e5gQIeVe2f/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 16:10:09.158094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 16:10:09.158416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 16:10:09.158803) ========= ========= Total master_lag: 0.19 =========