builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0388 starttime: 1480871866.02 results: success (0) buildid: 20161204070438 builduid: 1f5dd6ff26684cb2855443bc582aabbb revision: 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:46.020518) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:46.020881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:46.021155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:46.493110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 09:17:46.493418) ========= 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.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-04 09:17: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% 55.6M=0s 2016-12-04 09:17:47 (55.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.592555 ========= master_lag: 1.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-04 09:17:48.147857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:48.148140) ========= 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.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.026217 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:48.420350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-04 09:17:48.420656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 --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 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-04 09:17:48,525 truncating revision to first 12 chars 2016-12-04 09:17:48,525 Setting DEBUG logging. 2016-12-04 09:17:48,526 attempt 1/10 2016-12-04 09:17:48,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/12637ae351d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 09:17:49,753 unpacking tar archive at: mozilla-central-12637ae351d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499382 ========= master_lag: 3.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-04 09:17:53.131047) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:53.131379) ========= script_repo_revision: 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 09:17:53.131749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-12-04 09:17:53.132037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-12-04 09:17:54.221080) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-04 09:17:54.225470) ========= /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.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:17:54 INFO - MultiFileLogger online at 20161204 09:17:54 in /builds/slave/test 09:17:54 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 09:17:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:54 INFO - {'append_to_log': False, 09:17:54 INFO - 'base_work_dir': '/builds/slave/test', 09:17:54 INFO - 'blob_upload_branch': 'Firefox', 09:17:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:54 INFO - 'branch': 'Firefox', 09:17:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:54 INFO - 'config_files': ('talos/mac_config.py',), 09:17:54 INFO - 'default_actions': ('clobber', 09:17:54 INFO - 'read-buildbot-config', 09:17:54 INFO - 'download-and-extract', 09:17:54 INFO - 'populate-webroot', 09:17:54 INFO - 'create-virtualenv', 09:17:54 INFO - 'install', 09:17:54 INFO - 'run-tests'), 09:17:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:54 INFO - 'download_minidump_stackwalk': True, 09:17:54 INFO - 'download_symbols': 'ondemand', 09:17:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:54 INFO - 'installer_path': 'installer.exe', 09:17:54 INFO - 'log_level': 'info', 09:17:54 INFO - 'log_name': 'talos', 09:17:54 INFO - 'log_to_console': True, 09:17:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:54 INFO - 'opt_config_files': (), 09:17:54 INFO - 'pip_index': False, 09:17:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:54 INFO - 'cmd': ('bash', 09:17:54 INFO - '-c', 09:17:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:54 INFO - 'enabled': True, 09:17:54 INFO - 'halt_on_failure': False, 09:17:54 INFO - 'name': 'check_screen_resolution'},), 09:17:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:54 INFO - 'cmd': ('bash', 09:17:54 INFO - '-c', 09:17:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:54 INFO - 'enabled': True, 09:17:54 INFO - 'halt_on_failure': False, 09:17:54 INFO - 'name': 'check_screen_resolution'},), 09:17:54 INFO - 'run_cmd_checks_enabled': True, 09:17:54 INFO - 'sps_profile': False, 09:17:54 INFO - 'sps_profile_interval': 0, 09:17:54 INFO - 'suite': 'dromaeojs', 09:17:54 INFO - 'system_bits': '32', 09:17:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:54 INFO - 'title': 't-yosemite-r7-0388', 09:17:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:54 INFO - 'use_talos_json': True, 09:17:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:54 INFO - 'work_dir': 'build'} 09:17:54 INFO - [mozharness: 2016-12-04 17:17:54.426960Z] Running clobber step. 09:17:54 INFO - Running pre-action listener: _resource_record_pre_action 09:17:54 INFO - Running main action method: clobber 09:17:54 INFO - rmtree: /builds/slave/test/build 09:17:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:57 INFO - Running post-action listener: _resource_record_post_action 09:17:57 INFO - [mozharness: 2016-12-04 17:17:57.308253Z] Finished clobber step (success) 09:17:57 INFO - [mozharness: 2016-12-04 17:17:57.308382Z] Running read-buildbot-config step. 09:17:57 INFO - Running pre-action listener: _resource_record_pre_action 09:17:57 INFO - Running main action method: read_buildbot_config 09:17:57 INFO - Using buildbot properties: 09:17:57 INFO - { 09:17:57 INFO - "project": "", 09:17:57 INFO - "product": "firefox", 09:17:57 INFO - "script_repo_revision": "production", 09:17:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:17:57 INFO - "repository": "", 09:17:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:17:57 INFO - "buildid": "20161204070438", 09:17:57 INFO - "pgo_build": "False", 09:17:57 INFO - "basedir": "/builds/slave/test", 09:17:57 INFO - "buildnumber": 31, 09:17:57 INFO - "slavename": "t-yosemite-r7-0388", 09:17:57 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:17:57 INFO - "platform": "yosemite_r7", 09:17:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:17:57 INFO - "branch": "mozilla-central", 09:17:57 INFO - "repo_path": "mozilla-central", 09:17:57 INFO - "revision": "12637ae351d64ecbf6b74cdbf26d7eb24ac0f659", 09:17:57 INFO - "stage_platform": "macosx64", 09:17:57 INFO - "builduid": "1f5dd6ff26684cb2855443bc582aabbb", 09:17:57 INFO - "slavebuilddir": "test" 09:17:57 INFO - } 09:17:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:17:57 INFO - Running post-action listener: _resource_record_post_action 09:17:57 INFO - [mozharness: 2016-12-04 17:17:57.311695Z] Finished read-buildbot-config step (success) 09:17:57 INFO - [mozharness: 2016-12-04 17:17:57.311822Z] Running download-and-extract step. 09:17:57 INFO - Running pre-action listener: _resource_record_pre_action 09:17:57 INFO - Running main action method: download_and_extract 09:17:57 INFO - mkdir: /builds/slave/test/build/tests 09:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:57 INFO - trying https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:17:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/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 09:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/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 09:17:58 INFO - Downloaded 1199 bytes. 09:17:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:17:58 INFO - Using the following test package requirements: 09:17:58 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:17:58 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:58 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:17:58 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'jsshell-mac.zip'], 09:17:58 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:17:58 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:17:58 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:17:58 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:17:58 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:17:58 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:17:58 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:17:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:58 INFO - Fetch https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:17:59 INFO - Expected file size: 16283889 09:17:59 INFO - Obtained file size: 16283889 09:18:06 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 09:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:18:07 INFO - Expected file size: 16283889 09:18:07 INFO - Obtained file size: 16283889 09:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:18:14 INFO - Expected file size: 14409734 09:18:14 INFO - Obtained file size: 14409734 09:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:14 INFO - trying https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:18:14 INFO - Downloading https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/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 09:18:17 INFO - Downloaded 107576511 bytes. 09:18:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:18:17 INFO - mkdir: /builds/slave/test/properties 09:18:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:17 INFO - Contents: 09:18:17 INFO - build_url:https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:18:18 INFO - Running post-action listener: _resource_record_post_action 09:18:18 INFO - Running post-action listener: set_extra_try_arguments 09:18:18 INFO - [mozharness: 2016-12-04 17:18:18.315081Z] Finished download-and-extract step (success) 09:18:18 INFO - [mozharness: 2016-12-04 17:18:18.315235Z] Running populate-webroot step. 09:18:18 INFO - Running pre-action listener: _resource_record_pre_action 09:18:18 INFO - Running main action method: populate_webroot 09:18:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:18 INFO - '--tppagecycles', 09:18:18 INFO - '7'], 09:18:18 INFO - 'tests': ['tsvgm']}}, 09:18:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['damp', 'tps']}, 09:18:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'tests': ['damp', 'tps']}, 09:18:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['dromaeo_dom']}, 09:18:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['basic_compositor_video']}, 09:18:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['a11yr', 09:18:18 INFO - 'ts_paint', 09:18:18 INFO - 'tpaint', 09:18:18 INFO - 'sessionrestore', 09:18:18 INFO - 'sessionrestore_no_auto_restore', 09:18:18 INFO - 'tabpaint']}, 09:18:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['tsvgx', 09:18:18 INFO - 'tsvgr_opacity', 09:18:18 INFO - 'tart', 09:18:18 INFO - 'tscrollx', 09:18:18 INFO - 'cart', 09:18:18 INFO - 'tsvg_static']}, 09:18:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:18 INFO - 'tsvgr_opacity', 09:18:18 INFO - 'tart', 09:18:18 INFO - 'tscrollx', 09:18:18 INFO - 'cart', 09:18:18 INFO - 'tsvg_static']}, 09:18:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'talos_options': ['--disable-e10s'], 09:18:18 INFO - 'tests': ['tp5o']}, 09:18:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:18:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'talos_options': ['--disable-e10s', 09:18:18 INFO - '--xperf_path', 09:18:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:18 INFO - 'tests': ['tp5n']}, 09:18:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:18:18 INFO - 'talos_options': ['--xperf_path', 09:18:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:18 INFO - 'tests': ['tp5n']}}, 09:18:18 INFO - 'talos.zip': {'path': '', 09:18:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:18 INFO - Running post-action listener: _resource_record_post_action 09:18:18 INFO - [mozharness: 2016-12-04 17:18:18.333331Z] Finished populate-webroot step (success) 09:18:18 INFO - [mozharness: 2016-12-04 17:18:18.333437Z] Running create-virtualenv step. 09:18:18 INFO - Running pre-action listener: _resource_record_pre_action 09:18:18 INFO - Running main action method: create_virtualenv 09:18:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:18 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 09:18:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:18 INFO - Using real prefix '/tools/python27' 09:18:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:22 INFO - Installing pip.................done. 09:18:22 INFO - Return code: 0 09:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:22 INFO - Reading from file tmpfile_stdout 09:18:22 INFO - Output received: 09:18:22 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) 09:18:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:22 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')]} 09:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:22 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')]} 09:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:22 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:22 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 09:18:22 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 09:18:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:22 INFO - 'HOME': '/Users/cltbld', 09:18:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:22 INFO - 'LOGNAME': 'cltbld', 09:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:22 INFO - 'MOZ_NO_REMOTE': '1', 09:18:22 INFO - 'NO_EM_RESTART': '1', 09:18:22 INFO - 'PAGER': '/bin/cat', 09:18:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:22 INFO - 'PWD': '/builds/slave/test', 09:18:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:22 INFO - 'SHELL': '/bin/bash', 09:18:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:22 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:22 INFO - 'USER': 'cltbld', 09:18:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:22 INFO - 'XPC_FLAGS': '0x0', 09:18:22 INFO - 'XPC_SERVICE_NAME': '0', 09:18:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:22 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 09:18:22 INFO - Cleaning up... 09:18:22 INFO - Return code: 0 09:18:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:22 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')]} 09:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:22 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')]} 09:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:22 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:22 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 09:18:22 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 09:18:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:22 INFO - 'HOME': '/Users/cltbld', 09:18:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:22 INFO - 'LOGNAME': 'cltbld', 09:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:22 INFO - 'MOZ_NO_REMOTE': '1', 09:18:22 INFO - 'NO_EM_RESTART': '1', 09:18:22 INFO - 'PAGER': '/bin/cat', 09:18:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:22 INFO - 'PWD': '/builds/slave/test', 09:18:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:22 INFO - 'SHELL': '/bin/bash', 09:18:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:22 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:22 INFO - 'USER': 'cltbld', 09:18:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:22 INFO - 'XPC_FLAGS': '0x0', 09:18:22 INFO - 'XPC_SERVICE_NAME': '0', 09:18:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:22 INFO - Downloading/unpacking psutil>=3.1.1 09:18:22 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 09:18:22 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 09:18:22 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 09:18:22 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 09:18:22 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 09:18:22 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 09:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:26 INFO - Installing collected packages: psutil 09:18:26 INFO - Running setup.py install for psutil 09:18:26 INFO - building 'psutil._psutil_osx' extension 09:18:26 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 09:18:27 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 09:18:27 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 09:18:27 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 09:18:27 INFO - building 'psutil._psutil_posix' extension 09:18:27 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 09:18:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:18:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:18:27 INFO - ^ 09:18:27 INFO - 1 warning generated. 09:18:27 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 09:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:27 INFO - Successfully installed psutil 09:18:27 INFO - Cleaning up... 09:18:28 INFO - Return code: 0 09:18:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:28 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:28 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 09:18:28 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 09:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:28 INFO - 'HOME': '/Users/cltbld', 09:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:28 INFO - 'LOGNAME': 'cltbld', 09:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:28 INFO - 'MOZ_NO_REMOTE': '1', 09:18:28 INFO - 'NO_EM_RESTART': '1', 09:18:28 INFO - 'PAGER': '/bin/cat', 09:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:28 INFO - 'PWD': '/builds/slave/test', 09:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:28 INFO - 'SHELL': '/bin/bash', 09:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:28 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:28 INFO - 'USER': 'cltbld', 09:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:28 INFO - 'XPC_FLAGS': '0x0', 09:18:28 INFO - 'XPC_SERVICE_NAME': '0', 09:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:30 INFO - Installing collected packages: mozsystemmonitor 09:18:30 INFO - Running setup.py install for mozsystemmonitor 09:18:31 INFO - Successfully installed mozsystemmonitor 09:18:31 INFO - Cleaning up... 09:18:31 INFO - Return code: 0 09:18:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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', '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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18: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 jsonschema==2.5.1 09:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:31 INFO - 'HOME': '/Users/cltbld', 09:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:31 INFO - 'LOGNAME': 'cltbld', 09:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:31 INFO - 'MOZ_NO_REMOTE': '1', 09:18:31 INFO - 'NO_EM_RESTART': '1', 09:18:31 INFO - 'PAGER': '/bin/cat', 09:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:31 INFO - 'PWD': '/builds/slave/test', 09:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:31 INFO - 'SHELL': '/bin/bash', 09:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:31 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:31 INFO - 'USER': 'cltbld', 09:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:31 INFO - 'XPC_FLAGS': '0x0', 09:18:31 INFO - 'XPC_SERVICE_NAME': '0', 09:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:31 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 09:18:31 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 09:18:31 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 09:18:31 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 09:18:31 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 09:18:31 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 09:18:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 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 09:18:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:34 INFO - warning: no files found matching '*.txt' 09:18:34 INFO - no previously-included directories found matching 'build' 09:18:34 INFO - no previously-included directories found matching 'dist' 09:18:34 INFO - no previously-included directories found matching '.git*' 09:18:34 INFO - Installing collected packages: jsonschema, functools32 09:18:34 INFO - Running setup.py install for functools32 09:18:34 INFO - warning: no files found matching '*.txt' 09:18:34 INFO - no previously-included directories found matching 'build' 09:18:34 INFO - no previously-included directories found matching 'dist' 09:18:34 INFO - no previously-included directories found matching '.git*' 09:18:34 INFO - Successfully installed jsonschema functools32 09:18:34 INFO - Cleaning up... 09:18:34 INFO - Return code: 0 09:18:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:34 INFO - 'HOME': '/Users/cltbld', 09:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:34 INFO - 'LOGNAME': 'cltbld', 09:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:34 INFO - 'MOZ_NO_REMOTE': '1', 09:18:34 INFO - 'NO_EM_RESTART': '1', 09:18:34 INFO - 'PAGER': '/bin/cat', 09:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:34 INFO - 'PWD': '/builds/slave/test', 09:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:34 INFO - 'SHELL': '/bin/bash', 09:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:34 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:34 INFO - 'USER': 'cltbld', 09:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:34 INFO - 'XPC_FLAGS': '0x0', 09:18:34 INFO - 'XPC_SERVICE_NAME': '0', 09:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:35 INFO - Cleaning up... 09:18:35 INFO - Return code: 0 09:18:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:35 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')]} 09:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:35 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')]} 09:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:35 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:35 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 09:18:35 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 09:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:35 INFO - 'HOME': '/Users/cltbld', 09:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:35 INFO - 'LOGNAME': 'cltbld', 09:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:35 INFO - 'MOZ_NO_REMOTE': '1', 09:18:35 INFO - 'NO_EM_RESTART': '1', 09:18:35 INFO - 'PAGER': '/bin/cat', 09:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:35 INFO - 'PWD': '/builds/slave/test', 09:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:35 INFO - 'SHELL': '/bin/bash', 09:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:35 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:35 INFO - 'USER': 'cltbld', 09:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:35 INFO - 'XPC_FLAGS': '0x0', 09:18:35 INFO - 'XPC_SERVICE_NAME': '0', 09:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:39 INFO - Downloading docopt-0.6.1.tar.gz 09:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:39 INFO - Running setup.py install for blobuploader 09:18:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:39 INFO - Running setup.py install for requests 09:18:39 INFO - Running setup.py install for docopt 09:18:40 INFO - Successfully installed blobuploader requests docopt 09:18:40 INFO - Cleaning up... 09:18:40 INFO - Return code: 0 09:18:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:40 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')]} 09:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:40 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')]} 09:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:40 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:40 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 09:18:40 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 09:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:40 INFO - 'HOME': '/Users/cltbld', 09:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:40 INFO - 'LOGNAME': 'cltbld', 09:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:40 INFO - 'MOZ_NO_REMOTE': '1', 09:18:40 INFO - 'NO_EM_RESTART': '1', 09:18:40 INFO - 'PAGER': '/bin/cat', 09:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:40 INFO - 'PWD': '/builds/slave/test', 09:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:40 INFO - 'SHELL': '/bin/bash', 09:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:40 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:40 INFO - 'USER': 'cltbld', 09:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:40 INFO - 'XPC_FLAGS': '0x0', 09:18:40 INFO - 'XPC_SERVICE_NAME': '0', 09:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-lFXy5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-c3zyP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-KGnWGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-49b3Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-LAwCEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:40 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ytnVAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-buahMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-0RxUXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-9O5sa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-YFiGey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-tupcJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-4tiDyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-AUPVIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-jLGHKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ffjvMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:41 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ymLSIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:42 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-uHrgbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:42 INFO - Running setup.py install for manifestparser 09:18:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:42 INFO - Running setup.py install for mozcrash 09:18:42 INFO - Running setup.py install for mozdebug 09:18:42 INFO - Running setup.py install for mozdevice 09:18:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:42 INFO - Running setup.py install for mozfile 09:18:42 INFO - Running setup.py install for mozhttpd 09:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozinfo 09:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozInstall 09:18:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozleak 09:18:43 INFO - Running setup.py install for mozlog 09:18:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for moznetwork 09:18:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:43 INFO - Running setup.py install for mozprocess 09:18:43 INFO - Running setup.py install for mozprofile 09:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozrunner 09:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Running setup.py install for mozscreenshot 09:18:44 INFO - Running setup.py install for moztest 09:18:44 INFO - Running setup.py install for mozversion 09:18:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:44 INFO - Cleaning up... 09:18:44 INFO - Return code: 0 09:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:44 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')]} 09:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 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')]} 09:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:44 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:44 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 09:18:44 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 09:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:44 INFO - 'HOME': '/Users/cltbld', 09:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:44 INFO - 'LOGNAME': 'cltbld', 09:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:44 INFO - 'MOZ_NO_REMOTE': '1', 09:18:44 INFO - 'NO_EM_RESTART': '1', 09:18:44 INFO - 'PAGER': '/bin/cat', 09:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:44 INFO - 'PWD': '/builds/slave/test', 09:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:44 INFO - 'SHELL': '/bin/bash', 09:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:44 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:44 INFO - 'USER': 'cltbld', 09:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:44 INFO - 'XPC_FLAGS': '0x0', 09:18:44 INFO - 'XPC_SERVICE_NAME': '0', 09:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-pjLkE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-29U7R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-gCjp0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-LnvdEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-RSWpan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-FAv8MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-GQZaTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-654Uby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-5rrDmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:45 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)) 09:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:45 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-MOXPja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-tz7m7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-pxrV2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-GkRh4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-gMo3xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-xBcWj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-0PhPe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:46 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)) 09:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:46 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-uTivUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:46 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)) 09:18:46 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)) 09:18:46 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)) 09:18:46 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)) 09:18:46 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)) 09:18:46 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)) 09:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:46 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 09:18:46 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 09:18:46 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 09:18:46 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 09:18:46 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 09:18:46 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 09:18:49 INFO - Downloading blessings-1.6.tar.gz 09:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:49 INFO - Installing collected packages: blessings 09:18:49 INFO - Running setup.py install for blessings 09:18:49 INFO - Successfully installed blessings 09:18:49 INFO - Cleaning up... 09:18:49 INFO - Return code: 0 09:18:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:50 INFO - Reading from file tmpfile_stdout 09:18:50 INFO - Current package versions: 09:18:50 INFO - blessings == 1.6 09:18:50 INFO - blobuploader == 1.2.4 09:18:50 INFO - docopt == 0.6.1 09:18:50 INFO - functools32 == 3.2.3-2 09:18:50 INFO - jsonschema == 2.5.1 09:18:50 INFO - manifestparser == 1.1 09:18:50 INFO - mozInstall == 1.12 09:18:50 INFO - mozcrash == 1.0 09:18:50 INFO - mozdebug == 0.1 09:18:50 INFO - mozdevice == 0.49 09:18:50 INFO - mozfile == 1.2 09:18:50 INFO - mozhttpd == 0.7 09:18:50 INFO - mozinfo == 0.9 09:18:50 INFO - mozleak == 0.1 09:18:50 INFO - mozlog == 3.4 09:18:50 INFO - moznetwork == 0.27 09:18:50 INFO - mozprocess == 0.23 09:18:50 INFO - mozprofile == 0.28 09:18:50 INFO - mozrunner == 6.13 09:18:50 INFO - mozscreenshot == 0.1 09:18:50 INFO - mozsystemmonitor == 0.3 09:18:50 INFO - moztest == 0.7 09:18:50 INFO - mozversion == 1.4 09:18:50 INFO - psutil == 3.1.1 09:18:50 INFO - requests == 1.2.3 09:18:50 INFO - wsgiref == 0.1.2 09:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 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 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:50 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 09:18:50 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 09:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:50 INFO - 'HOME': '/Users/cltbld', 09:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:50 INFO - 'LOGNAME': 'cltbld', 09:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:50 INFO - 'MOZ_NO_REMOTE': '1', 09:18:50 INFO - 'NO_EM_RESTART': '1', 09:18:50 INFO - 'PAGER': '/bin/cat', 09:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:50 INFO - 'PWD': '/builds/slave/test', 09:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:50 INFO - 'SHELL': '/bin/bash', 09:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:50 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:50 INFO - 'USER': 'cltbld', 09:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:50 INFO - 'XPC_FLAGS': '0x0', 09:18:50 INFO - 'XPC_SERVICE_NAME': '0', 09:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 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)) 09:18:50 INFO - Cleaning up... 09:18:50 INFO - Return code: 0 09:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10565c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876bd89c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, '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.X9uymO7y8P/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.8AkaYopI5y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 09:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:50 INFO - 'HOME': '/Users/cltbld', 09:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:50 INFO - 'LOGNAME': 'cltbld', 09:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:50 INFO - 'MOZ_NO_REMOTE': '1', 09:18:50 INFO - 'NO_EM_RESTART': '1', 09:18:50 INFO - 'PAGER': '/bin/cat', 09:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:50 INFO - 'PWD': '/builds/slave/test', 09:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:50 INFO - 'SHELL': '/bin/bash', 09:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:18:50 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:50 INFO - 'USER': 'cltbld', 09:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:50 INFO - 'XPC_FLAGS': '0x0', 09:18:50 INFO - 'XPC_SERVICE_NAME': '0', 09:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:50 INFO - Cleaning up... 09:18:50 INFO - Return code: 0 09:18:50 INFO - Running post-action listener: _resource_record_post_action 09:18:50 INFO - Running post-action listener: _start_resource_monitoring 09:18:50 INFO - Starting resource monitoring. 09:18:50 INFO - [mozharness: 2016-12-04 17:18:50.629212Z] Finished create-virtualenv step (success) 09:18:50 INFO - [mozharness: 2016-12-04 17:18:50.630211Z] Running install step. 09:18:50 INFO - Running pre-action listener: _resource_record_pre_action 09:18:50 INFO - Running main action method: install 09:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:50 INFO - Reading from file tmpfile_stdout 09:18:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:50 INFO - Reading from file tmpfile_stdout 09:18:50 INFO - Output received: 09:18:50 INFO - Usage: mozinstall [options] installer 09:18:50 INFO - Options: 09:18:50 INFO - -h, --help show this help message and exit 09:18:50 INFO - -d DEST, --destination=DEST 09:18:50 INFO - Directory to install application into. [default: 09:18:50 INFO - "/builds/slave/test"] 09:18:50 INFO - --app=APP Application being installed. [default: firefox] 09:18:50 INFO - mkdir: /builds/slave/test/build/application 09:18:50 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'] 09:18:50 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 09:19:24 INFO - Reading from file tmpfile_stdout 09:19:24 INFO - Output received: 09:19:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:19:24 INFO - Running post-action listener: _resource_record_post_action 09:19:24 INFO - [mozharness: 2016-12-04 17:19:24.228316Z] Finished install step (success) 09:19:24 INFO - [mozharness: 2016-12-04 17:19:24.228449Z] Running run-tests step. 09:19:24 INFO - Running pre-action listener: _resource_record_pre_action 09:19:24 INFO - Running main action method: run_tests 09:19:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:24 INFO - 2016-12-04 09:19:24.242 screenresolution[1635:8598] starting screenresolution argv=screenresolution get 09:19:24 INFO - 2016-12-04 09:19:24.245 screenresolution[1635:8598] Display 0: 1600x1200x32@60 09:19:24 INFO - 2016-12-04 09:19:24.251 screenresolution[1636:8600] starting screenresolution argv=screenresolution list 09:19:24 INFO - Available Modes on Display 0 09:19:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:24 INFO - Intel Iris: 09:19:24 INFO - Chipset Model: Intel Iris 09:19:24 INFO - Type: GPU 09:19:24 INFO - Bus: Built-In 09:19:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:24 INFO - Vendor: Intel (0x8086) 09:19:24 INFO - Device ID: 0x0a2e 09:19:24 INFO - Revision ID: 0x0009 09:19:24 INFO - Displays: 09:19:24 INFO - Display: 09:19:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:24 INFO - Display Serial Number: 1600x1200 60 09:19:24 INFO - Main Display: Yes 09:19:24 INFO - Mirror: Off 09:19:24 INFO - Online: Yes 09:19:24 INFO - Rotation: Supported 09:19:24 INFO - Return code: 0 09:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:24 INFO - Python 2.7.3 09:19:24 INFO - Return code: 0 09:19:24 INFO - grabbing minidump binary from tooltool 09:19:24 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')]} 09:19:24 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 0x105471d30>, '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 0x1052d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105469b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:24 INFO - Return code: 0 09:19:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:24 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/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 09:19:24 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/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0388 --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 09:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9uymO7y8P/Render', 09:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:24 INFO - 'HOME': '/Users/cltbld', 09:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PAGER': '/bin/cat', 09:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8AkaYopI5y/Listeners', 09:19:24 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 09:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - 'XPC_FLAGS': '0x0', 09:19:24 INFO - 'XPC_SERVICE_NAME': '0', 09:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:24 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/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 09:19:24 INFO - mozversion application_buildid: 20161204070438 09:19:24 INFO - mozversion application_changeset: 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 09:19:24 INFO - mozversion application_display_name: Nightly 09:19:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:24 INFO - mozversion application_name: Firefox 09:19:24 INFO - mozversion application_remotingname: firefox 09:19:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:19:24 INFO - mozversion application_vendor: Mozilla 09:19:24 INFO - mozversion application_version: 53.0a1 09:19:24 INFO - mozversion platform_buildid: 20161204070438 09:19:24 INFO - mozversion platform_changeset: 12637ae351d64ecbf6b74cdbf26d7eb24ac0f659 09:19:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:19:24 INFO - mozversion platform_version: 53.0a1 09:19:24 INFO - using testdate: 1480871964 09:19:24 INFO - actual date: 1480871964 09:19:24 INFO - starting webserver on 'localhost:49245' 09:19:24 INFO - SUITE-START | Running 2 tests 09:19:24 INFO - TEST-START | dromaeo_css 09:19:24 INFO - operating with platform_type : mac_ 09:19:24 INFO - Initialising browser for dromaeo_css test... 09:19:24 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmp3fqB8I/profile http://localhost:49245/getInfo.html) 09:19:27 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:19:27 INFO - PROCESS | 1646 | colorDepth:24 09:19:27 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:19:27 INFO - PROCESS | 1646 | __metrics 09:19:27 INFO - PROCESS | 1646 | 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" 09:19:27 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:28 INFO - TEST-INFO | 1646: exit 0 09:19:28 INFO - Browser initialized. 09:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:28 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmp3fqB8I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:40 INFO - PROCESS | 1649 | RSS: Main: 242688000 09:19:40 INFO - PROCESS | 1649 | 09:20:31 INFO - PROCESS | 1649 | 1480872031876 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] 09:22:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 09:22:47 INFO - PROCESS | 1649 | RSS: Main: 480124928 09:22:47 INFO - PROCESS | 1649 | 09:25:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 09:25:51 INFO - PROCESS | 1649 | RSS: Main: 370814976 09:25:51 INFO - PROCESS | 1649 | 09:28:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 09:28:54 INFO - PROCESS | 1649 | RSS: Main: 344154112 09:28:54 INFO - PROCESS | 1649 | 09:31:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 09:31:57 INFO - PROCESS | 1649 | RSS: Main: 348782592 09:31:57 INFO - PROCESS | 1649 | 09:35:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 09:35:01 INFO - PROCESS | 1649 | RSS: Main: 336650240 09:35:01 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 09:38:04 INFO - PROCESS | 1649 | RSS: Main: 454885376 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | __start_tp_report 09:38:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 09:38:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 09:38:04 INFO - PROCESS | 1649 | |i|pagename|runs| 09:38:04 INFO - PROCESS | 1649 | |0;dojo.html;3304.0583433721395;3333.59996800384;3337.5160601712737;3355.697987181153;3382.2389962258494;5535.806246781363;5571.498565129137;5600.6079574429805;5665.291838520185;5711.543076553871;5585.357683866357;5595.104783234683;5647.548196144309;5658.688772117532;5690.57320700947;4201.558836322188;5171.50870667286;5191.091558977183;5211.843644690646;5214.478552144793;5088.669236499634;5185.299984502081;5224.973875130638;5239.240310155025;5248.239005344242;5198.350206224222;5201.713905735183;5214.556762675177;5226.137687281613;5266.631335806495;5058.519440653132;5097.847064588032;5134.306868572732;5145;5186.507281808223;4201.243776120297;5090.33825602673;5138.997895410396;5163.896722065575;5203.60972927032;5526.778928842841;5590.357108932484;5591.329040515124;5593.496585307301;5603.299587551556;5878.118282257653;6106.48094911933;6115.143879856823;6119.479844213247;6121.755129794803;6056.757729690807;6103.943827031755;6107.522607572277;6157.907631385533;6169.290531588835;5678.034734095172;5678.971605141948;5686.3744988051285;5694.544436445157;5728.226689396962;6258.843528911722;6292.779752708725;6307.905381419282;6310.9368906311265;6311.715972781144;5796.275465566804;5837.970810145922;5848.561357898175;5909.940900591025;5911.940880591225;6044.727987240584;6119.357467465941;6130.325664176937;6135.263768347827;6139;5979.133025711248;5984.31180414258;5984.760609575568;5991.5206783457215;6001.339852616209;6031.487323577458;6035.818925432244;6040.546958978094;6045.758169673164;6046.576739628272;4809.927851082237;4818;4825.831095911626;4826.903461930812;4828.03439312139;4306.1172459645695;4308.612224899712;4313.396124542566;4376.168527979674;4399.274119770202;5327.147656374961;5689.886202276014;5709.714514274269;5711.029125048752;5718.857028574319;6198.380161983766;6210.7515699372425;6212.968935155295;6223.439890409885;6234.906476402857;5550.139728342033;5615.522680572116;5685.346185188756;5698.487136157766;5698.601097923106;4440.289553671397;5238.345206849144;5266.131088370453;5288.338957630296;5312.963972025418;6291.779787707408;6292.2134733158355;6299.874002520016;6305.117283580303;6319.431251187231;6037.818865434044;6174.44430001302;6195.96902015487;6203.06953956892;6207.534434917309;6179.752809887555;6193.349698281796;6219.626822390671;6241.563090583797;6308.526860485574;6099.542534309856;6099.993501072451;6105.429421494235;6107.083937409424;6141.416565426277;6107.603005804608;6120.510359171167;6129.816105516842;6130.47890929276;6132.908006379818;5760.711964401679;5808.5062769665055;5831.970840145772;5850.970745146417;5871.354151043467;5825.213596164633;5853.707314634336;5856.677882716492;5865.882682346414;5867.20792692998;5717.914231286617;5733.942660573341;5738.655680659173;5738.913916291175;5739;5802.564807639359;5833.941660583339;5847.415258474119;5859.707014649336;5864.296284445893;5713.05734553794;5721.713914304351;5725.112607545837;5727.799527016535;5731.656100633975 09:38:04 INFO - PROCESS | 1649 | |1;ext.html;460.3164301012996;505.8811179372849;513.4711247415164;519.4208457569811;522.78304503631;23138.88430557847;30530;37087.072823179435;37985.81007094961;38070.61929380705;38927;39212;39263.21473570527;39373.803130984306;39384.409233861516;7965.283124518792;9208.263338932902;9355.906440935605;9360.672376466826;9377.249820014382;8296.419250652427;8523.190296921783;8535.445196062235;8632.352573556976;9236.584353704066;7197.208307086216;10856.891431085667;11096.667099987013;11116.555337786478;11278.492467838925;11025.503852326665;11090.55637774488;11104.777904441866;11119.944400278027;11131.554737810478;8160.428769986103;8428.45215061019;10842.72893177669;10936.070434013118;10948.303013032993;36602.26795464102;37330.44004339937;37567.24865502675;37706.24587508262;37761;3241.1410976091356;3337.8331083445732;3719.75821571597;3836.5012548368813;3974.3839704845795;28564.285892852637;29219.41561168786;29222.561661575095;29263.561046584317;29305.706942930512;3010.322677397568;3023.818570885754;3092.103290045884;3292.209869631295;3295.967040329614;472058;496224;496461;496693;496781;47555.5244447558;51751.48248517542;54181.45818541843;54440;54548.45451545434;55727.04955326544;55929.720351397984;55975.44024559702;56039.439605603424;56099.15851262234;13384.397702103428;14129.505467308594;14812.333444995002;15030;15090.396384144731;11693.298402095901;11755.823662645067;11783.941080294544;11784.116191285688;11799.941000294944;11707.590234341757;12371.505139794488;12767.93616031914;14659.633509162142;14723.411063557338;5996.310424301174;6938.826529336706;6993.181772739124;7048.436125109979;7052.188998265163;921.7188757429049;941.5151197133482;946.8863736351682;947.3415975896824;978.774881777181;27049.323766905592;28073.859630701714;28341.149765507067;28471.240540473285;28950.855245723636;926.092429419173;968.651285537206;1011.3072545306488;1022.6676330192718;1101.124605938281;14672.486462973744;14692.412303507954;14868.182249976355;14986.175760333068;14990.100593964178;650655;656989;659889.7005514941;659895.401045993;660132;52748.0988545626;53010.46989530132;53022;53067;53185.46814531805;1290.9096363254482;1317.947282108724;1347.3667376333108;1350.0549615269547;1355.6746380868717;27139.59290610682;27523.86238068797;28383.006594769085;28814.567781482874;29082.854585726935;46173.30740038835;46619;46678;46690;46700.53299466962;474929;476960;477944;479053;479103;23980.16069437631;24632.87683561571;24705.382365441008;25290.1148459803;36729;34652.30695386028;34710.479342809376;39772.2045559093;42859.7857010713;43948.56051439445;34263.972080837615;36936.44595331126;36957.63042369542;37515.81242093772;38260.426093609174;35610.28779424345;35657.82171089128;36080.45879311865;37074.70238541638;37177;35465.468017979234;36025.81987090048;36051.45922811212;36053.81973090118;36327.63672363242;26057.95768169252;30539.847300763355;32039.199020024687;32325.676743232267;32652.83673581617;24212.1525746598;24280.75719242785;24445.51108977775;24449.755502444747;24633.63049554294 09:38:04 INFO - PROCESS | 1649 | |2;jquery.html;364.76472675124546;367.7076724004415;376.2193448594167;383.8598911397341;396.274817084735;18681.995075847834;19263.614727705455;19837.603247935032;20368.592628147428;20482.692759608617;19663.410097697055;19825;19992.000399979977;20033.699494507593;20411.775293482402;5551.417101204376;5754.913676294848;5828.242328497289;6051.152838602599;6057.091436284549;3783.602721714222;5952.70236488176;6010.398960103998;6013.007853704134;6014.789482368118;3991.6207960243732;5719.370869204384;5999.730012149464;6039.245094363205;6105.725242364082;5762.625429347079;5921.230240068763;6055.848603784919;6061.393860613925;6062.605930614496;5747.453991870808;5765.740541675593;5766.452187042266;5769.653820770725;5775.075987841967;12920.87079129206;21048.42136839743;22888.427789305235;23860;24102.15642452506;2292.5071109711494;2842.1331493894354;2884.7582170550286;2907.09879937218;2934.779891508124;14320;15057.623559410993;15141.772873406908;15167.089974601558;15192;1510.5468359492108;1821.879544080381;1880.3136855047946;1919.251491918153;1920.155131742029;106522;107629.46185269102;108467;110604;115773;8842.867356989651;9214.769630759285;11308.378039207922;11471.598494052669;11698.824517632072;14423.42306307757;14426.42294308216;14431;14444.85555144435;14454.421823127168;7321.560706357635;7882.802929926683;8021.558814265271;8102.230288122619;8250.793730156794;7787.182345853717;7968.641411136513;8117.634706438224;8143.75568732939;8196.467229630054;4353.3765491890945;4434.822607095744;4437.556244375537;4540.114677637895;4574.336721175411;1853.490290170187;1920.1198202695955;1923.9326623568109;1927.6144771045847;1937.0992488492918;697.3235961117708;701.7999870037015;719.7372958869975;774.7714424244749;986.6842610364758;18800.905995469937;19757.901210493856;19775.912324821984;19803.603927921362;19927.900360498395;863.8274739031341;867.4968518259394;878.9340799440067;892.7321803459066;902.9954850225707;9854.901450985399;10218.93431970406;10393.740156496147;10403.53184106717;10406.5837366506;553634;555444.4455555474;556691;557708;561646;105639;118605.22092168624;120632.396838017;123259;135275;946.1673727120228;971.7522031881825;1012.1700205831295;1013.1793247469574;1014.4268488304232;14280.214588197749;17908.01505917187;18284.085795709896;18572.907135464236;18920;52948.94102118013;53103.734481328895;53136.468635313155;54088.45911540834;54138.45861541334;80261;81358.59320703358;83245.58377208075;83286.58356708178;83823.5808820952;7485.962570187115;7813.335866451415;7897.68409263646;8055.234752698484;8103.716369927024;11588.420578971187;12215.511379544718;12267.631971040882;12535;12645.620631381073;10330.741731456774;11085.778284434427;11119.72200694989;11160.051395631463;11167.441627918734;10453.58185672595;10454.790904181722;10598.735031624272;10699.679009629723;11183.993440590386;10834.566617335218;10919.672409827717;10988.725281867697;11411.885881141414;11497.597584084851;6838.316168383122;7118.537295075804;7207.279272072751;7393;8077.87883181741;10490.632827850988;10585.735356615838;10760.569577217137;10862;10956 09:38:04 INFO - PROCESS | 1649 | |3;mootools.html;1468.251191892135;1492.1793013842387;1571.5678188498155;1646.613045934206;1833.4224719213446;7842.451028428012;8351.039630442501;8366.414350995425;8366.665333386658;8380.078191398949;7349.7060117595365;7623.352015078725;7632.3894088472925;7995.7601271961785;8243.010838699349;2271.284545368204;2316.2587971849016;2317.374308936586;2320.385097949036;2321.767823217673;2303.781140791622;2325.1513197682893;2344.8944797484155;2347.9178228762;2353.2940117964627;2285.0973865323185;2286.8856557172157;2306.215886598556;2311.7919387255142;2314.6296592545195;2270.4096934796908;2270.500489892221;2287.062304455182;2291.301153148289;2305.561943230781;2246.70792796937;2267.195145723261;2270.738865030526;2271.897764600597;2272.5568514139586;8172.141925097839;8200.42597018209;8257.545834979073;8269.62786674595;8275.586220688941;5029.371328583927;5190.532852043334;5191.091558977164;5202.115640341151;5204.063268611649;3104.1153271317794;3232.3858466891215;3430.9828450857585;3435;3440.2259491614186;1027.3681685763277;1035.77213013137;1048.2976405808126;1068.4924660786064;1072.222638587026;10595.629152979609;10729.141668666489;10805.243632945698;10807.621733239377;10839.945800271027;3540.964590354115;4500.932486012713;4572.565606267399;4572.588467037983;4644.373009643722;7991.761277002074;9086.36395452312;9257.768555786024;9303.25573954082;9310.348275620641;5140.717260550631;5142.820001299937;5148.047611191867;5156.1492353761205;5156.716380599028;4201.012762000927;4358.65130789536;4409.5149533551285;4677.251639737626;4714.4106986626675;3072.677368876236;3714.7399682022;3781.262653782486;3809.276237514863;3833.2333533292895;1224.088054399478;1252.6367353467574;1255.6233130060946;1269.1243042300782;1269.3272565540278;619.7582942652369;760.7451503746196;779.9782285206397;799.1608810748806;843.7721815109886;5318.308619879391;5446.863828404322;5553.278073850373;5554.583406244467;5612.326520817528;419.9832006719697;440.7311539960621;440.79503031090695;446.484310621233;446.8302045222795;3693.279810436939;3714.461403096536;3799.2401519696173;3810.504634397566;3882.437046628223;9739.853902191473;9834;10005.949970250102;10147.188224941987;10166.4916754162;9616.374935629301;9787.363821351732;10078.294519383573;10081.395116293046;10081.596736130472;7657.0811502620045;7737.574433406104;7754.844903102019;7759.650815713307;7764.84470310602;5393.811216607557;5454.972725136349;5456.399796022355;5525.475079867406;5526.91709624364;9114;9191.540422978958;9230.538473076454;9274.860877086714;9344.486053267136;9200.95399522998;9384.530773461436;9416;9526.618935242514;9531.237501000041;6309.211348581427;6470.902936456051;6678.599284042973;7024.051753013277;7130.18002929649;7511.8497630046;7849.097353804385;7901.565413902061;7918.960405197937;7943.046834379911;6940.548864324005;6989.266127056586;6997.110780089449;7050.858982820418;7175.46184036189;6841.657917104224;6901.723931042702;6911.308869113049;6943.062686537455;6986.895196571953;6370.58591191571;6558.508111891531;6636.203655561363;6710.396064354231;6716.529842910949;4632.351470794159;4762.071396077731;4763.237881938873;4772.809087636595;4943.5797957174045;4638.953610463987;4640.164770341236;4736.668433209642;4791.041791641616;4918.508149185053 09:38:04 INFO - PROCESS | 1649 | |4;prototype.html;273.9178246526043;286.22861388557834;295.73383954441;303.93465404937933;312.75448772713423;4299.419578356921;4571.337156112366;4596.862094137173;4783.258594917785;5328.573714102872;4714.915569419036;4861.829835955742;5007.298978143063;5177.844664660057;5203.881165549406;3296.8516416761304;3593.975716920678;3981.471765428959;4096.037431203665;4101.58984101589;3290.605127384717;4034.3545032794614;4058.3303754880408;4065.3292206785845;4093.5497095319492;4048.056932672319;4053.716239863211;4061.817218225187;4087.3460246360587;4092.6725861930972;3464.3590935676852;3884.902877428087;4044.777537235451;4051.4530538377385;4057.2088442753675;3071;3481.5551546108336;3539.0975301298263;3540.6545512705266;3550.55618047744;4006.939895901564;4927.634735327028;5141.794328226866;5148.742562871841;5163.974180129113;4619.514950930137;4621.550578193563;4625.791839367236;4636.814527418899;4649.814007439699;5077;5214.791408343662;5517.586181036399;5562.86092847678;5578.888422231573;3340.5113190673105;3712;3818.7970789201313;3853.3834586466032;3905.668018218455;5043.823466178666;5804.970975145097;5813.4477224664015;5819.185314056035;5830.47525722687;3946.881593552198;3950.9604903950594;3951.565327813938;3957.5053118360206;3959.762414255154;3353.480210567366;3519.5248641433077;4028.5568587455355;4066.5157217615947;4104.938425923614;4188.308929026737;4391.3412988051405;4599.3776254864315;4600.539946005372;4629.384397815291;5573.773769770725;5578.44215578447;5598.888022239533;5601.29983752031;5603.551715862721;1180.4864883775585;1251.055453132879;1258.7104965857905;1267.8161666558296;1294.838145231846;708.284632521147;892.9821403571892;899.4378513429107;899.8290324838391;905.1446383167975;5017.448080711119;5034.823781167642;5053.67151135175;5089.618278629117;5097.796088156432;5119.462456442095;5422.620416570802;5454.863628409242;5495;5547.223388725582;4462.754548499799;4925.359703238556;4956.752162391866;5000.449950505442;5020.874478138003;2550.6174073889065;2636.5122452346377;2839.4605025045175;2846.9430611387656;2848.7293707097792;4836.46798852126;5567.721613919288;5574.665520068727;5597.93639208549;6004.609700369462;5903.907777061258;5968.731407086691;5994.610350327215;5999.760009599567;6007.849803754853;4730.716157030521;5675.771550195131;6027.969860150672;6035.668038257762;6035.788747393908;5639.943600563942;5781.8554536136935;5805.535557155502;5822.70886455684;5825.242718446575;4251.404803327475;4522.072975040043;5377.897531006056;5654.604177707521;5740.770369185186;5020.87030418153;5663.433656634304;5973.6260660047565;6020.8795824084145;6022.789202377896;3789.8776685056455;3852.749571277858;3871.245107204068;3872.9806350968065;3881.4954055972544;5265.552428043659;5788.668606220509;5797.710114494174;5799.536037117105;5808.361080281081;5303.499690204447;5587.1339942309005;5601.467860553241;5604.411536788579;5613.438656134517;5646.0640466957775;5646.491815736604;5647.6893770843;5655.688937108334;5655.943440565707;5241.895162096813;5416.945830541644;5420.8644783879145;5434.2120392542065;5546.978440630511;4776.474587795409;5208.094158988172;5510.559155267649;5522.122478357378;5568.303962004749;5014;5277.525022747971;5510.366307874646;5545.72271386421;5558.749856256397 09:38:04 INFO - PROCESS | 1649 | |5;yui.html;726.2011787034263;744.6649007946426;750.4296734481794;781.4959351218461;817.0277369929784;14822.258887055645;15053.096814191142;15613.843861561396;15651.92174039131;15839.287232074556;12330.32183229922;14203.857961420383;14393.424263029467;14393.992420530567;14396.928015359908;801.7835184500196;830.5639539241886;831.0069466986953;831.3640065349982;833.5415521463171;827.4497459189631;828.7555171224473;828.8549503836805;829.1584042197175;830.1781236575807;859.0292968945083;870.6517393042802;873.2097451806126;873.9825203495926;875.1685898396516;867.9826403471958;868.9478631282143;869.2698133567802;870.8606622940331;871.533729454745;640.4524131867233;641.8042497038401;641.9582727122722;643.1092936283235;643.4305639509022;12636.936815315956;12736.936315318364;12762.17045892014;12773.48906043757;13457.327133643377;11846.466908989116;11873.881261187364;11915.344656043913;11951.282923024646;11987.340696261703;10604.257701960865;10637.149028077734;10649.414282214475;10995.285306455055;11112.166587505888;3536.6463353664685;3552.5559305086863;3556.6798988091195;3576.660217279354;3593.7125029997537;107441;110941.44529277383;115259.42370288094;115804.05175689401;117190;8987.775305617412;9037.638494460149;9062.909370906207;9250.583723732449;9444.90555094454;18922.432327030212;18970.241190352506;19158.808411915983;19161.712574311397;19378.96520865317;7395.889061664079;7455.813604659818;7487.700491980259;7670.970922618024;7737.6518056686455;4277.593628605277;4337.219300525872;4339.305711086211;4342.5874541918465;4395.318725597537;3341.8496167672515;3421.2815308784934;3424.33225521026;3455.4644030175364;3461.0655123116617;634.7143785296543;638.450932198309;639.2616527910271;645.8675424192721;647.388218133859;480.32034670940226;589.8672798620277;610.3743662745721;620.0606081786098;627.8022422936851;8820.8676869847;8844.867326990101;8878.245349145265;8910;8910.599023043978;583.7168973048068;607.6809674920702;607.805502239288;613.3804857094367;616.3374372549528;4066.430699702044;4128.3601041838565;4316.2446571849805;4385.824567017284;4400.603945644843;107210;108340;108727;109016;109276.81446371028;57766.13350799657;61522.69238653868;65369.69260614761;67125.99999999903;96272.51863740776;55897.572897187114;61066.77866442646;76933.6153319241;77720.61139694492;79570;9420.858687119562;9719.319647624598;9759.219262458844;9798.608055677978;9830.508474576385;34246.828765857004;49088.75455622699;49528.75235623799;49680.50319496759;50027;63101.36898630955;65621;68306.65846670735;71577;73839.6308018478;12496.125271230927;12618.242905425705;12621.810672840098;13000.479980800663;13065.934670326587;14278.785818212942;14427.505161188017;14465.49370772018;14515.129092254498;14572.854271457574;11173.608923687632;13106.082574219714;13514.121582097132;13563.118397304144;13821.308934553434;11365.261258018203;12044.337561434206;13034.283114428417;13284.269365185008;13303.334833258492;11592.43502127202;12707.618771436872;13013.739725205633;13117.60647180586;13541.661458463617;9187.908120918974;9541.47521886303;9805.166560842408;10419.895801042196;11390.601328953448;8275.964759895769;9184;10569.260151789302;10838.945805270923;11115.610953616584 09:38:04 INFO - PROCESS | 1649 | __end_tp_report 09:38:04 INFO - PROCESS | 1649 | __start_cc_report 09:38:04 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2932 09:38:04 INFO - PROCESS | 1649 | __end_cc_report 09:38:04 INFO - PROCESS | 1649 | __startTimestamp1480873084396__endTimestamp 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | ------- Summary: start ------- 09:38:04 INFO - PROCESS | 1649 | Number of tests: 6 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5622.19 Median:5738.66 stddev:636.50 (11.1%) stddev-sans-first:611.92 09:38:04 INFO - PROCESS | 1649 | Values: 3304.1 3333.6 3337.5 3355.7 3382.2 5535.8 5571.5 5600.6 5665.3 5711.5 5585.4 5595.1 5647.5 5658.7 5690.6 4201.6 5171.5 5191.1 5211.8 5214.5 5088.7 5185.3 5225.0 5239.2 5248.2 5198.4 5201.7 5214.6 5226.1 5266.6 5058.5 5097.8 5134.3 5145.0 5186.5 4201.2 5090.3 5139.0 5163.9 5203.6 5526.8 5590.4 5591.3 5593.5 5603.3 5878.1 6106.5 6115.1 6119.5 6121.8 6056.8 6103.9 6107.5 6157.9 6169.3 5678.0 5679.0 5686.4 5694.5 5728.2 6258.8 6292.8 6307.9 6310.9 6311.7 5796.3 5838.0 5848.6 5909.9 5911.9 6044.7 6119.4 6130.3 6135.3 6139.0 5979.1 5984.3 5984.8 5991.5 6001.3 6031.5 6035.8 6040.5 6045.8 6046.6 4809.9 4818.0 4825.8 4826.9 4828.0 4306.1 4308.6 4313.4 4376.2 4399.3 5327.1 5689.9 5709.7 5711.0 5718.9 6198.4 6210.8 6213.0 6223.4 6234.9 5550.1 5615.5 5685.3 5698.5 5698.6 4440.3 5238.3 5266.1 5288.3 5313.0 6291.8 6292.2 6299.9 6305.1 6319.4 6037.8 6174.4 6196.0 6203.1 6207.5 6179.8 6193.3 6219.6 6241.6 6308.5 6099.5 6100.0 6105.4 6107.1 6141.4 6107.6 6120.5 6129.8 6130.5 6132.9 5760.7 5808.5 5832.0 5851.0 5871.4 5825.2 5853.7 5856.7 5865.9 5867.2 5717.9 5733.9 5738.7 5738.9 5739.0 5802.6 5833.9 5847.4 5859.7 5864.3 5713.1 5721.7 5725.1 5727.8 5731.7 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:66149.80 Median:36832.72 stddev:146775.62 (398.5%) stddev-sans-first:147104.50 09:38:04 INFO - PROCESS | 1649 | Values: 460.3 505.9 513.5 519.4 522.8 23138.9 30530.0 37087.1 37985.8 38070.6 38927.0 39212.0 39263.2 39373.8 39384.4 7965.3 9208.3 9355.9 9360.7 9377.2 8296.4 8523.2 8535.4 8632.4 9236.6 7197.2 10856.9 11096.7 11116.6 11278.5 11025.5 11090.6 11104.8 11119.9 11131.6 8160.4 8428.5 10842.7 10936.1 10948.3 36602.3 37330.4 37567.2 37706.2 37761.0 3241.1 3337.8 3719.8 3836.5 3974.4 28564.3 29219.4 29222.6 29263.6 29305.7 3010.3 3023.8 3092.1 3292.2 3296.0 472058.0 496224.0 496461.0 496693.0 496781.0 47555.5 51751.5 54181.5 54440.0 54548.5 55727.0 55929.7 55975.4 56039.4 56099.2 13384.4 14129.5 14812.3 15030.0 15090.4 11693.3 11755.8 11783.9 11784.1 11799.9 11707.6 12371.5 12767.9 14659.6 14723.4 5996.3 6938.8 6993.2 7048.4 7052.2 921.7 941.5 946.9 947.3 978.8 27049.3 28073.9 28341.1 28471.2 28950.9 926.1 968.7 1011.3 1022.7 1101.1 14672.5 14692.4 14868.2 14986.2 14990.1 650655.0 656989.0 659889.7 659895.4 660132.0 52748.1 53010.5 53022.0 53067.0 53185.5 1290.9 1317.9 1347.4 1350.1 1355.7 27139.6 27523.9 28383.0 28814.6 29082.9 46173.3 46619.0 46678.0 46690.0 46700.5 474929.0 476960.0 477944.0 479053.0 479103.0 23980.2 24632.9 24705.4 25290.1 36729.0 34652.3 34710.5 39772.2 42859.8 43948.6 34264.0 36936.4 36957.6 37515.8 38260.4 35610.3 35657.8 36080.5 37074.7 37177.0 35465.5 36025.8 36051.5 36053.8 36327.6 26058.0 30539.8 32039.2 32325.7 32652.8 24212.2 24280.8 24445.5 24449.8 24633.6 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:33362.85 Median:13472.14 stddev:93092.29 (691.0%) stddev-sans-first:93320.47 09:38:04 INFO - PROCESS | 1649 | Values: 364.8 367.7 376.2 383.9 396.3 18682.0 19263.6 19837.6 20368.6 20482.7 19663.4 19825.0 19992.0 20033.7 20411.8 5551.4 5754.9 5828.2 6051.2 6057.1 3783.6 5952.7 6010.4 6013.0 6014.8 3991.6 5719.4 5999.7 6039.2 6105.7 5762.6 5921.2 6055.8 6061.4 6062.6 5747.5 5765.7 5766.5 5769.7 5775.1 12920.9 21048.4 22888.4 23860.0 24102.2 2292.5 2842.1 2884.8 2907.1 2934.8 14320.0 15057.6 15141.8 15167.1 15192.0 1510.5 1821.9 1880.3 1919.3 1920.2 106522.0 107629.5 108467.0 110604.0 115773.0 8842.9 9214.8 11308.4 11471.6 11698.8 14423.4 14426.4 14431.0 14444.9 14454.4 7321.6 7882.8 8021.6 8102.2 8250.8 7787.2 7968.6 8117.6 8143.8 8196.5 4353.4 4434.8 4437.6 4540.1 4574.3 1853.5 1920.1 1923.9 1927.6 1937.1 697.3 701.8 719.7 774.8 986.7 18800.9 19757.9 19775.9 19803.6 19927.9 863.8 867.5 878.9 892.7 903.0 9854.9 10218.9 10393.7 10403.5 10406.6 553634.0 555444.4 556691.0 557708.0 561646.0 105639.0 118605.2 120632.4 123259.0 135275.0 946.2 971.8 1012.2 1013.2 1014.4 14280.2 17908.0 18284.1 18572.9 18920.0 52948.9 53103.7 53136.5 54088.5 54138.5 80261.0 81358.6 83245.6 83286.6 83823.6 7486.0 7813.3 7897.7 8055.2 8103.7 11588.4 12215.5 12267.6 12535.0 12645.6 10330.7 11085.8 11119.7 11160.1 11167.4 10453.6 10454.8 10598.7 10699.7 11184.0 10834.6 10919.7 10988.7 11411.9 11497.6 6838.3 7118.5 7207.3 7393.0 8077.9 10490.6 10585.7 10760.6 10862.0 10956.0 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5343.96 Median:4986.48 stddev:2960.03 (59.4%) stddev-sans-first:2954.00 09:38:04 INFO - PROCESS | 1649 | Values: 1468.3 1492.2 1571.6 1646.6 1833.4 7842.5 8351.0 8366.4 8366.7 8380.1 7349.7 7623.4 7632.4 7995.8 8243.0 2271.3 2316.3 2317.4 2320.4 2321.8 2303.8 2325.2 2344.9 2347.9 2353.3 2285.1 2286.9 2306.2 2311.8 2314.6 2270.4 2270.5 2287.1 2291.3 2305.6 2246.7 2267.2 2270.7 2271.9 2272.6 8172.1 8200.4 8257.5 8269.6 8275.6 5029.4 5190.5 5191.1 5202.1 5204.1 3104.1 3232.4 3431.0 3435.0 3440.2 1027.4 1035.8 1048.3 1068.5 1072.2 10595.6 10729.1 10805.2 10807.6 10839.9 3541.0 4500.9 4572.6 4572.6 4644.4 7991.8 9086.4 9257.8 9303.3 9310.3 5140.7 5142.8 5148.0 5156.1 5156.7 4201.0 4358.7 4409.5 4677.3 4714.4 3072.7 3714.7 3781.3 3809.3 3833.2 1224.1 1252.6 1255.6 1269.1 1269.3 619.8 760.7 780.0 799.2 843.8 5318.3 5446.9 5553.3 5554.6 5612.3 420.0 440.7 440.8 446.5 446.8 3693.3 3714.5 3799.2 3810.5 3882.4 9739.9 9834.0 10005.9 10147.2 10166.5 9616.4 9787.4 10078.3 10081.4 10081.6 7657.1 7737.6 7754.8 7759.7 7764.8 5393.8 5455.0 5456.4 5525.5 5526.9 9114.0 9191.5 9230.5 9274.9 9344.5 9201.0 9384.5 9416.0 9526.6 9531.2 6309.2 6470.9 6678.6 7024.1 7130.2 7511.8 7849.1 7901.6 7919.0 7943.0 6940.5 6989.3 6997.1 7050.9 7175.5 6841.7 6901.7 6911.3 6943.1 6986.9 6370.6 6558.5 6636.2 6710.4 6716.5 4632.4 4762.1 4763.2 4772.8 4943.6 4639.0 4640.2 4736.7 4791.0 4918.5 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4503.38 Median:5020.87 stddev:1401.88 (27.9%) stddev-sans-first:1369.40 09:38:04 INFO - PROCESS | 1649 | Values: 273.9 286.2 295.7 303.9 312.8 4299.4 4571.3 4596.9 4783.3 5328.6 4714.9 4861.8 5007.3 5177.8 5203.9 3296.9 3594.0 3981.5 4096.0 4101.6 3290.6 4034.4 4058.3 4065.3 4093.5 4048.1 4053.7 4061.8 4087.3 4092.7 3464.4 3884.9 4044.8 4051.5 4057.2 3071.0 3481.6 3539.1 3540.7 3550.6 4006.9 4927.6 5141.8 5148.7 5164.0 4619.5 4621.6 4625.8 4636.8 4649.8 5077.0 5214.8 5517.6 5562.9 5578.9 3340.5 3712.0 3818.8 3853.4 3905.7 5043.8 5805.0 5813.4 5819.2 5830.5 3946.9 3951.0 3951.6 3957.5 3959.8 3353.5 3519.5 4028.6 4066.5 4104.9 4188.3 4391.3 4599.4 4600.5 4629.4 5573.8 5578.4 5598.9 5601.3 5603.6 1180.5 1251.1 1258.7 1267.8 1294.8 708.3 893.0 899.4 899.8 905.1 5017.4 5034.8 5053.7 5089.6 5097.8 5119.5 5422.6 5454.9 5495.0 5547.2 4462.8 4925.4 4956.8 5000.4 5020.9 2550.6 2636.5 2839.5 2846.9 2848.7 4836.5 5567.7 5574.7 5597.9 6004.6 5903.9 5968.7 5994.6 5999.8 6007.8 4730.7 5675.8 6028.0 6035.7 6035.8 5639.9 5781.9 5805.5 5822.7 5825.2 4251.4 4522.1 5377.9 5654.6 5740.8 5020.9 5663.4 5973.6 6020.9 6022.8 3789.9 3852.7 3871.2 3873.0 3881.5 5265.6 5788.7 5797.7 5799.5 5808.4 5303.5 5587.1 5601.5 5604.4 5613.4 5646.1 5646.5 5647.7 5655.7 5655.9 5241.9 5416.9 5420.9 5434.2 5547.0 4776.5 5208.1 5510.6 5522.1 5568.3 5014.0 5277.5 5510.4 5545.7 5558.7 09:38:04 INFO - PROCESS | 1649 | 09:38:04 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:19554.31 Median:2440.46 stddev:29192.24 (1196.2%) stddev-sans-first:29239.90 09:38:04 INFO - PROCESS | 1649 | Values: 726.2 744.7 750.4 781.5 817.0 14822.3 15053.1 15613.8 15651.9 15839.3 12330.3 14203.9 14393.4 14394.0 14396.9 801.8 830.6 831.0 831.4 833.5 827.4 828.8 828.9 829.2 830.2 859.0 870.7 873.2 874.0 875.2 868.0 868.9 869.3 870.9 871.5 640.5 641.8 642.0 643.1 643.4 12636.9 12736.9 12762.2 12773.5 13457.3 11846.5 11873.9 11915.3 11951.3 11987.3 10604.3 10637.1 10649.4 10995.3 11112.2 3536.6 3552.6 3556.7 3576.7 3593.7 107441.0 110941.4 115259.4 115804.1 117190.0 8987.8 9037.6 9062.9 9250.6 9444.9 18922.4 18970.2 19158.8 19161.7 19379.0 7395.9 7455.8 7487.7 7671.0 7737.7 4277.6 4337.2 4339.3 4342.6 4395.3 3341.8 3421.3 3424.3 3455.5 3461.1 634.7 638.5 639.3 645.9 647.4 480.3 589.9 610.4 620.1 627.8 8820.9 8844.9 8878.2 8910.0 8910.6 583.7 607.7 607.8 613.4 616.3 4066.4 4128.4 4316.2 4385.8 4400.6 107210.0 108340.0 108727.0 109016.0 109276.8 57766.1 61522.7 65369.7 67126.0 96272.5 55897.6 61066.8 76933.6 77720.6 79570.0 9420.9 9719.3 9759.2 9798.6 9830.5 34246.8 49088.8 49528.8 49680.5 50027.0 63101.4 65621.0 68306.7 71577.0 73839.6 12496.1 12618.2 12621.8 13000.5 13065.9 14278.8 14427.5 14465.5 14515.1 14572.9 11173.6 13106.1 13514.1 13563.1 13821.3 11365.3 12044.3 13034.3 13284.3 13303.3 11592.4 12707.6 13013.7 13117.6 13541.7 9187.9 9541.5 9805.2 10419.9 11390.6 8276.0 9184.0 10569.3 10838.9 11115.6 09:38:04 INFO - PROCESS | 1649 | -------- Summary: end -------- 09:38:04 INFO - PROCESS | 1649 | 09:38:05 INFO - TEST-INFO | 1649: exit 0 09:38:05 INFO - TEST-OK | dromaeo_css | took 1120196ms 09:38:05 INFO - TEST-START | kraken 09:38:05 INFO - operating with platform_type : mac_ 09:38:05 INFO - Initialising browser for kraken test... 09:38:05 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpwbUEYI/profile http://localhost:49245/getInfo.html) 09:38:07 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 09:38:07 INFO - PROCESS | 1656 | colorDepth:24 09:38:07 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 09:38:07 INFO - PROCESS | 1656 | __metrics 09:38:07 INFO - PROCESS | 1656 | 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" 09:38:07 INFO - PROCESS | 1656 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:08 INFO - TEST-INFO | 1656: exit 0 09:38:08 INFO - Browser initialized. 09:38:08 INFO - Running cycle 1/1 for kraken test... 09:38:08 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpwbUEYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:21 INFO - PROCESS | 1657 | RSS: Main: 235728896 09:38:21 INFO - PROCESS | 1657 | 09:38:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:24 INFO - PROCESS | 1657 | RSS: Main: 293793792 09:38:24 INFO - PROCESS | 1657 | 09:38:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 09:38:28 INFO - PROCESS | 1657 | RSS: Main: 296099840 09:38:28 INFO - PROCESS | 1657 | 09:38:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 09:38:32 INFO - PROCESS | 1657 | RSS: Main: 388775936 09:38:32 INFO - PROCESS | 1657 | 09:38:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 09:38:34 INFO - PROCESS | 1657 | RSS: Main: 289931264 09:38:34 INFO - PROCESS | 1657 | 09:38:36 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:37 INFO - PROCESS | 1657 | RSS: Main: 295030784 09:38:37 INFO - PROCESS | 1657 | 09:38:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:40 INFO - PROCESS | 1657 | RSS: Main: 336949248 09:38:40 INFO - PROCESS | 1657 | 09:38:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:44 INFO - PROCESS | 1657 | RSS: Main: 338661376 09:38:44 INFO - PROCESS | 1657 | 09:38:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 09:38:47 INFO - PROCESS | 1657 | RSS: Main: 335319040 09:38:47 INFO - PROCESS | 1657 | 09:38:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:49 INFO - PROCESS | 1657 | RSS: Main: 309108736 09:38:49 INFO - PROCESS | 1657 | 09:38:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:52 INFO - PROCESS | 1657 | RSS: Main: 313270272 09:38:52 INFO - PROCESS | 1657 | 09:38:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:55 INFO - PROCESS | 1657 | RSS: Main: 314966016 09:38:55 INFO - PROCESS | 1657 | 09:38:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:58 INFO - PROCESS | 1657 | RSS: Main: 332668928 09:38:58 INFO - PROCESS | 1657 | 09:39:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:02 INFO - PROCESS | 1657 | RSS: Main: 327073792 09:39:02 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 09:39:04 INFO - PROCESS | 1657 | RSS: Main: 370720768 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | __start_tp_report 09:39:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 09:39:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 09:39:04 INFO - PROCESS | 1657 | |i|pagename|runs| 09:39:04 INFO - PROCESS | 1657 | |0;ai-astar;103;116;115;115;113;115;113;114;115;114 09:39:04 INFO - PROCESS | 1657 | |1;audio-beat-detection;149;116;115;153;124;142;145;146;137;127 09:39:04 INFO - PROCESS | 1657 | |2;audio-dft;175;178;182;185;185;184;181;182;181;185 09:39:04 INFO - PROCESS | 1657 | |3;audio-fft;77;72;61;89;61;60;58;57;74;59 09:39:04 INFO - PROCESS | 1657 | |4;audio-oscillator;90;72;85;72;69;69;83;68;70;84 09:39:04 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;86;84;89;85;86;84;89;85;127;85 09:39:04 INFO - PROCESS | 1657 | |6;imaging-darkroom;95;99;97;95;94;96;95;104;146;101 09:39:04 INFO - PROCESS | 1657 | |7;imaging-desaturate;88;85;87;87;88;87;87;87;86;87 09:39:04 INFO - PROCESS | 1657 | |8;json-parse-financial;56;54;54;54;56;55;55;55;53;54 09:39:04 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;64;71;69;79;77;69;69;71;70;72 09:39:04 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;87;87;88;88;88;88;88;86;88;88 09:39:04 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;149;151;150;149;148;153;149;148;188;152 09:39:04 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;180;175;173;177;175;175;182;175;206;164 09:39:04 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;70;70;71;70;69;67;69;68;67;69 09:39:04 INFO - PROCESS | 1657 | __end_tp_report 09:39:04 INFO - PROCESS | 1657 | __start_cc_report 09:39:04 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2062 09:39:04 INFO - PROCESS | 1657 | __end_cc_report 09:39:04 INFO - PROCESS | 1657 | __startTimestamp1480873144572__endTimestamp 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | ------- Summary: start ------- 09:39:04 INFO - PROCESS | 1657 | Number of tests: 14 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.74 (3.3%) stddev-sans-first:1.01 09:39:04 INFO - PROCESS | 1657 | Values: 103.0 116.0 115.0 115.0 113.0 115.0 113.0 114.0 115.0 114.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:143.50 stddev:13.90 (9.7%) stddev-sans-first:13.84 09:39:04 INFO - PROCESS | 1657 | Values: 149.0 116.0 115.0 153.0 124.0 142.0 145.0 146.0 137.0 127.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:181.80 Median:183.00 stddev:3.29 (1.8%) stddev-sans-first:2.40 09:39:04 INFO - PROCESS | 1657 | Values: 175.0 178.0 182.0 185.0 185.0 184.0 181.0 182.0 181.0 185.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:66.80 Median:66.50 stddev:10.66 (16.0%) stddev-sans-first:10.65 09:39:04 INFO - PROCESS | 1657 | Values: 77.0 72.0 61.0 89.0 61.0 60.0 58.0 57.0 74.0 59.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:8.30 (10.7%) stddev-sans-first:7.14 09:39:04 INFO - PROCESS | 1657 | Values: 90.0 72.0 85.0 72.0 69.0 69.0 83.0 68.0 70.0 84.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:85.50 stddev:13.12 (15.3%) stddev-sans-first:13.84 09:39:04 INFO - PROCESS | 1657 | Values: 86.0 84.0 89.0 85.0 86.0 84.0 89.0 85.0 127.0 85.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:95.00 stddev:15.71 (16.5%) stddev-sans-first:16.45 09:39:04 INFO - PROCESS | 1657 | Values: 95.0 99.0 97.0 95.0 94.0 96.0 95.0 104.0 146.0 101.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 09:39:04 INFO - PROCESS | 1657 | Values: 88.0 85.0 87.0 87.0 88.0 87.0 87.0 87.0 86.0 87.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 09:39:04 INFO - PROCESS | 1657 | Values: 56.0 54.0 54.0 54.0 56.0 55.0 55.0 55.0 53.0 54.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:4.25 (6.0%) stddev-sans-first:3.66 09:39:04 INFO - PROCESS | 1657 | Values: 64.0 71.0 69.0 79.0 77.0 69.0 69.0 71.0 70.0 72.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 09:39:04 INFO - PROCESS | 1657 | Values: 87.0 87.0 88.0 88.0 88.0 88.0 88.0 86.0 88.0 88.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:150.50 stddev:12.17 (8.1%) stddev-sans-first:12.78 09:39:04 INFO - PROCESS | 1657 | Values: 149.0 151.0 150.0 149.0 148.0 153.0 149.0 148.0 188.0 152.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:176.00 stddev:10.86 (6.2%) stddev-sans-first:11.50 09:39:04 INFO - PROCESS | 1657 | Values: 180.0 175.0 173.0 177.0 175.0 175.0 182.0 175.0 206.0 164.0 09:39:04 INFO - PROCESS | 1657 | 09:39:04 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.33 (1.9%) stddev-sans-first:1.36 09:39:04 INFO - PROCESS | 1657 | Values: 70.0 70.0 71.0 70.0 69.0 67.0 69.0 68.0 67.0 69.0 09:39:04 INFO - PROCESS | 1657 | -------- Summary: end -------- 09:39:04 INFO - PROCESS | 1657 | 09:39:05 INFO - TEST-INFO | 1657: exit 0 09:39:05 INFO - TEST-OK | kraken | took 60682ms 09:39:05 INFO - SUITE-END | took 1180s 09:39:05 INFO - Completed test suite (00:19:40) 09:39:05 INFO - javascript benchmark 09:39:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.0583433721395, 3333.59996800384, 3337.5160601712737, 3355.697987181153, 3382.2389962258494, 5535.806246781363, 5571.498565129137, 5600.6079574429805, 5665.291838520185, 5711.543076553871, 5585.357683866357, 5595.104783234683, 5647.548196144309, 5658.688772117532, 5690.57320700947, 4201.558836322188, 5171.50870667286, 5191.091558977183, 5211.843644690646, 5214.478552144793, 5088.669236499634, 5185.299984502081, 5224.973875130638, 5239.240310155025, 5248.239005344242, 5198.350206224222, 5201.713905735183, 5214.556762675177, 5226.137687281613, 5266.631335806495, 5058.519440653132, 5097.847064588032, 5134.306868572732, 5145.0, 5186.507281808223, 4201.243776120297, 5090.33825602673, 5138.997895410396, 5163.896722065575, 5203.60972927032, 5526.778928842841, 5590.357108932484, 5591.329040515124, 5593.496585307301, 5603.299587551556, 5878.118282257653, 6106.48094911933, 6115.143879856823, 6119.479844213247, 6121.755129794803, 6056.757729690807, 6103.943827031755, 6107.522607572277, 6157.907631385533, 6169.290531588835, 5678.034734095172, 5678.971605141948, 5686.3744988051285, 5694.544436445157, 5728.226689396962, 6258.843528911722, 6292.779752708725, 6307.905381419282, 6310.9368906311265, 6311.715972781144, 5796.275465566804, 5837.970810145922, 5848.561357898175, 5909.940900591025, 5911.940880591225, 6044.727987240584, 6119.357467465941, 6130.325664176937, 6135.263768347827, 6139.0, 5979.133025711248, 5984.31180414258, 5984.760609575568, 5991.5206783457215, 6001.339852616209, 6031.487323577458, 6035.818925432244, 6040.546958978094, 6045.758169673164, 6046.576739628272, 4809.927851082237, 4818.0, 4825.831095911626, 4826.903461930812, 4828.03439312139, 4306.1172459645695, 4308.612224899712, 4313.396124542566, 4376.168527979674, 4399.274119770202, 5327.147656374961, 5689.886202276014, 5709.714514274269, 5711.029125048752, 5718.857028574319, 6198.380161983766, 6210.7515699372425, 6212.968935155295, 6223.439890409885, 6234.906476402857, 5550.139728342033, 5615.522680572116, 5685.346185188756, 5698.487136157766, 5698.601097923106, 4440.289553671397, 5238.345206849144, 5266.131088370453, 5288.338957630296, 5312.963972025418, 6291.779787707408, 6292.2134733158355, 6299.874002520016, 6305.117283580303, 6319.431251187231, 6037.818865434044, 6174.44430001302, 6195.96902015487, 6203.06953956892, 6207.534434917309, 6179.752809887555, 6193.349698281796, 6219.626822390671, 6241.563090583797, 6308.526860485574, 6099.542534309856, 6099.993501072451, 6105.429421494235, 6107.083937409424, 6141.416565426277, 6107.603005804608, 6120.510359171167, 6129.816105516842, 6130.47890929276, 6132.908006379818, 5760.711964401679, 5808.5062769665055, 5831.970840145772, 5850.970745146417, 5871.354151043467, 5825.213596164633, 5853.707314634336, 5856.677882716492, 5865.882682346414, 5867.20792692998, 5717.914231286617, 5733.942660573341, 5738.655680659173, 5738.913916291175, 5739.0, 5802.564807639359, 5833.941660583339, 5847.415258474119, 5859.707014649336, 5864.296284445893, 5713.05734553794, 5721.713914304351, 5725.112607545837, 5727.799527016535, 5731.656100633975], "value": 5581.584169677872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.3164301012996, 505.8811179372849, 513.4711247415164, 519.4208457569811, 522.78304503631, 23138.88430557847, 30530.0, 37087.072823179435, 37985.81007094961, 38070.61929380705, 38927.0, 39212.0, 39263.21473570527, 39373.803130984306, 39384.409233861516, 7965.283124518792, 9208.263338932902, 9355.906440935605, 9360.672376466826, 9377.249820014382, 8296.419250652427, 8523.190296921783, 8535.445196062235, 8632.352573556976, 9236.584353704066, 7197.208307086216, 10856.891431085667, 11096.667099987013, 11116.555337786478, 11278.492467838925, 11025.503852326665, 11090.55637774488, 11104.777904441866, 11119.944400278027, 11131.554737810478, 8160.428769986103, 8428.45215061019, 10842.72893177669, 10936.070434013118, 10948.303013032993, 36602.26795464102, 37330.44004339937, 37567.24865502675, 37706.24587508262, 37761.0, 3241.1410976091356, 3337.8331083445732, 3719.75821571597, 3836.5012548368813, 3974.3839704845795, 28564.285892852637, 29219.41561168786, 29222.561661575095, 29263.561046584317, 29305.706942930512, 3010.322677397568, 3023.818570885754, 3092.103290045884, 3292.209869631295, 3295.967040329614, 472058.0, 496224.0, 496461.0, 496693.0, 496781.0, 47555.5244447558, 51751.48248517542, 54181.45818541843, 54440.0, 54548.45451545434, 55727.04955326544, 55929.720351397984, 55975.44024559702, 56039.439605603424, 56099.15851262234, 13384.397702103428, 14129.505467308594, 14812.333444995002, 15030.0, 15090.396384144731, 11693.298402095901, 11755.823662645067, 11783.941080294544, 11784.116191285688, 11799.941000294944, 11707.590234341757, 12371.505139794488, 12767.93616031914, 14659.633509162142, 14723.411063557338, 5996.310424301174, 6938.826529336706, 6993.181772739124, 7048.436125109979, 7052.188998265163, 921.7188757429049, 941.5151197133482, 946.8863736351682, 947.3415975896824, 978.774881777181, 27049.323766905592, 28073.859630701714, 28341.149765507067, 28471.240540473285, 28950.855245723636, 926.092429419173, 968.651285537206, 1011.3072545306488, 1022.6676330192718, 1101.124605938281, 14672.486462973744, 14692.412303507954, 14868.182249976355, 14986.175760333068, 14990.100593964178, 650655.0, 656989.0, 659889.7005514941, 659895.401045993, 660132.0, 52748.0988545626, 53010.46989530132, 53022.0, 53067.0, 53185.46814531805, 1290.9096363254482, 1317.947282108724, 1347.3667376333108, 1350.0549615269547, 1355.6746380868717, 27139.59290610682, 27523.86238068797, 28383.006594769085, 28814.567781482874, 29082.854585726935, 46173.30740038835, 46619.0, 46678.0, 46690.0, 46700.53299466962, 474929.0, 476960.0, 477944.0, 479053.0, 479103.0, 23980.16069437631, 24632.87683561571, 24705.382365441008, 25290.1148459803, 36729.0, 34652.30695386028, 34710.479342809376, 39772.2045559093, 42859.7857010713, 43948.56051439445, 34263.972080837615, 36936.44595331126, 36957.63042369542, 37515.81242093772, 38260.426093609174, 35610.28779424345, 35657.82171089128, 36080.45879311865, 37074.70238541638, 37177.0, 35465.468017979234, 36025.81987090048, 36051.45922811212, 36053.81973090118, 36327.63672363242, 26057.95768169252, 30539.847300763355, 32039.199020024687, 32325.676743232267, 32652.83673581617, 24212.1525746598, 24280.75719242785, 24445.51108977775, 24449.755502444747, 24633.63049554294], "value": 18781.268916941015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.76472675124546, 367.7076724004415, 376.2193448594167, 383.8598911397341, 396.274817084735, 18681.995075847834, 19263.614727705455, 19837.603247935032, 20368.592628147428, 20482.692759608617, 19663.410097697055, 19825.0, 19992.000399979977, 20033.699494507593, 20411.775293482402, 5551.417101204376, 5754.913676294848, 5828.242328497289, 6051.152838602599, 6057.091436284549, 3783.602721714222, 5952.70236488176, 6010.398960103998, 6013.007853704134, 6014.789482368118, 3991.6207960243732, 5719.370869204384, 5999.730012149464, 6039.245094363205, 6105.725242364082, 5762.625429347079, 5921.230240068763, 6055.848603784919, 6061.393860613925, 6062.605930614496, 5747.453991870808, 5765.740541675593, 5766.452187042266, 5769.653820770725, 5775.075987841967, 12920.87079129206, 21048.42136839743, 22888.427789305235, 23860.0, 24102.15642452506, 2292.5071109711494, 2842.1331493894354, 2884.7582170550286, 2907.09879937218, 2934.779891508124, 14320.0, 15057.623559410993, 15141.772873406908, 15167.089974601558, 15192.0, 1510.5468359492108, 1821.879544080381, 1880.3136855047946, 1919.251491918153, 1920.155131742029, 106522.0, 107629.46185269102, 108467.0, 110604.0, 115773.0, 8842.867356989651, 9214.769630759285, 11308.378039207922, 11471.598494052669, 11698.824517632072, 14423.42306307757, 14426.42294308216, 14431.0, 14444.85555144435, 14454.421823127168, 7321.560706357635, 7882.802929926683, 8021.558814265271, 8102.230288122619, 8250.793730156794, 7787.182345853717, 7968.641411136513, 8117.634706438224, 8143.75568732939, 8196.467229630054, 4353.3765491890945, 4434.822607095744, 4437.556244375537, 4540.114677637895, 4574.336721175411, 1853.490290170187, 1920.1198202695955, 1923.9326623568109, 1927.6144771045847, 1937.0992488492918, 697.3235961117708, 701.7999870037015, 719.7372958869975, 774.7714424244749, 986.6842610364758, 18800.905995469937, 19757.901210493856, 19775.912324821984, 19803.603927921362, 19927.900360498395, 863.8274739031341, 867.4968518259394, 878.9340799440067, 892.7321803459066, 902.9954850225707, 9854.901450985399, 10218.93431970406, 10393.740156496147, 10403.53184106717, 10406.5837366506, 553634.0, 555444.4455555474, 556691.0, 557708.0, 561646.0, 105639.0, 118605.22092168624, 120632.396838017, 123259.0, 135275.0, 946.1673727120228, 971.7522031881825, 1012.1700205831295, 1013.1793247469574, 1014.4268488304232, 14280.214588197749, 17908.01505917187, 18284.085795709896, 18572.907135464236, 18920.0, 52948.94102118013, 53103.734481328895, 53136.468635313155, 54088.45911540834, 54138.45861541334, 80261.0, 81358.59320703358, 83245.58377208075, 83286.58356708178, 83823.5808820952, 7485.962570187115, 7813.335866451415, 7897.68409263646, 8055.234752698484, 8103.716369927024, 11588.420578971187, 12215.511379544718, 12267.631971040882, 12535.0, 12645.620631381073, 10330.741731456774, 11085.778284434427, 11119.72200694989, 11160.051395631463, 11167.441627918734, 10453.58185672595, 10454.790904181722, 10598.735031624272, 10699.679009629723, 11183.993440590386, 10834.566617335218, 10919.672409827717, 10988.725281867697, 11411.885881141414, 11497.597584084851, 6838.316168383122, 7118.537295075804, 7207.279272072751, 7393.0, 8077.87883181741, 10490.632827850988, 10585.735356615838, 10760.569577217137, 10862.0, 10956.0], "value": 9363.544640425278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.251191892135, 1492.1793013842387, 1571.5678188498155, 1646.613045934206, 1833.4224719213446, 7842.451028428012, 8351.039630442501, 8366.414350995425, 8366.665333386658, 8380.078191398949, 7349.7060117595365, 7623.352015078725, 7632.3894088472925, 7995.7601271961785, 8243.010838699349, 2271.284545368204, 2316.2587971849016, 2317.374308936586, 2320.385097949036, 2321.767823217673, 2303.781140791622, 2325.1513197682893, 2344.8944797484155, 2347.9178228762, 2353.2940117964627, 2285.0973865323185, 2286.8856557172157, 2306.215886598556, 2311.7919387255142, 2314.6296592545195, 2270.4096934796908, 2270.500489892221, 2287.062304455182, 2291.301153148289, 2305.561943230781, 2246.70792796937, 2267.195145723261, 2270.738865030526, 2271.897764600597, 2272.5568514139586, 8172.141925097839, 8200.42597018209, 8257.545834979073, 8269.62786674595, 8275.586220688941, 5029.371328583927, 5190.532852043334, 5191.091558977164, 5202.115640341151, 5204.063268611649, 3104.1153271317794, 3232.3858466891215, 3430.9828450857585, 3435.0, 3440.2259491614186, 1027.3681685763277, 1035.77213013137, 1048.2976405808126, 1068.4924660786064, 1072.222638587026, 10595.629152979609, 10729.141668666489, 10805.243632945698, 10807.621733239377, 10839.945800271027, 3540.964590354115, 4500.932486012713, 4572.565606267399, 4572.588467037983, 4644.373009643722, 7991.761277002074, 9086.36395452312, 9257.768555786024, 9303.25573954082, 9310.348275620641, 5140.717260550631, 5142.820001299937, 5148.047611191867, 5156.1492353761205, 5156.716380599028, 4201.012762000927, 4358.65130789536, 4409.5149533551285, 4677.251639737626, 4714.4106986626675, 3072.677368876236, 3714.7399682022, 3781.262653782486, 3809.276237514863, 3833.2333533292895, 1224.088054399478, 1252.6367353467574, 1255.6233130060946, 1269.1243042300782, 1269.3272565540278, 619.7582942652369, 760.7451503746196, 779.9782285206397, 799.1608810748806, 843.7721815109886, 5318.308619879391, 5446.863828404322, 5553.278073850373, 5554.583406244467, 5612.326520817528, 419.9832006719697, 440.7311539960621, 440.79503031090695, 446.484310621233, 446.8302045222795, 3693.279810436939, 3714.461403096536, 3799.2401519696173, 3810.504634397566, 3882.437046628223, 9739.853902191473, 9834.0, 10005.949970250102, 10147.188224941987, 10166.4916754162, 9616.374935629301, 9787.363821351732, 10078.294519383573, 10081.395116293046, 10081.596736130472, 7657.0811502620045, 7737.574433406104, 7754.844903102019, 7759.650815713307, 7764.84470310602, 5393.811216607557, 5454.972725136349, 5456.399796022355, 5525.475079867406, 5526.91709624364, 9114.0, 9191.540422978958, 9230.538473076454, 9274.860877086714, 9344.486053267136, 9200.95399522998, 9384.530773461436, 9416.0, 9526.618935242514, 9531.237501000041, 6309.211348581427, 6470.902936456051, 6678.599284042973, 7024.051753013277, 7130.18002929649, 7511.8497630046, 7849.097353804385, 7901.565413902061, 7918.960405197937, 7943.046834379911, 6940.548864324005, 6989.266127056586, 6997.110780089449, 7050.858982820418, 7175.46184036189, 6841.657917104224, 6901.723931042702, 6911.308869113049, 6943.062686537455, 6986.895196571953, 6370.58591191571, 6558.508111891531, 6636.203655561363, 6710.396064354231, 6716.529842910949, 4632.351470794159, 4762.071396077731, 4763.237881938873, 4772.809087636595, 4943.5797957174045, 4638.953610463987, 4640.164770341236, 4736.668433209642, 4791.041791641616, 4918.508149185053], "value": 4251.267267634239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.9178246526043, 286.22861388557834, 295.73383954441, 303.93465404937933, 312.75448772713423, 4299.419578356921, 4571.337156112366, 4596.862094137173, 4783.258594917785, 5328.573714102872, 4714.915569419036, 4861.829835955742, 5007.298978143063, 5177.844664660057, 5203.881165549406, 3296.8516416761304, 3593.975716920678, 3981.471765428959, 4096.037431203665, 4101.58984101589, 3290.605127384717, 4034.3545032794614, 4058.3303754880408, 4065.3292206785845, 4093.5497095319492, 4048.056932672319, 4053.716239863211, 4061.817218225187, 4087.3460246360587, 4092.6725861930972, 3464.3590935676852, 3884.902877428087, 4044.777537235451, 4051.4530538377385, 4057.2088442753675, 3071.0, 3481.5551546108336, 3539.0975301298263, 3540.6545512705266, 3550.55618047744, 4006.939895901564, 4927.634735327028, 5141.794328226866, 5148.742562871841, 5163.974180129113, 4619.514950930137, 4621.550578193563, 4625.791839367236, 4636.814527418899, 4649.814007439699, 5077.0, 5214.791408343662, 5517.586181036399, 5562.86092847678, 5578.888422231573, 3340.5113190673105, 3712.0, 3818.7970789201313, 3853.3834586466032, 3905.668018218455, 5043.823466178666, 5804.970975145097, 5813.4477224664015, 5819.185314056035, 5830.47525722687, 3946.881593552198, 3950.9604903950594, 3951.565327813938, 3957.5053118360206, 3959.762414255154, 3353.480210567366, 3519.5248641433077, 4028.5568587455355, 4066.5157217615947, 4104.938425923614, 4188.308929026737, 4391.3412988051405, 4599.3776254864315, 4600.539946005372, 4629.384397815291, 5573.773769770725, 5578.44215578447, 5598.888022239533, 5601.29983752031, 5603.551715862721, 1180.4864883775585, 1251.055453132879, 1258.7104965857905, 1267.8161666558296, 1294.838145231846, 708.284632521147, 892.9821403571892, 899.4378513429107, 899.8290324838391, 905.1446383167975, 5017.448080711119, 5034.823781167642, 5053.67151135175, 5089.618278629117, 5097.796088156432, 5119.462456442095, 5422.620416570802, 5454.863628409242, 5495.0, 5547.223388725582, 4462.754548499799, 4925.359703238556, 4956.752162391866, 5000.449950505442, 5020.874478138003, 2550.6174073889065, 2636.5122452346377, 2839.4605025045175, 2846.9430611387656, 2848.7293707097792, 4836.46798852126, 5567.721613919288, 5574.665520068727, 5597.93639208549, 6004.609700369462, 5903.907777061258, 5968.731407086691, 5994.610350327215, 5999.760009599567, 6007.849803754853, 4730.716157030521, 5675.771550195131, 6027.969860150672, 6035.668038257762, 6035.788747393908, 5639.943600563942, 5781.8554536136935, 5805.535557155502, 5822.70886455684, 5825.242718446575, 4251.404803327475, 4522.072975040043, 5377.897531006056, 5654.604177707521, 5740.770369185186, 5020.87030418153, 5663.433656634304, 5973.6260660047565, 6020.8795824084145, 6022.789202377896, 3789.8776685056455, 3852.749571277858, 3871.245107204068, 3872.9806350968065, 3881.4954055972544, 5265.552428043659, 5788.668606220509, 5797.710114494174, 5799.536037117105, 5808.361080281081, 5303.499690204447, 5587.1339942309005, 5601.467860553241, 5604.411536788579, 5613.438656134517, 5646.0640466957775, 5646.491815736604, 5647.6893770843, 5655.688937108334, 5655.943440565707, 5241.895162096813, 5416.945830541644, 5420.8644783879145, 5434.2120392542065, 5546.978440630511, 4776.474587795409, 5208.094158988172, 5510.559155267649, 5522.122478357378, 5568.303962004749, 5014.0, 5277.525022747971, 5510.366307874646, 5545.72271386421, 5558.749856256397], "value": 4049.0975237779307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.2011787034263, 744.6649007946426, 750.4296734481794, 781.4959351218461, 817.0277369929784, 14822.258887055645, 15053.096814191142, 15613.843861561396, 15651.92174039131, 15839.287232074556, 12330.32183229922, 14203.857961420383, 14393.424263029467, 14393.992420530567, 14396.928015359908, 801.7835184500196, 830.5639539241886, 831.0069466986953, 831.3640065349982, 833.5415521463171, 827.4497459189631, 828.7555171224473, 828.8549503836805, 829.1584042197175, 830.1781236575807, 859.0292968945083, 870.6517393042802, 873.2097451806126, 873.9825203495926, 875.1685898396516, 867.9826403471958, 868.9478631282143, 869.2698133567802, 870.8606622940331, 871.533729454745, 640.4524131867233, 641.8042497038401, 641.9582727122722, 643.1092936283235, 643.4305639509022, 12636.936815315956, 12736.936315318364, 12762.17045892014, 12773.48906043757, 13457.327133643377, 11846.466908989116, 11873.881261187364, 11915.344656043913, 11951.282923024646, 11987.340696261703, 10604.257701960865, 10637.149028077734, 10649.414282214475, 10995.285306455055, 11112.166587505888, 3536.6463353664685, 3552.5559305086863, 3556.6798988091195, 3576.660217279354, 3593.7125029997537, 107441.0, 110941.44529277383, 115259.42370288094, 115804.05175689401, 117190.0, 8987.775305617412, 9037.638494460149, 9062.909370906207, 9250.583723732449, 9444.90555094454, 18922.432327030212, 18970.241190352506, 19158.808411915983, 19161.712574311397, 19378.96520865317, 7395.889061664079, 7455.813604659818, 7487.700491980259, 7670.970922618024, 7737.6518056686455, 4277.593628605277, 4337.219300525872, 4339.305711086211, 4342.5874541918465, 4395.318725597537, 3341.8496167672515, 3421.2815308784934, 3424.33225521026, 3455.4644030175364, 3461.0655123116617, 634.7143785296543, 638.450932198309, 639.2616527910271, 645.8675424192721, 647.388218133859, 480.32034670940226, 589.8672798620277, 610.3743662745721, 620.0606081786098, 627.8022422936851, 8820.8676869847, 8844.867326990101, 8878.245349145265, 8910.0, 8910.599023043978, 583.7168973048068, 607.6809674920702, 607.805502239288, 613.3804857094367, 616.3374372549528, 4066.430699702044, 4128.3601041838565, 4316.2446571849805, 4385.824567017284, 4400.603945644843, 107210.0, 108340.0, 108727.0, 109016.0, 109276.81446371028, 57766.13350799657, 61522.69238653868, 65369.69260614761, 67125.99999999903, 96272.51863740776, 55897.572897187114, 61066.77866442646, 76933.6153319241, 77720.61139694492, 79570.0, 9420.858687119562, 9719.319647624598, 9759.219262458844, 9798.608055677978, 9830.508474576385, 34246.828765857004, 49088.75455622699, 49528.75235623799, 49680.50319496759, 50027.0, 63101.36898630955, 65621.0, 68306.65846670735, 71577.0, 73839.6308018478, 12496.125271230927, 12618.242905425705, 12621.810672840098, 13000.479980800663, 13065.934670326587, 14278.785818212942, 14427.505161188017, 14465.49370772018, 14515.129092254498, 14572.854271457574, 11173.608923687632, 13106.082574219714, 13514.121582097132, 13563.118397304144, 13821.308934553434, 11365.261258018203, 12044.337561434206, 13034.283114428417, 13284.269365185008, 13303.334833258492, 11592.43502127202, 12707.618771436872, 13013.739725205633, 13117.60647180586, 13541.661458463617, 9187.908120918974, 9541.47521886303, 9805.166560842408, 10419.895801042196, 11390.601328953448, 8275.964759895769, 9184.0, 10569.260151789302, 10838.945805270923, 11115.610953616584], "value": 7079.412801775749, "unit": "score"}], "name": "dromaeo_css", "value": 7019.517105917807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 115.0, 115.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 115.0, 153.0, 124.0, 142.0, 145.0, 146.0, 137.0, 127.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 182.0, 185.0, 185.0, 184.0, 181.0, 182.0, 181.0, 185.0], "value": 181.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 61.0, 89.0, 61.0, 60.0, 58.0, 57.0, 74.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 85.0, 72.0, 69.0, 69.0, 83.0, 68.0, 70.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 89.0, 85.0, 86.0, 84.0, 89.0, 85.0, 127.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 97.0, 95.0, 94.0, 96.0, 95.0, 104.0, 146.0, 101.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 86.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 56.0, 55.0, 55.0, 55.0, 53.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 69.0, 79.0, 77.0, 69.0, 69.0, 71.0, 70.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 88.0, 88.0, 88.0, 88.0, 86.0, 88.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 149.0, 148.0, 153.0, 149.0, 148.0, 188.0, 152.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 175.0, 173.0, 177.0, 175.0, 175.0, 182.0, 175.0, 206.0, 164.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 70.0, 69.0, 67.0, 69.0, 68.0, 67.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1466.8000000000002, "alertThreshold": 2.0}]} 09:39:05 INFO - Return code: 0 09:39:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:05 INFO - # TBPL SUCCESS # 09:39:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:05 INFO - 2016-12-04 09:39:05.904 screenresolution[1661:10688] starting screenresolution argv=screenresolution get 09:39:05 INFO - 2016-12-04 09:39:05.907 screenresolution[1661:10688] Display 0: 1600x1200x32@60 09:39:05 INFO - 2016-12-04 09:39:05.913 screenresolution[1662:10691] starting screenresolution argv=screenresolution list 09:39:05 INFO - Available Modes on Display 0 09:39:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:06 INFO - Intel Iris: 09:39:06 INFO - Chipset Model: Intel Iris 09:39:06 INFO - Type: GPU 09:39:06 INFO - Bus: Built-In 09:39:06 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:06 INFO - Vendor: Intel (0x8086) 09:39:06 INFO - Device ID: 0x0a2e 09:39:06 INFO - Revision ID: 0x0009 09:39:06 INFO - Displays: 09:39:06 INFO - Display: 09:39:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:06 INFO - Display Serial Number: 1600x1200 60 09:39:06 INFO - Main Display: Yes 09:39:06 INFO - Mirror: Off 09:39:06 INFO - Online: Yes 09:39:06 INFO - Rotation: Supported 09:39:06 INFO - Return code: 0 09:39:06 INFO - Running post-action listener: _resource_record_post_action 09:39:06 INFO - [mozharness: 2016-12-04 17:39:06.159625Z] Finished run-tests step (success) 09:39:06 INFO - Running post-run listener: _resource_record_post_run 09:39:06 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 32451584; Write bytes: 696239104; Read time: 195; Write time: 1981 09:39:06 INFO - TinderboxPrint: CPU usage
53.5% 09:39:06 INFO - TinderboxPrint: I/O read bytes / time
32,451,584 / 195 09:39:06 INFO - TinderboxPrint: I/O write bytes / time
696,239,104 / 1,981 09:39:06 INFO - TinderboxPrint: CPU idle
2,262.8 (46.5%) 09:39:06 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 09:39:06 INFO - TinderboxPrint: CPU user
1,626.9 (33.5%) 09:39:06 INFO - TinderboxPrint: Swap in / out
412,610,560 / 0 09:39:06 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 372830720; Write bytes: 367830528; Read time: 28705; Write time: 791 09:39:06 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 30661632; Write bytes: 309067264; Read time: 180; Write time: 1138 09:39:06 INFO - Running post-run listener: _upload_blobber_files 09:39:06 INFO - Blob upload gear active. 09:39:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:06 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 09:39:06 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'] 09:39:06 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 09:39:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:08 INFO - (blobuploader) - INFO - Done attempting. 09:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:09 INFO - (blobuploader) - INFO - Done attempting. 09:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:12 INFO - (blobuploader) - INFO - Done attempting. 09:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:12 INFO - Return code: 0 09:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed1a204a955286b5dfa7a8f8c383b93dc4d70111d959c409e65378d8f5676a321c1d5cf62da55b3d14b0ab380473f248df36daf4ccf824ee82e9dd45087270a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a3a9ddbdf3ca812884f8a2876009c16cd25196bec18a3f25ba468a821f97ea15ef83465e2e98511fae2adc288d766bb4ee79e13080f1ee30ced16e89d7cfa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/951ce95f379c2542368817bc41deaef2c4ce9da7fd0dbaf5b33676d5d4df9fd514f950728609a946f8bc7b2dcd8b0cc65703348383d21446a08071416c2cc9f6"} 09:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:12 INFO - Contents: 09:39:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed1a204a955286b5dfa7a8f8c383b93dc4d70111d959c409e65378d8f5676a321c1d5cf62da55b3d14b0ab380473f248df36daf4ccf824ee82e9dd45087270a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a3a9ddbdf3ca812884f8a2876009c16cd25196bec18a3f25ba468a821f97ea15ef83465e2e98511fae2adc288d766bb4ee79e13080f1ee30ced16e89d7cfa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/951ce95f379c2542368817bc41deaef2c4ce9da7fd0dbaf5b33676d5d4df9fd514f950728609a946f8bc7b2dcd8b0cc65703348383d21446a08071416c2cc9f6"} 09:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:12 INFO - Copying logs to upload dir... 09:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.361355 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-04 09:39:12.714287) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 09:39:12.718039) ========= 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.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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/fed1a204a955286b5dfa7a8f8c383b93dc4d70111d959c409e65378d8f5676a321c1d5cf62da55b3d14b0ab380473f248df36daf4ccf824ee82e9dd45087270a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a3a9ddbdf3ca812884f8a2876009c16cd25196bec18a3f25ba468a821f97ea15ef83465e2e98511fae2adc288d766bb4ee79e13080f1ee30ced16e89d7cfa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/951ce95f379c2542368817bc41deaef2c4ce9da7fd0dbaf5b33676d5d4df9fd514f950728609a946f8bc7b2dcd8b0cc65703348383d21446a08071416c2cc9f6"} build_url:https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010825 build_url: 'https://queue.taskcluster.net/v1/task/FfWKc-M5S4C5FRAmfUmndg/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/fed1a204a955286b5dfa7a8f8c383b93dc4d70111d959c409e65378d8f5676a321c1d5cf62da55b3d14b0ab380473f248df36daf4ccf824ee82e9dd45087270a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a3a9ddbdf3ca812884f8a2876009c16cd25196bec18a3f25ba468a821f97ea15ef83465e2e98511fae2adc288d766bb4ee79e13080f1ee30ced16e89d7cfa5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/951ce95f379c2542368817bc41deaef2c4ce9da7fd0dbaf5b33676d5d4df9fd514f950728609a946f8bc7b2dcd8b0cc65703348383d21446a08071416c2cc9f6"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 09:39:12.787185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 09:39:12.787469) ========= 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.X9uymO7y8P/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.8AkaYopI5y/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.005109 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 09:39:12.888172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 09:39:12.888479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 09:39:12.898744) ========= ========= Total master_lag: 4.80 =========