builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0065 starttime: 1488645579.69 results: success (0) buildid: 20170304075924 builduid: dee96865dce64f27bd52b2ec620ec9c8 revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:39.690695) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:39.691085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:39.691361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:39.717220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:39.717715) ========= 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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-04 08:39:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.8M=0s 2017-03-04 08:39:40 (70.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.610123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:40.352029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:40.352347) ========= 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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.020409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:40.404278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 08:39:40.407669) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb23648534779c110f3a1f2baae1849ae4a9c570 --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 eb23648534779c110f3a1f2baae1849ae4a9c570 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-04 08:39:40,494 truncating revision to first 12 chars 2017-03-04 08:39:40,494 Setting DEBUG logging. 2017-03-04 08:39:40,494 attempt 1/10 2017-03-04 08:39:40,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb2364853477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-04 08:39:41,564 unpacking tar archive at: mozilla-central-eb2364853477/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 08:39:41.755554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:41.755870) ========= script_repo_revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:41.756243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:41.756504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 08:39:41.776722) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-04 08:39:41.777110) ========= /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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:39:41 INFO - MultiFileLogger online at 20170304 08:39:41 in /builds/slave/test 08:39:41 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 08:39:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:41 INFO - {'append_to_log': False, 08:39:41 INFO - 'base_work_dir': '/builds/slave/test', 08:39:41 INFO - 'blob_upload_branch': 'Firefox', 08:39:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:41 INFO - 'branch': 'Firefox', 08:39:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:41 INFO - 'config_files': ('talos/mac_config.py',), 08:39:41 INFO - 'default_actions': ('clobber', 08:39:41 INFO - 'read-buildbot-config', 08:39:41 INFO - 'download-and-extract', 08:39:41 INFO - 'populate-webroot', 08:39:41 INFO - 'create-virtualenv', 08:39:41 INFO - 'install', 08:39:41 INFO - 'run-tests'), 08:39:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:41 INFO - 'download_minidump_stackwalk': True, 08:39:41 INFO - 'download_symbols': 'ondemand', 08:39:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:41 INFO - 'gecko_profile': False, 08:39:41 INFO - 'gecko_profile_interval': 0, 08:39:41 INFO - 'installer_path': 'installer.exe', 08:39:41 INFO - 'log_level': 'info', 08:39:41 INFO - 'log_name': 'talos', 08:39:41 INFO - 'log_to_console': True, 08:39:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:39:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:39:41 INFO - 'opt_config_files': (), 08:39:41 INFO - 'pip_index': False, 08:39:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:41 INFO - 'cmd': ('bash', 08:39:41 INFO - '-c', 08:39:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:41 INFO - 'enabled': True, 08:39:41 INFO - 'halt_on_failure': False, 08:39:41 INFO - 'name': 'check_screen_resolution'},), 08:39:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:41 INFO - 'cmd': ('bash', 08:39:41 INFO - '-c', 08:39:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:41 INFO - 'enabled': True, 08:39:41 INFO - 'halt_on_failure': False, 08:39:41 INFO - 'name': 'check_screen_resolution'},), 08:39:41 INFO - 'run_cmd_checks_enabled': True, 08:39:41 INFO - 'suite': 'dromaeojs', 08:39:41 INFO - 'system_bits': '32', 08:39:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:41 INFO - 'title': 't-yosemite-r7-0065', 08:39:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:41 INFO - 'use_talos_json': True, 08:39:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:41 INFO - 'work_dir': 'build'} 08:39:41 INFO - [mozharness: 2017-03-04 16:39:41.985151Z] Running clobber step. 08:39:41 INFO - Running pre-action listener: _resource_record_pre_action 08:39:41 INFO - Running main action method: clobber 08:39:41 INFO - rmtree: /builds/slave/test/build 08:39:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:39:43 INFO - Running post-action listener: _resource_record_post_action 08:39:43 INFO - [mozharness: 2017-03-04 16:39:43.644248Z] Finished clobber step (success) 08:39:43 INFO - [mozharness: 2017-03-04 16:39:43.644390Z] Running read-buildbot-config step. 08:39:43 INFO - Running pre-action listener: _resource_record_pre_action 08:39:43 INFO - Running main action method: read_buildbot_config 08:39:43 INFO - Using buildbot properties: 08:39:43 INFO - { 08:39:43 INFO - "project": "", 08:39:43 INFO - "product": "firefox", 08:39:43 INFO - "script_repo_revision": "production", 08:39:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:39:43 INFO - "repository": "", 08:39:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:39:43 INFO - "buildid": "20170304075924", 08:39:43 INFO - "pgo_build": "False", 08:39:43 INFO - "basedir": "/builds/slave/test", 08:39:43 INFO - "buildnumber": 4, 08:39:43 INFO - "slavename": "t-yosemite-r7-0065", 08:39:43 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:39:43 INFO - "platform": "yosemite_r7", 08:39:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:39:43 INFO - "branch": "mozilla-central", 08:39:43 INFO - "repo_path": "mozilla-central", 08:39:43 INFO - "revision": "eb23648534779c110f3a1f2baae1849ae4a9c570", 08:39:43 INFO - "stage_platform": "macosx64", 08:39:43 INFO - "builduid": "dee96865dce64f27bd52b2ec620ec9c8", 08:39:43 INFO - "slavebuilddir": "test" 08:39:43 INFO - } 08:39:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:39:43 INFO - Running post-action listener: _resource_record_post_action 08:39:43 INFO - [mozharness: 2017-03-04 16:39:43.647884Z] Finished read-buildbot-config step (success) 08:39:43 INFO - [mozharness: 2017-03-04 16:39:43.648024Z] Running download-and-extract step. 08:39:43 INFO - Running pre-action listener: _resource_record_pre_action 08:39:43 INFO - Running main action method: download_and_extract 08:39:43 INFO - mkdir: /builds/slave/test/build/tests 08:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:43 INFO - trying https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:39:44 INFO - Downloaded 1199 bytes. 08:39:44 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:39:44 INFO - Using the following test package requirements: 08:39:44 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:39:44 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:39:44 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:39:44 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'jsshell-mac.zip'], 08:39:44 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:39:44 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:39:44 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:39:44 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:39:44 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:39:44 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:39:44 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:39:44 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:39:46 INFO - Expected file size: 51775332 08:39:46 INFO - Obtained file size: 51775332 08:40:02 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:40:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:40:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:02 INFO - Fetch https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:40:04 INFO - Expected file size: 51775332 08:40:04 INFO - Obtained file size: 51775332 08:40:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:40:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:40:19 INFO - Fetch https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:40:20 INFO - Expected file size: 14404424 08:40:20 INFO - Obtained file size: 14404424 08:40:20 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')]} 08:40:20 INFO - trying https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:40:20 INFO - Downloading https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:40:23 INFO - Downloaded 75121876 bytes. 08:40:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:40:23 INFO - mkdir: /builds/slave/test/properties 08:40:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:23 INFO - Contents: 08:40:23 INFO - build_url:https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - Running post-action listener: set_extra_try_arguments 08:40:23 INFO - [mozharness: 2017-03-04 16:40:23.827038Z] Finished download-and-extract step (success) 08:40:23 INFO - [mozharness: 2017-03-04 16:40:23.827179Z] Running populate-webroot step. 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: populate_webroot 08:40:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:23 INFO - '--tppagecycles', 08:40:23 INFO - '7'], 08:40:23 INFO - 'tests': ['tsvgm']}}, 08:40:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['damp', 'tps']}, 08:40:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'tests': ['damp', 'tps']}, 08:40:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['dromaeo_dom']}, 08:40:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['basic_compositor_video']}, 08:40:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['a11yr', 08:40:23 INFO - 'ts_paint', 08:40:23 INFO - 'tpaint', 08:40:23 INFO - 'sessionrestore', 08:40:23 INFO - 'sessionrestore_no_auto_restore', 08:40:23 INFO - 'tabpaint']}, 08:40:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tsvgx', 08:40:23 INFO - 'tsvgr_opacity', 08:40:23 INFO - 'tart', 08:40:23 INFO - 'tscrollx', 08:40:23 INFO - 'cart', 08:40:23 INFO - 'tsvg_static']}, 08:40:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:23 INFO - 'tsvgr_opacity', 08:40:23 INFO - 'tart', 08:40:23 INFO - 'tscrollx', 08:40:23 INFO - 'cart', 08:40:23 INFO - 'tsvg_static']}, 08:40:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s'], 08:40:23 INFO - 'tests': ['tp5o']}, 08:40:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'talos_options': ['--disable-e10s', 08:40:23 INFO - '--xperf_path', 08:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:23 INFO - 'tests': ['tp5n']}, 08:40:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:23 INFO - 'talos_options': ['--xperf_path', 08:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:23 INFO - 'tests': ['tp5n']}}, 08:40:23 INFO - 'talos.zip': {'path': '', 08:40:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:23 INFO - Running post-action listener: _resource_record_post_action 08:40:23 INFO - [mozharness: 2017-03-04 16:40:23.845612Z] Finished populate-webroot step (success) 08:40:23 INFO - [mozharness: 2017-03-04 16:40:23.845755Z] Running create-virtualenv step. 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: create_virtualenv 08:40:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:23 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 08:40:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:23 INFO - Using real prefix '/tools/python27' 08:40:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:27 INFO - Installing pip.................done. 08:40:27 INFO - Return code: 0 08:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:27 INFO - Reading from file tmpfile_stdout 08:40:27 INFO - Output received: 08:40:27 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) 08:40:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:27 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:27 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 08:40:27 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 08:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:27 INFO - 'HOME': '/Users/cltbld', 08:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:27 INFO - 'LOGNAME': 'cltbld', 08:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:27 INFO - 'MOZ_NO_REMOTE': '1', 08:40:27 INFO - 'NO_EM_RESTART': '1', 08:40:27 INFO - 'PAGER': '/bin/cat', 08:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:27 INFO - 'PWD': '/builds/slave/test', 08:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:27 INFO - 'SHELL': '/bin/bash', 08:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:27 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:27 INFO - 'USER': 'cltbld', 08:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:27 INFO - 'XPC_FLAGS': '0x0', 08:40:27 INFO - 'XPC_SERVICE_NAME': '0', 08:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:28 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 08:40:28 INFO - Cleaning up... 08:40:28 INFO - Return code: 0 08:40:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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', '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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40: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 psutil>=3.1.1 08:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:28 INFO - 'HOME': '/Users/cltbld', 08:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:28 INFO - 'LOGNAME': 'cltbld', 08:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:28 INFO - 'MOZ_NO_REMOTE': '1', 08:40:28 INFO - 'NO_EM_RESTART': '1', 08:40:28 INFO - 'PAGER': '/bin/cat', 08:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:28 INFO - 'PWD': '/builds/slave/test', 08:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:28 INFO - 'SHELL': '/bin/bash', 08:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:28 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:28 INFO - 'USER': 'cltbld', 08:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:28 INFO - 'XPC_FLAGS': '0x0', 08:40:28 INFO - 'XPC_SERVICE_NAME': '0', 08:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:28 INFO - Downloading/unpacking psutil>=3.1.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:32 INFO - Installing collected packages: psutil 08:40:32 INFO - Running setup.py install for psutil 08:40:32 INFO - building 'psutil._psutil_osx' extension 08:40:32 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 08:40:32 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 08:40:33 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 08:40:33 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 08:40:33 INFO - building 'psutil._psutil_posix' extension 08:40:33 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 08:40:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:40:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:40:33 INFO - ^ 08:40:33 INFO - 1 warning generated. 08:40:33 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 08:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:33 INFO - Successfully installed psutil 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:33 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:33 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 08:40:33 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 08:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:33 INFO - 'HOME': '/Users/cltbld', 08:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PAGER': '/bin/cat', 08:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:33 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - 'XPC_FLAGS': '0x0', 08:40:33 INFO - 'XPC_SERVICE_NAME': '0', 08:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:33 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 08:40:33 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 08:40:33 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 08:40:33 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 08:40:33 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 08:40:33 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 08:40:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:36 INFO - Installing collected packages: mozsystemmonitor 08:40:36 INFO - Running setup.py install for mozsystemmonitor 08:40:36 INFO - Successfully installed mozsystemmonitor 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:36 INFO - 'HOME': '/Users/cltbld', 08:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PAGER': '/bin/cat', 08:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:36 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - 'XPC_FLAGS': '0x0', 08:40:36 INFO - 'XPC_SERVICE_NAME': '0', 08:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:39 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 08:40:39 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 08:40:39 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 08:40:39 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 08:40:39 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 08:40:39 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 08:40:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:39 INFO - warning: no files found matching '*.txt' 08:40:39 INFO - no previously-included directories found matching 'build' 08:40:39 INFO - no previously-included directories found matching 'dist' 08:40:39 INFO - no previously-included directories found matching '.git*' 08:40:39 INFO - Installing collected packages: jsonschema, functools32 08:40:40 INFO - Running setup.py install for functools32 08:40:40 INFO - warning: no files found matching '*.txt' 08:40:40 INFO - no previously-included directories found matching 'build' 08:40:40 INFO - no previously-included directories found matching 'dist' 08:40:40 INFO - no previously-included directories found matching '.git*' 08:40:40 INFO - Successfully installed jsonschema functools32 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:40 INFO - 'HOME': '/Users/cltbld', 08:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PAGER': '/bin/cat', 08:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:40 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - 'XPC_FLAGS': '0x0', 08:40:40 INFO - 'XPC_SERVICE_NAME': '0', 08:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:40 INFO - Cleaning up... 08:40:40 INFO - Return code: 0 08:40:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:40 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:40 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 08:40:40 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 08:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:40 INFO - 'HOME': '/Users/cltbld', 08:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:40 INFO - 'LOGNAME': 'cltbld', 08:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:40 INFO - 'MOZ_NO_REMOTE': '1', 08:40:40 INFO - 'NO_EM_RESTART': '1', 08:40:40 INFO - 'PAGER': '/bin/cat', 08:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:40 INFO - 'PWD': '/builds/slave/test', 08:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:40 INFO - 'SHELL': '/bin/bash', 08:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:40 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:40 INFO - 'USER': 'cltbld', 08:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:40 INFO - 'XPC_FLAGS': '0x0', 08:40:40 INFO - 'XPC_SERVICE_NAME': '0', 08:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:40 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 08:40:40 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 08:40:40 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 08:40:40 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 08:40:40 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 08:40:40 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 08:40:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - Downloading docopt-0.6.1.tar.gz 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:44 INFO - Running setup.py install for blobuploader 08:40:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:44 INFO - Running setup.py install for requests 08:40:45 INFO - Running setup.py install for docopt 08:40:45 INFO - Successfully installed blobuploader requests docopt 08:40:45 INFO - Cleaning up... 08:40:45 INFO - Return code: 0 08:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:45 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:45 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 08:40:45 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 08:40:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:45 INFO - 'HOME': '/Users/cltbld', 08:40:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:45 INFO - 'LOGNAME': 'cltbld', 08:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:45 INFO - 'MOZ_NO_REMOTE': '1', 08:40:45 INFO - 'NO_EM_RESTART': '1', 08:40:45 INFO - 'PAGER': '/bin/cat', 08:40:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:45 INFO - 'PWD': '/builds/slave/test', 08:40:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:45 INFO - 'SHELL': '/bin/bash', 08:40:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:45 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:45 INFO - 'USER': 'cltbld', 08:40:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:45 INFO - 'XPC_FLAGS': '0x0', 08:40:45 INFO - 'XPC_SERVICE_NAME': '0', 08:40:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:45 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-1XlNJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-IUjyPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-234QT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6Ay_m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-sa2ldI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-YvF9If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-trTeI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-k8Gfxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-PJlJyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FTYNob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:46 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nXb2NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-O1vzwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-x7u90k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-8PjP7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-9uTmEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-F7aBqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:47 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-eqT8Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:47 INFO - Running setup.py install for manifestparser 08:40:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:47 INFO - Running setup.py install for mozcrash 08:40:48 INFO - Running setup.py install for mozdebug 08:40:48 INFO - Running setup.py install for mozdevice 08:40:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Running setup.py install for mozfile 08:40:48 INFO - Running setup.py install for mozhttpd 08:40:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Running setup.py install for mozinfo 08:40:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Running setup.py install for mozInstall 08:40:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:48 INFO - Running setup.py install for mozleak 08:40:49 INFO - Running setup.py install for mozlog 08:40:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for moznetwork 08:40:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozprocess 08:40:49 INFO - Running setup.py install for mozprofile 08:40:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozrunner 08:40:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozscreenshot 08:40:50 INFO - Running setup.py install for moztest 08:40:50 INFO - Running setup.py install for mozversion 08:40:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:50 INFO - Cleaning up... 08:40:50 INFO - Return code: 0 08:40:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:50 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:50 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 08:40:50 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 08:40:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:50 INFO - 'HOME': '/Users/cltbld', 08:40:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:50 INFO - 'LOGNAME': 'cltbld', 08:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:50 INFO - 'MOZ_NO_REMOTE': '1', 08:40:50 INFO - 'NO_EM_RESTART': '1', 08:40:50 INFO - 'PAGER': '/bin/cat', 08:40:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:50 INFO - 'PWD': '/builds/slave/test', 08:40:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:50 INFO - 'SHELL': '/bin/bash', 08:40:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:50 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:50 INFO - 'USER': 'cltbld', 08:40:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:50 INFO - 'XPC_FLAGS': '0x0', 08:40:50 INFO - 'XPC_SERVICE_NAME': '0', 08:40:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:50 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Tm93RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:50 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)) 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:50 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-hPy_87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:50 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)) 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:50 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-kKpeIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:50 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)) 08:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:50 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-bla00R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-RsXRxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-DiUrZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0MFXwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-iaoSMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-c9SHk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dBxQDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Ls71am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-O1ljcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:51 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-di_qHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:51 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)) 08:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qirrCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:52 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)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-NKQmUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:52 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)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-49hC0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:52 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-bkojPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:52 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)) 08:40:52 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)) 08:40:52 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)) 08:40:52 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)) 08:40:52 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)) 08:40:52 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)) 08:40:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - Downloading blessings-1.6.tar.gz 08:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:55 INFO - Installing collected packages: blessings 08:40:55 INFO - Running setup.py install for blessings 08:40:55 INFO - Successfully installed blessings 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:55 INFO - Reading from file tmpfile_stdout 08:40:55 INFO - Current package versions: 08:40:55 INFO - blessings == 1.6 08:40:55 INFO - blobuploader == 1.2.4 08:40:55 INFO - docopt == 0.6.1 08:40:55 INFO - functools32 == 3.2.3-2 08:40:55 INFO - jsonschema == 2.5.1 08:40:55 INFO - manifestparser == 1.1 08:40:55 INFO - mozInstall == 1.12 08:40:55 INFO - mozcrash == 1.0 08:40:55 INFO - mozdebug == 0.1 08:40:55 INFO - mozdevice == 0.49 08:40:55 INFO - mozfile == 1.2 08:40:55 INFO - mozhttpd == 0.7 08:40:55 INFO - mozinfo == 0.9 08:40:55 INFO - mozleak == 0.1 08:40:55 INFO - mozlog == 3.4 08:40:55 INFO - moznetwork == 0.27 08:40:55 INFO - mozprocess == 0.25 08:40:55 INFO - mozprofile == 0.28 08:40:55 INFO - mozrunner == 6.13 08:40:55 INFO - mozscreenshot == 0.1 08:40:55 INFO - mozsystemmonitor == 0.3 08:40:55 INFO - moztest == 0.8 08:40:55 INFO - mozversion == 1.4 08:40:55 INFO - psutil == 3.1.1 08:40:55 INFO - requests == 1.2.3 08:40:55 INFO - wsgiref == 0.1.2 08:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:55 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')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:55 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 08:40:55 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 08:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:55 INFO - 'HOME': '/Users/cltbld', 08:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PAGER': '/bin/cat', 08:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:55 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - 'XPC_FLAGS': '0x0', 08:40:55 INFO - 'XPC_SERVICE_NAME': '0', 08:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 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)) 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:55 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')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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 0x1072fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5984a9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, '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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:55 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 08:40:55 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 08:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:55 INFO - 'HOME': '/Users/cltbld', 08:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PAGER': '/bin/cat', 08:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:40:55 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - 'XPC_FLAGS': '0x0', 08:40:55 INFO - 'XPC_SERVICE_NAME': '0', 08:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:56 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Running post-action listener: _resource_record_post_action 08:40:56 INFO - Running post-action listener: _start_resource_monitoring 08:40:56 INFO - Starting resource monitoring. 08:40:56 INFO - [mozharness: 2017-03-04 16:40:56.274474Z] Finished create-virtualenv step (success) 08:40:56 INFO - [mozharness: 2017-03-04 16:40:56.275447Z] Running install step. 08:40:56 INFO - Running pre-action listener: _resource_record_pre_action 08:40:56 INFO - Running main action method: install 08:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:56 INFO - Reading from file tmpfile_stdout 08:40:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:56 INFO - Reading from file tmpfile_stdout 08:40:56 INFO - Output received: 08:40:56 INFO - Usage: mozinstall [options] installer 08:40:56 INFO - Options: 08:40:56 INFO - -h, --help show this help message and exit 08:40:56 INFO - -d DEST, --destination=DEST 08:40:56 INFO - Directory to install application into. [default: 08:40:56 INFO - "/builds/slave/test"] 08:40:56 INFO - --app=APP Application being installed. [default: firefox] 08:40:56 INFO - mkdir: /builds/slave/test/build/application 08:40:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:41:17 INFO - Reading from file tmpfile_stdout 08:41:17 INFO - Output received: 08:41:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:41:17 INFO - Running post-action listener: _resource_record_post_action 08:41:17 INFO - [mozharness: 2017-03-04 16:41:17.003200Z] Finished install step (success) 08:41:17 INFO - [mozharness: 2017-03-04 16:41:17.003322Z] Running run-tests step. 08:41:17 INFO - Running pre-action listener: _resource_record_pre_action 08:41:17 INFO - Running main action method: run_tests 08:41:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:17 INFO - 2017-03-04 08:41:17.018 screenresolution[1914:25530] starting screenresolution argv=screenresolution get 08:41:17 INFO - 2017-03-04 08:41:17.020 screenresolution[1914:25530] Display 0: 1600x1200x32@60 08:41:17 INFO - 2017-03-04 08:41:17.026 screenresolution[1915:25533] starting screenresolution argv=screenresolution list 08:41:17 INFO - Available Modes on Display 0 08:41:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:17 INFO - Intel Iris: 08:41:17 INFO - Chipset Model: Intel Iris 08:41:17 INFO - Type: GPU 08:41:17 INFO - Bus: Built-In 08:41:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:17 INFO - Vendor: Intel (0x8086) 08:41:17 INFO - Device ID: 0x0a2e 08:41:17 INFO - Revision ID: 0x0009 08:41:17 INFO - Displays: 08:41:17 INFO - Display: 08:41:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:17 INFO - Display Serial Number: 1600x1200 60 08:41:17 INFO - Main Display: Yes 08:41:17 INFO - Mirror: Off 08:41:17 INFO - Online: Yes 08:41:17 INFO - Rotation: Supported 08:41:17 INFO - Return code: 0 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:17 INFO - Python 2.7.3 08:41:17 INFO - Return code: 0 08:41:17 INFO - grabbing minidump binary from tooltool 08:41:17 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')]} 08:41:17 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 0x1070d8d30>, '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 0x106fffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070cdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:17 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 08:41:17 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 08:41:17 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 08:41:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:17 INFO - Return code: 0 08:41:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:17 INFO - ENV: RUST_BACKTRACE is now 1 08:41:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:17 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/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 08:41:17 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/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 08:41:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f92Mk5xB7Y/Render', 08:41:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:17 INFO - 'HOME': '/Users/cltbld', 08:41:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PAGER': '/bin/cat', 08:41:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:17 INFO - 'RUST_BACKTRACE': '1', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oHC5C7Tyvh/Listeners', 08:41:17 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - 'XPC_FLAGS': '0x0', 08:41:17 INFO - 'XPC_SERVICE_NAME': '0', 08:41:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:17 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/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 08:41:17 INFO - mozversion application_buildid: 20170304075924 08:41:17 INFO - mozversion application_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 08:41:17 INFO - mozversion application_display_name: Nightly 08:41:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:17 INFO - mozversion application_name: Firefox 08:41:17 INFO - mozversion application_remotingname: firefox 08:41:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:17 INFO - mozversion application_vendor: Mozilla 08:41:17 INFO - mozversion application_version: 54.0a1 08:41:17 INFO - mozversion platform_buildid: 20170304075924 08:41:17 INFO - mozversion platform_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 08:41:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:17 INFO - mozversion platform_version: 54.0a1 08:41:17 INFO - using testdate: 1488645677 08:41:17 INFO - actual date: 1488645677 08:41:17 INFO - starting webserver on 'localhost:57532' 08:41:17 INFO - SUITE-START | Running 2 tests 08:41:17 INFO - TEST-START | dromaeo_css 08:41:17 INFO - operating with platform_type : mac_ 08:41:17 INFO - Initialising browser for dromaeo_css test... 08:41:17 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp0ldtDY/profile http://localhost:57532/getInfo.html) 08:41:20 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 08:41:20 INFO - PROCESS | 1925 | colorDepth:24 08:41:20 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 08:41:20 INFO - PROCESS | 1925 | __metrics 08:41:20 INFO - PROCESS | 1925 | 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" 08:41:20 INFO - PROCESS | 1925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:20 INFO - TEST-INFO | 1925: exit 0 08:41:20 INFO - Browser initialized. 08:41:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:20 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp0ldtDY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:33 INFO - PROCESS | 1927 | RSS: Main: 232304640 08:41:33 INFO - PROCESS | 1927 | 08:44:38 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57532/tests/dromaeo/cssquery-ext.html) 08:44:41 INFO - PROCESS | 1927 | RSS: Main: 464822272 08:44:41 INFO - PROCESS | 1927 | 08:46:22 INFO - PROCESS | 1927 | ************************* 08:46:22 INFO - PROCESS | 1927 | A coding exception was thrown and uncaught in a Task. 08:46:22 INFO - PROCESS | 1927 | 08:46:22 ERROR - PROCESS | 1927 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:46:22 INFO - PROCESS | 1927 | Full stack: 08:46:22 INFO - PROCESS | 1927 | ************************* 08:47:44 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-ext.html (next: http://localhost:57532/tests/dromaeo/cssquery-jquery.html) 08:47:45 INFO - PROCESS | 1927 | RSS: Main: 382496768 08:47:45 INFO - PROCESS | 1927 | 08:50:47 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57532/tests/dromaeo/cssquery-mootools.html) 08:50:48 INFO - PROCESS | 1927 | RSS: Main: 349806592 08:50:48 INFO - PROCESS | 1927 | 08:53:50 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57532/tests/dromaeo/cssquery-prototype.html) 08:53:51 INFO - PROCESS | 1927 | RSS: Main: 359706624 08:53:51 INFO - PROCESS | 1927 | 08:56:55 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57532/tests/dromaeo/cssquery-yui.html) 08:56:56 INFO - PROCESS | 1927 | RSS: Main: 346755072 08:56:56 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:57532/tests/dromaeo/cssquery-yui.html (next: http://localhost:57532/tests/dromaeo/cssquery-dojo.html) 08:59:59 INFO - PROCESS | 1927 | RSS: Main: 537477120 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | __start_tp_report 08:59:59 INFO - PROCESS | 1927 | _x_x_mozilla_page_load 08:59:59 INFO - PROCESS | 1927 | _x_x_mozilla_page_load_details 08:59:59 INFO - PROCESS | 1927 | |i|pagename|runs| 08:59:59 INFO - PROCESS | 1927 | |0;dojo.html;3040.5287180487026;3335.7991123195648;3352.865885364586;3383.9492407613875;3417.3848707232687;5616.241807356006;5704.201411802341;5793.652380857152;5879.794207202749;5898.351181370052;5685.459881311269;5754.913676294859;5825.854353641151;5845.7953971611005;5886.88226235475;5204.713740744258;5239.214117882329;5271.499207575293;5289.471052894699;5292.10034294169;5390.460953904598;5398.055340315429;5398.055340315429;5398.838034858961;5447.5641948644015;5174.223866420067;5221.6083793715625;5269.499397557264;5358.946410535903;5371.086915224421;5206.193040078794;5239.030779305841;5254.264402983586;5256.132738098209;5256.894862102775;5179.171332586768;5204.843854684365;5214.713190774506;5243.6067294952645;5246.344206974129;4903.65674402792;5616.887662246773;5743.62666426681;5757.309122905278;5759.539236861083;6249.625022498664;6254.937450625481;6270.811875643738;6272.5922815016875;6274;6174.938250617526;6306.747730090791;6319;6327.525435592349;6329.746810127589;5919.230500035011;5930.1994230779155;6029.78895738647;6068.21113255274;6076.817695469187;6328.286080865849;6370.554061215763;6371.23545174582;6381.712822922979;6385.96807015962;6115.827502811652;6125.1731016313115;6183.474404675563;6301.873962520815;6336.968315158395;6272.874542509125;6279.497640188774;6281.403266689657;6282.654454004982;6295.433410992941;6226.346233645492;6238.407351301619;6243.562950593506;6248.781292654826;6256.74973001084;5622.212890195376;6204.627722336674;6209.379062093754;6261.436470717657;6266.279377871512;4939.234418665113;5076.949230507722;5112.974435127875;5132.435432102466;5135.6918584885025;4470.262406702857;4501.729896206238;4541.6593755468475;4613.884652883705;4620.376249206314;5603.971980140073;5708.343540492813;5839.591228614041;5847.006008978484;5849.88300233993;6297.2128483939505;6300.180976473121;6301.747930082745;6303.36966303366;6307.337729538424;5678;5687.573431992617;5691.26013618227;5698.544116470673;5699.658020518782;5374.838754837361;5436;5437.021336159451;5446.21029950655;5456.399796022434;6047.606905551125;6184.907226391518;6248.375162483806;6268.9969604863;6346.619202847844;6235.407636274546;6280.371962803683;6287.748490060347;6299.811005669837;6315.052742088724;6403;6420.1974753155855;6432.195975503062;6441.291457939529;6444.4844412445955;6100.338962863055;6152.98475751496;6220.098085777628;6342.143810585697;6344.714487847966;6213.844653883689;6233.189685340877;6293.590916590407;6317.399847014526;6318.178636777189;6115.575014303803;6117.218487018478;6132.7345309381235;6180.598261113013;6248.250209974832;5248.527632513092;6210.658413787285;6247.9062814056915;6254.249490061222;6264.655443950626;6122.326544080059;6122.602030867979;6126.417990290915;6136.325004249618;6141.477974372228;6020.729067192075;6032.1856549365275;6068.544859135671;6273.184486016971;6290.9056364155485;5949.702514874326;5961.076033214858;5970.462658360769;5975.133605627073;5979.820605381846 08:59:59 INFO - PROCESS | 1927 | |1;ext.html;760.114466646357;779.5985067690141;837.1377481194368;846.7036537211981;846.8221673448576;37363.252734945316;37900;38019;38071.23857522855;38117.618823811754;34518.82740586293;34662.826685866596;34734;34736;34755.30489390211;7224.024756657836;9089.363744537884;9252.444853308789;9283.442993420416;9297.395669281475;7352.448566357518;7424.703011879518;7428.480006399554;7437.107547094356;10846.72883177923;10977.890221097807;11035;11039.889601104007;11040.392778397185;11041.558337666484;10935.617253396133;10989.395583242918;10994.976381495073;10996.505157267942;11004.779904401947;6462.836689395906;7108.111486064242;10772.838407423895;10850.511726972305;10857.805641379442;37021.259574808624;37406.25187496262;39279.60720392788;39282.803585982176;39326.606733932866;3757.210985693008;3793.203427280247;3806.638369354907;3835.8082095895093;3840.8655697050467;26889.865550672315;27200;27319.86340068307;27720.584191237147;27783.305417364525;3068.5243787213017;3111.3932783107302;3123.984380078085;3223.1942014496376;3228.2413632796274;319422.8057719416;323567.38216309005;325188;325632;325716;40059;40958.59041409607;42802.57197427986;49190.75404623026;49416.011679766925;50400.22798746031;51804.74097629563;53903.92192156135;53914.730426348404;54017.45982540203;13007.739845203043;13097.083204175617;13108.541201057917;13108.558058613546;13129.409176587076;11202;11205.327680339044;11231.831522527169;11239.719007024889;11241.550337986553;11568.190226684052;11630.941845290889;11679.474423650956;11782.705432364088;11804.291742495307;4359.629431498295;5072.213806859942;5097.357128973903;5130.153524668388;5130.87172820675;857.3269983063266;870.3854350180325;878.9736307910773;901.9458832469942;916.6745805239177;25141.87429062843;25588.232353029438;25712.74287257141;25779.484410312063;25795;891.826093911694;910.8269428808505;1022.8210063238903;1027.2552399510444;1043.95824167034;13315.334233288297;13932.95502837271;14390;14418.711625767426;14721.852781472047;414860.8513914883;416114;416525;416620;417320;46492.302615460794;46549;46555.30167047497;46614.300785488245;46657.83355416074;1320.227666814924;1364.3178410794603;1365.808786769853;1372.2315503317975;1374.752544541992;25467;26323.73676263213;26326.736732633195;26408;26490.735092648825;37864.43203351897;43885.780571098214;45014.77492612516;46783.76608116938;46830;419782;423139.76860231004;423313;423991;424281;18463.353782617545;18768.436946891616;19173.137208825916;21534.569308613427;21635;36922.630773692996;37071.62928370682;37935.62064379321;37973.81013094917;38700.80649596734;30322;31362.1182729037;31932.201694956882;32147.35705285928;32189.517157242193;25283.620745689197;30437.239069023453;31057;31576.368472629958;31602.209944750644;31580.842095789372;31585.368292634477;31687.049388518382;31694.36611267808;31695.52456713197;25522;27388.863055684593;28312;28407;28413;21620.567588648453;21919.12323507042;22037.559248814614;22159;22209.333719988426 08:59:59 INFO - PROCESS | 1927 | |2;jquery.html;379.11665818642564;392.95284565852086;411.3418530351438;420.1387156329525;436.3193418267503;11764.82350765108;20414.877181754997;21091.789082109193;22100.88949555254;22106.557868842614;21576.676349854766;21839.78160218397;22336.776632233672;22513.887430562867;22632.54734905301;5005.624578156653;6709.36261055199;6796.694148763293;6840.213375461811;6841;4121.258173528764;4333.718308309965;4352.107817897323;4366.781660916941;6654.3012983636745;4327.5888790565;4343.9348409773875;4345.6523478121835;4347.760873151976;6020.795840831829;4324.437823082995;7759.8448031039625;7795.532268063935;7798.9220107798765;7806.765797026098;7242.203357630657;7412.813949768011;7488.400927925807;7502.8124296892465;7547.3962083033775;26853.0601428951;26878.731212687817;26895.596566051525;26921.596176057374;27086.78109485078;2786.958195627067;2816.2114607909816;2957.7929544931862;3010.081925012892;3096.783225174239;15310.540683779505;16036.599085022968;16246.268917898722;16414;16488.505344839676;1852.1202428846325;1914.626647803679;1923.884566925975;1952.2093552111417;1979.9010049497467;131671.68328316786;162134.1893290526;165269;165452.17273913673;168590;14672.335493282866;18627.813721862607;18690.81309186918;19009.61980760377;19262.518437039187;28424.57363139513;29704.96032638847;29740.256493587833;31164.68835311618;31260.374792504022;8898.822023559493;9213.63145474187;9621.759456013515;9622.326437149331;9807.970163132768;7861.764147075597;7876.803079923047;7995.922079739375;8036;8036.517808931483;7336.96331518339;7505.761549344297;8146;8225.725012623054;8764.342674299452;3559.6796288334176;3664.670179683841;3669.9816500917323;3674.577423596267;3678.779273243614;864.386285737121;870.4951128345544;874.1651722604897;896.5741272895323;910.9544522773834;20328.593428131353;20801.06395212219;20982.68525972112;21060.789392106188;21361.67957480639;884.5311984648147;887.4763889305341;900.3607438718452;908.123660667459;908.6637943960644;10083.798324033478;10393.752749670088;10560.419176945341;10772.892271077346;10797.190210734227;601010;699870;703514;703711;724175;121171.39414303048;130765;138182.92725609124;150597;155193;1180.2918249050501;1188.085174415695;1209.6915286601861;1209.9879001209874;1218.415160722858;14189.787153192918;17676.82323176803;18043.278268869097;18213.54466138357;18320.45038648843;59717.402825971185;62178.37821621726;63427.682861585396;63754;63822.361776381644;76494.61752691201;81015.5695329141;87337.56331218558;89189.21621567663;90572;11100.167487438313;11137;11211.551537938718;11410.54357825711;11521.53913843437;11098.616046661686;12599.685007874876;12644;12732.108752387245;12898.548550800677;10428.687139385831;10538.89461105379;11120.555177792798;11274.492647830702;11288.98399144081;10488.947555262175;10794.56821727122;10857.262837945891;10990.780184396108;11074.723131921766;9001.36990410665;10685.091767199876;10950.06924411434;11335.263207891461;11443.027342675632;10959.178061645249;11221.158413118885;11355.602553910903;11370.431478426211;11421.942890285496;10510.369377837354;10594;10828;10905.400202988912;10972.506237219504 08:59:59 INFO - PROCESS | 1927 | |3;mootools.html;1398.454602704946;1557.0735412429608;1583.6357637743326;1599.1844159478667;1604.5988502874281;10375.636852710148;10934.343939363644;10937.45312734364;10946.343219406841;10949;10315.226358023141;10756.946215268932;10818.945905270482;10837.458127093652;10849.294795838265;2288.8855557222155;2320.3039088273536;2329.5457385809773;2329.685492458522;2332.0322066342533;2209.2267706302746;2241.7085778848727;2250.7524172341027;2253.1212826997485;2254.5603607296584;2102.6740855167473;2121.787821217881;2127.5213077057615;2131.007507980036;2135.3166986564306;2145.410012246629;2159.946001349971;2167.6640120781385;2170.7829217078324;2175.575762726269;1905.8189472000138;2244.4164517225477;2289.9313020609407;2296.0930432479245;2302.9424264393356;9606.663766768199;10495.583096282056;10759.408232547206;10827.621033263877;10839.078678312275;5592.664440133564;5755.107958266475;5766.913496297559;5779.739911703983;5792.218050563204;3288.2765791525826;3361.4117529432497;3569.3575156471825;3576.8748093816853;3581.3374525712825;1157.6353448663729;1192.379962419537;1195.2290772451806;1232.383808095952;1239.6590937492172;14654.267286635732;14717.116972981656;14850.331735071948;14888.330025148785;14916.105033698013;4352.564743525622;4553.271476563734;4622.168009758276;4636.327732478771;4667.206574882211;11365.147613928988;11368.431578421047;11375.715607109723;11380.94309528447;11390.886091138982;5638.6052976292085;5648.265725455664;5653.717314134276;5654.773809047674;5659.518940889988;4677.555632214934;5000.549950504472;5102.719350435687;5182.740862956837;5189.091908915924;3645.5807582128396;3715.5169827922737;3737.3085979093953;3783.0353259919093;3811.8475260989803;1009.4448053570507;1014.102519270451;1024.4672770159475;1029.5006921642996;1033.8294181460126;781.1173374087246;899.4558292233105;904.9909500904906;911.1458530416376;916.4455504419864;6217.6891155442045;6384.808455746335;6391.265004524539;6393.9101831517055;6509.674516274167;786.984260314802;916.5463095767504;954.8446379880422;980.4901451245313;987.2299606307092;3806.809659517013;4053.5544786931464;4061.6953728470485;4094.160697057096;4112.218678451085;12422.81365779514;12855.871441285655;13065.934670326587;13356.332183390792;13416.798748018788;13082.411291491906;13196.340182990813;13209.537666181637;13396;13399.464021439228;9711.223102151669;9750.853737193947;9905.068511640162;9908;9909.20726341891;6221.097940798469;6418.358164183544;6449.484041276781;6453.064305675744;6495.382938620824;9927.305088643725;11301.547938082385;11510;11914.16600837933;12035.819462707892;11532.827007594726;11770;12143.332116733665;12225.877741222474;12350.75298494043;8073.87889181651;8091.271785539329;8144.592770361577;8199.918000819915;8267.958660206661;9677.516124193902;9723.951380243054;9879.753006174904;9890.109890109925;9891.208703303575;7529.360004399688;8764.868526971974;8775.473471591726;8842.778930526789;8861.955690221508;8501.95749021251;8558.400911936105;8561;8588.65645374178;8615.8707619387;7480.476366654282;7658.846823063619;7678.1170165431695;7683;7685.385169186564;5529.834104976857;5586.888262234651;5814.127880817911;5817.272840894888;5819.621724587888;5487.506124448819;5685.573581981451;5735.8566035849435;5818.301803783404;5877.529797616095 08:59:59 INFO - PROCESS | 1927 | |4;prototype.html;330.2602171136655;330.98179600121995;355.26814761591123;372.3335229938412;374.47947353179075;4659.697119687222;4784.067106914154;4788.976055119724;4815.061063092694;4819.662623616348;4065.959340406595;4120.423140760296;4408.801603927823;4792.568668819806;4795.568398844103;3776.565694945082;4068.3083875741195;4347.3261644445;4348.543402942693;4376.343548467724;3726.5341832270965;4126.628603425691;4358.8474403395885;4361.193179261847;4375.4093197418415;3347.397468455677;3472.947905781415;3740.7942563159017;4193.43388642534;4295.656347492209;3587.641235876418;4157.817145998345;4218.186179942623;4251.471278838557;4259.978700106511;3640.3629364861044;4034.9193016139807;4048.817803198863;4064.073866815888;4133.524644665872;4516.345129956171;4838.29844672524;4918.262260660894;5002.549770520671;5008.649394542347;3887.4168874669026;4384.386185933972;4625.32932724753;5055;5079.6952182869145;4702.672177272238;5259.605529585297;5364;5417.539509141728;5430.8913821723345;4628.907421851578;4640.025594625099;4645.372874661945;4656.557627025461;4664.55686709762;4505.932411013838;5183.403908550527;5615.6630602164005;5622.662640241599;5662.112322715445;4265.232258193493;4338.457692788402;4580.885477863014;4588.541145885451;4612.469565999886;4419.624331931822;4672.299155126758;4681.6722829401615;4747.1486120413065;4760.143544017836;3915.138669492707;4510.548945105529;4629.25931850909;4887.682300650446;4911.68074075184;4884.389451318585;5010.413389071232;5016.974915125474;5044.092063428545;5398.298221231294;1441.740486712381;1543;1558.2676142213143;1628.7719719239317;1663.6672665466713;1142.8913953465292;1279.7824369857146;1300.8634093420055;1403.7964495148146;1413.9929300353638;4170.77060761655;4335.834840566341;4665.720056796603;4891.192953162759;4911.979132833353;4886.804527818847;4974.612186150668;5073.746312684425;5147.40804807452;5520.06158952979;4265.4881414230495;4362.556968097875;4648.931225604573;4921.4832442593015;4972.925406118911;2477.876106194683;2642.8546429946537;2780.944381112407;2791.567307067408;2874.8993785217417;4823.022560750075;5481.643693159932;5524.519552681785;5669.177969194444;5755.316597377681;4011.338129208706;4695.004623035196;5050.732131349004;5079.009593129304;5656.660600363992;5621.353544342372;5652.3217213934595;5656.717164141776;5764.13537969308;5773.910957637644;4638.6752927294765;4996.925046124238;5583.357913839798;5600.85997850057;5604.243427137284;4781.497942715965;4842.5157484251295;4885.216895832924;5424.067551025475;5539.362973257966;5165.380154381498;5684.63049901755;5739.856503587277;5807.083662391485;5819.359870414336;3807.8857634271017;4396.373341863531;4461.933071004002;4464.4865840428765;4522.4573051234065;5375.731213439234;5538.6399884007415;5573.693446860461;5594.608377413542;5598;4570.771461426849;5063.518965698253;5217.31308376179;5225.335079109757;5235.534050465875;4950.801967921243;5206.817761378334;5389.679528515539;5417.724555686542;5430.864228394322;4589.151007063704;4638.373819534319;4725.085082382838;5152.639315247897;5309.495597918191;5108.66793658411;5371.973140134274;5382.273393091882;5391;5399.406065332889;4241.727481755523;4663.906721865612;4714.5149277977325;5286.334804536558;5358.651687640291 08:59:59 INFO - PROCESS | 1927 | |5;yui.html;701.8140192848895;735.8454724507853;764.9426293028024;811.2495941254339;817.9369701547424;14539.78190327146;15558.299876505556;15594.14232217229;15594.45419410321;15604.141772202523;14101.78847317291;14183.361748721307;14239;14252.999999999975;14253.287335633202;936.5364144748343;943.8065196634708;947.7109481608106;951.9857202141974;952.1383148250844;959.3764053365298;960.5485421851719;975.024975024975;976.1946394224793;977.6529332087114;1013.0730381700735;1013.4628646817199;1013.6806905824642;1013.751630850439;1014.6093753904726;1006.5520843224768;1006.9144122749575;1007.365359823314;1008.6923488336055;1009;752.2627824731738;752.5221484357418;752.7704050264667;753.0248328414716;755.316438623047;15468.5359439217;15755.44855930037;15808.972416792987;15975.92012039944;16022.919885400615;13630.454781808816;13775.724485510334;13777.724445511134;13879.375428105659;13894.096883702527;9795.332565892686;11648.767024659544;11654.30074195551;11700.824487632608;11921.523139074427;3678.3562876496508;3692.593814680383;3695.8891233263043;3710.9257814843822;3840.519935008124;112864.43567782108;114500.42749786198;115471.26793098194;116379;116770.83229167685;10631.308964917256;10677.733056673489;10725.08836748885;10740.979606937328;11343.886561134448;22408.103675852784;22572.66141007886;22798.31605051851;22829;22868.31395058151;7421.517601355895;7518.812029699192;7532.811679707942;7717.768466946;7778.766637000899;4218.123337171873;4218.3289081063995;4225.19721252961;4273.914521709548;4427.203103441347;3400.7619466637593;3476.1830969722096;3516.0682419158943;3518.2787528556582;3518.3666939951054;600.7446835095067;601.4436646102338;629.5970578829553;631.8104568629393;632.301307055706;650.3334082565408;661.3650895140622;673.6214605067064;697.9217109565733;717.7308509309009;8723.912760872438;9069.682561110329;9797.579350994209;9908.306418550632;10248.846267305997;662.6686656671665;667.7729571945562;673.845015646404;720.8450183210634;724.2359310927022;3923.8234279457492;4455.9554404456185;4601.74690392025;4769.59458446029;4845.55295610448;97736;100133.49933250288;101011;102171.48914255381;103014.48492757638;45885.31172032355;66603.33491662747;69035;85590.57204713937;90152.09847901568;67733.66133169303;69025.96461052987;69903;70752;70994.64502677454;7106.467014973794;8922.197002269568;9304.069593040913;9374.798597994224;9456.14894659484;43242.35136472892;43339;43768.78115609402;46258.768706156254;46504;53426.93146136978;56274.87450251054;56864.43135568591;63852.68073659602;66863.66568167128;12663.810042849549;12859.807102893652;12953.676158096123;13006;13051.608451746462;14612.269386530843;14642.70714585681;14696.55910322692;14858.702825943637;14875.47935822241;13612.931935340655;13779.517716879862;13858.376373063438;13879.375428105961;14735.705285894008;13277.468901243841;13627.863721362659;13641.454341826216;13710.24593647359;13958;13296;13424;13459.327033648475;13465.528706495226;14040.508582199574;10724.785504289714;10921.56313747473;11090.445477726244;11155.888441115485;11243.212975091992;9426.915904670775;9602.759931001781;10868.565257389932;10990.505427255634;11151.721206969567 08:59:59 INFO - PROCESS | 1927 | __end_tp_report 08:59:59 INFO - PROCESS | 1927 | __start_cc_report 08:59:59 INFO - PROCESS | 1927 | _x_x_mozilla_cycle_collect,2886 08:59:59 INFO - PROCESS | 1927 | __end_cc_report 08:59:59 INFO - PROCESS | 1927 | __startTimestamp1488646799499__endTimestamp 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | ------- Summary: start ------- 08:59:59 INFO - PROCESS | 1927 | Number of tests: 6 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#0] dojo.html Cycles:165 Average:5797.68 Median:6047.61 stddev:647.57 (10.7%) stddev-sans-first:612.37 08:59:59 INFO - PROCESS | 1927 | Values: 3040.5 3335.8 3352.9 3383.9 3417.4 5616.2 5704.2 5793.7 5879.8 5898.4 5685.5 5754.9 5825.9 5845.8 5886.9 5204.7 5239.2 5271.5 5289.5 5292.1 5390.5 5398.1 5398.1 5398.8 5447.6 5174.2 5221.6 5269.5 5358.9 5371.1 5206.2 5239.0 5254.3 5256.1 5256.9 5179.2 5204.8 5214.7 5243.6 5246.3 4903.7 5616.9 5743.6 5757.3 5759.5 6249.6 6254.9 6270.8 6272.6 6274.0 6174.9 6306.7 6319.0 6327.5 6329.7 5919.2 5930.2 6029.8 6068.2 6076.8 6328.3 6370.6 6371.2 6381.7 6386.0 6115.8 6125.2 6183.5 6301.9 6337.0 6272.9 6279.5 6281.4 6282.7 6295.4 6226.3 6238.4 6243.6 6248.8 6256.7 5622.2 6204.6 6209.4 6261.4 6266.3 4939.2 5076.9 5113.0 5132.4 5135.7 4470.3 4501.7 4541.7 4613.9 4620.4 5604.0 5708.3 5839.6 5847.0 5849.9 6297.2 6300.2 6301.7 6303.4 6307.3 5678.0 5687.6 5691.3 5698.5 5699.7 5374.8 5436.0 5437.0 5446.2 5456.4 6047.6 6184.9 6248.4 6269.0 6346.6 6235.4 6280.4 6287.7 6299.8 6315.1 6403.0 6420.2 6432.2 6441.3 6444.5 6100.3 6153.0 6220.1 6342.1 6344.7 6213.8 6233.2 6293.6 6317.4 6318.2 6115.6 6117.2 6132.7 6180.6 6248.3 5248.5 6210.7 6247.9 6254.2 6264.7 6122.3 6122.6 6126.4 6136.3 6141.5 6020.7 6032.2 6068.5 6273.2 6290.9 5949.7 5961.1 5970.5 5975.1 5979.8 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#1] ext.html Cycles:180 Average:51555.44 Median:17706.36 stddev:103518.77 (584.6%) stddev-sans-first:103738.92 08:59:59 INFO - PROCESS | 1927 | Values: 760.1 779.6 837.1 846.7 846.8 37363.3 37900.0 38019.0 38071.2 38117.6 34518.8 34662.8 34734.0 34736.0 34755.3 7224.0 9089.4 9252.4 9283.4 9297.4 7352.4 7424.7 7428.5 7437.1 10846.7 10977.9 11035.0 11039.9 11040.4 11041.6 10935.6 10989.4 10995.0 10996.5 11004.8 6462.8 7108.1 10772.8 10850.5 10857.8 37021.3 37406.3 39279.6 39282.8 39326.6 3757.2 3793.2 3806.6 3835.8 3840.9 26889.9 27200.0 27319.9 27720.6 27783.3 3068.5 3111.4 3124.0 3223.2 3228.2 319422.8 323567.4 325188.0 325632.0 325716.0 40059.0 40958.6 42802.6 49190.8 49416.0 50400.2 51804.7 53903.9 53914.7 54017.5 13007.7 13097.1 13108.5 13108.6 13129.4 11202.0 11205.3 11231.8 11239.7 11241.6 11568.2 11630.9 11679.5 11782.7 11804.3 4359.6 5072.2 5097.4 5130.2 5130.9 857.3 870.4 879.0 901.9 916.7 25141.9 25588.2 25712.7 25779.5 25795.0 891.8 910.8 1022.8 1027.3 1044.0 13315.3 13933.0 14390.0 14418.7 14721.9 414860.9 416114.0 416525.0 416620.0 417320.0 46492.3 46549.0 46555.3 46614.3 46657.8 1320.2 1364.3 1365.8 1372.2 1374.8 25467.0 26323.7 26326.7 26408.0 26490.7 37864.4 43885.8 45014.8 46783.8 46830.0 419782.0 423139.8 423313.0 423991.0 424281.0 18463.4 18768.4 19173.1 21534.6 21635.0 36922.6 37071.6 37935.6 37973.8 38700.8 30322.0 31362.1 31932.2 32147.4 32189.5 25283.6 30437.2 31057.0 31576.4 31602.2 31580.8 31585.4 31687.0 31694.4 31695.5 25522.0 27388.9 28312.0 28407.0 28413.0 21620.6 21919.1 22037.6 22159.0 22209.3 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#2] jquery.html Cycles:180 Average:40532.01 Median:26887.16 stddev:115221.92 (428.5%) stddev-sans-first:115505.70 08:59:59 INFO - PROCESS | 1927 | Values: 379.1 393.0 411.3 420.1 436.3 11764.8 20414.9 21091.8 22100.9 22106.6 21576.7 21839.8 22336.8 22513.9 22632.5 5005.6 6709.4 6796.7 6840.2 6841.0 4121.3 4333.7 4352.1 4366.8 6654.3 4327.6 4343.9 4345.7 4347.8 6020.8 4324.4 7759.8 7795.5 7798.9 7806.8 7242.2 7412.8 7488.4 7502.8 7547.4 26853.1 26878.7 26895.6 26921.6 27086.8 2787.0 2816.2 2957.8 3010.1 3096.8 15310.5 16036.6 16246.3 16414.0 16488.5 1852.1 1914.6 1923.9 1952.2 1979.9 131671.7 162134.2 165269.0 165452.2 168590.0 14672.3 18627.8 18690.8 19009.6 19262.5 28424.6 29705.0 29740.3 31164.7 31260.4 8898.8 9213.6 9621.8 9622.3 9808.0 7861.8 7876.8 7995.9 8036.0 8036.5 7337.0 7505.8 8146.0 8225.7 8764.3 3559.7 3664.7 3670.0 3674.6 3678.8 864.4 870.5 874.2 896.6 911.0 20328.6 20801.1 20982.7 21060.8 21361.7 884.5 887.5 900.4 908.1 908.7 10083.8 10393.8 10560.4 10772.9 10797.2 601010.0 699870.0 703514.0 703711.0 724175.0 121171.4 130765.0 138182.9 150597.0 155193.0 1180.3 1188.1 1209.7 1210.0 1218.4 14189.8 17676.8 18043.3 18213.5 18320.5 59717.4 62178.4 63427.7 63754.0 63822.4 76494.6 81015.6 87337.6 89189.2 90572.0 11100.2 11137.0 11211.6 11410.5 11521.5 11098.6 12599.7 12644.0 12732.1 12898.5 10428.7 10538.9 11120.6 11274.5 11289.0 10488.9 10794.6 10857.3 10990.8 11074.7 9001.4 10685.1 10950.1 11335.3 11443.0 10959.2 11221.2 11355.6 11370.4 11421.9 10510.4 10594.0 10828.0 10905.4 10972.5 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#3] mootools.html Cycles:180 Average:6486.16 Median:3760.17 stddev:4066.40 (108.1%) stddev-sans-first:4059.84 08:59:59 INFO - PROCESS | 1927 | Values: 1398.5 1557.1 1583.6 1599.2 1604.6 10375.6 10934.3 10937.5 10946.3 10949.0 10315.2 10756.9 10818.9 10837.5 10849.3 2288.9 2320.3 2329.5 2329.7 2332.0 2209.2 2241.7 2250.8 2253.1 2254.6 2102.7 2121.8 2127.5 2131.0 2135.3 2145.4 2159.9 2167.7 2170.8 2175.6 1905.8 2244.4 2289.9 2296.1 2302.9 9606.7 10495.6 10759.4 10827.6 10839.1 5592.7 5755.1 5766.9 5779.7 5792.2 3288.3 3361.4 3569.4 3576.9 3581.3 1157.6 1192.4 1195.2 1232.4 1239.7 14654.3 14717.1 14850.3 14888.3 14916.1 4352.6 4553.3 4622.2 4636.3 4667.2 11365.1 11368.4 11375.7 11380.9 11390.9 5638.6 5648.3 5653.7 5654.8 5659.5 4677.6 5000.5 5102.7 5182.7 5189.1 3645.6 3715.5 3737.3 3783.0 3811.8 1009.4 1014.1 1024.5 1029.5 1033.8 781.1 899.5 905.0 911.1 916.4 6217.7 6384.8 6391.3 6393.9 6509.7 787.0 916.5 954.8 980.5 987.2 3806.8 4053.6 4061.7 4094.2 4112.2 12422.8 12855.9 13065.9 13356.3 13416.8 13082.4 13196.3 13209.5 13396.0 13399.5 9711.2 9750.9 9905.1 9908.0 9909.2 6221.1 6418.4 6449.5 6453.1 6495.4 9927.3 11301.5 11510.0 11914.2 12035.8 11532.8 11770.0 12143.3 12225.9 12350.8 8073.9 8091.3 8144.6 8199.9 8268.0 9677.5 9724.0 9879.8 9890.1 9891.2 7529.4 8764.9 8775.5 8842.8 8862.0 8502.0 8558.4 8561.0 8588.7 8615.9 7480.5 7658.8 7678.1 7683.0 7685.4 5529.8 5586.9 5814.1 5817.3 5819.6 5487.5 5685.6 5735.9 5818.3 5877.5 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#4] prototype.html Cycles:180 Average:4459.53 Median:4719.80 stddev:1214.10 (25.7%) stddev-sans-first:1177.29 08:59:59 INFO - PROCESS | 1927 | Values: 330.3 331.0 355.3 372.3 374.5 4659.7 4784.1 4789.0 4815.1 4819.7 4066.0 4120.4 4408.8 4792.6 4795.6 3776.6 4068.3 4347.3 4348.5 4376.3 3726.5 4126.6 4358.8 4361.2 4375.4 3347.4 3472.9 3740.8 4193.4 4295.7 3587.6 4157.8 4218.2 4251.5 4260.0 3640.4 4034.9 4048.8 4064.1 4133.5 4516.3 4838.3 4918.3 5002.5 5008.6 3887.4 4384.4 4625.3 5055.0 5079.7 4702.7 5259.6 5364.0 5417.5 5430.9 4628.9 4640.0 4645.4 4656.6 4664.6 4505.9 5183.4 5615.7 5622.7 5662.1 4265.2 4338.5 4580.9 4588.5 4612.5 4419.6 4672.3 4681.7 4747.1 4760.1 3915.1 4510.5 4629.3 4887.7 4911.7 4884.4 5010.4 5017.0 5044.1 5398.3 1441.7 1543.0 1558.3 1628.8 1663.7 1142.9 1279.8 1300.9 1403.8 1414.0 4170.8 4335.8 4665.7 4891.2 4912.0 4886.8 4974.6 5073.7 5147.4 5520.1 4265.5 4362.6 4648.9 4921.5 4972.9 2477.9 2642.9 2780.9 2791.6 2874.9 4823.0 5481.6 5524.5 5669.2 5755.3 4011.3 4695.0 5050.7 5079.0 5656.7 5621.4 5652.3 5656.7 5764.1 5773.9 4638.7 4996.9 5583.4 5600.9 5604.2 4781.5 4842.5 4885.2 5424.1 5539.4 5165.4 5684.6 5739.9 5807.1 5819.4 3807.9 4396.4 4461.9 4464.5 4522.5 5375.7 5538.6 5573.7 5594.6 5598.0 4570.8 5063.5 5217.3 5225.3 5235.5 4950.8 5206.8 5389.7 5417.7 5430.9 4589.2 4638.4 4725.1 5152.6 5309.5 5108.7 5372.0 5382.3 5391.0 5399.4 4241.7 4663.9 4714.5 5286.3 5358.7 08:59:59 INFO - PROCESS | 1927 | 08:59:59 INFO - PROCESS | 1927 | [#5] yui.html Cycles:180 Average:19581.30 Median:3518.32 stddev:28223.53 (802.2%) stddev-sans-first:28267.11 08:59:59 INFO - PROCESS | 1927 | Values: 701.8 735.8 764.9 811.2 817.9 14539.8 15558.3 15594.1 15594.5 15604.1 14101.8 14183.4 14239.0 14253.0 14253.3 936.5 943.8 947.7 952.0 952.1 959.4 960.5 975.0 976.2 977.7 1013.1 1013.5 1013.7 1013.8 1014.6 1006.6 1006.9 1007.4 1008.7 1009.0 752.3 752.5 752.8 753.0 755.3 15468.5 15755.4 15809.0 15975.9 16022.9 13630.5 13775.7 13777.7 13879.4 13894.1 9795.3 11648.8 11654.3 11700.8 11921.5 3678.4 3692.6 3695.9 3710.9 3840.5 112864.4 114500.4 115471.3 116379.0 116770.8 10631.3 10677.7 10725.1 10741.0 11343.9 22408.1 22572.7 22798.3 22829.0 22868.3 7421.5 7518.8 7532.8 7717.8 7778.8 4218.1 4218.3 4225.2 4273.9 4427.2 3400.8 3476.2 3516.1 3518.3 3518.4 600.7 601.4 629.6 631.8 632.3 650.3 661.4 673.6 697.9 717.7 8723.9 9069.7 9797.6 9908.3 10248.8 662.7 667.8 673.8 720.8 724.2 3923.8 4456.0 4601.7 4769.6 4845.6 97736.0 100133.5 101011.0 102171.5 103014.5 45885.3 66603.3 69035.0 85590.6 90152.1 67733.7 69026.0 69903.0 70752.0 70994.6 7106.5 8922.2 9304.1 9374.8 9456.1 43242.4 43339.0 43768.8 46258.8 46504.0 53426.9 56274.9 56864.4 63852.7 66863.7 12663.8 12859.8 12953.7 13006.0 13051.6 14612.3 14642.7 14696.6 14858.7 14875.5 13612.9 13779.5 13858.4 13879.4 14735.7 13277.5 13627.9 13641.5 13710.2 13958.0 13296.0 13424.0 13459.3 13465.5 14040.5 10724.8 10921.6 11090.4 11155.9 11243.2 9426.9 9602.8 10868.6 10990.5 11151.7 08:59:59 INFO - PROCESS | 1927 | -------- Summary: end -------- 08:59:59 INFO - PROCESS | 1927 | 09:00:00 INFO - TEST-INFO | 1927: exit 0 09:00:00 INFO - TEST-OK | dromaeo_css | took 1122611ms 09:00:00 INFO - TEST-START | kraken 09:00:00 INFO - operating with platform_type : mac_ 09:00:00 INFO - Initialising browser for kraken test... 09:00:00 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp1dK7Sg/profile http://localhost:57532/getInfo.html) 09:00:02 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 09:00:02 INFO - PROCESS | 1929 | colorDepth:24 09:00:02 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 09:00:02 INFO - PROCESS | 1929 | __metrics 09:00:02 INFO - PROCESS | 1929 | 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:00:02 INFO - PROCESS | 1929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:03 INFO - TEST-INFO | 1929: exit 0 09:00:03 INFO - Browser initialized. 09:00:03 INFO - Running cycle 1/1 for kraken test... 09:00:03 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp1dK7Sg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:15 INFO - PROCESS | 1930 | RSS: Main: 232239104 09:00:15 INFO - PROCESS | 1930 | 09:00:18 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57532/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:19 INFO - PROCESS | 1930 | RSS: Main: 282992640 09:00:19 INFO - PROCESS | 1930 | 09:00:22 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57532/tests/kraken/driver.html?testName=audio-dft) 09:00:22 INFO - PROCESS | 1930 | RSS: Main: 286076928 09:00:22 INFO - PROCESS | 1930 | 09:00:26 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57532/tests/kraken/driver.html?testName=audio-fft) 09:00:26 INFO - PROCESS | 1930 | RSS: Main: 376680448 09:00:26 INFO - PROCESS | 1930 | 09:00:28 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57532/tests/kraken/driver.html?testName=audio-oscillator) 09:00:29 INFO - PROCESS | 1930 | RSS: Main: 279093248 09:00:29 INFO - PROCESS | 1930 | 09:00:31 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:32 INFO - PROCESS | 1930 | RSS: Main: 282062848 09:00:32 INFO - PROCESS | 1930 | 09:00:35 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57532/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:36 INFO - PROCESS | 1930 | RSS: Main: 324923392 09:00:36 INFO - PROCESS | 1930 | 09:00:39 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57532/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:40 INFO - PROCESS | 1930 | RSS: Main: 326897664 09:00:40 INFO - PROCESS | 1930 | 09:00:43 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57532/tests/kraken/driver.html?testName=json-parse-financial) 09:00:43 INFO - PROCESS | 1930 | RSS: Main: 324194304 09:00:43 INFO - PROCESS | 1930 | 09:00:45 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:46 INFO - PROCESS | 1930 | RSS: Main: 298872832 09:00:46 INFO - PROCESS | 1930 | 09:00:48 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:48 INFO - PROCESS | 1930 | RSS: Main: 305594368 09:00:48 INFO - PROCESS | 1930 | 09:00:50 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:51 INFO - PROCESS | 1930 | RSS: Main: 313577472 09:00:51 INFO - PROCESS | 1930 | 09:00:54 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:55 INFO - PROCESS | 1930 | RSS: Main: 326037504 09:00:55 INFO - PROCESS | 1930 | 09:00:58 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:58 INFO - PROCESS | 1930 | RSS: Main: 319131648 09:00:58 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:57532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57532/tests/kraken/driver.html?testName=ai-astar) 09:01:00 INFO - PROCESS | 1930 | RSS: Main: 364109824 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | __start_tp_report 09:01:00 INFO - PROCESS | 1930 | _x_x_mozilla_page_load 09:01:00 INFO - PROCESS | 1930 | _x_x_mozilla_page_load_details 09:01:00 INFO - PROCESS | 1930 | |i|pagename|runs| 09:01:00 INFO - PROCESS | 1930 | |0;ai-astar;116;115;114;114;114;115;115;115;114;115 09:01:00 INFO - PROCESS | 1930 | |1;audio-beat-detection;138;111;109;148;112;110;110;108;147;94 09:01:00 INFO - PROCESS | 1930 | |2;audio-dft;189;188;186;187;181;188;188;186;184;186 09:01:00 INFO - PROCESS | 1930 | |3;audio-fft;81;60;62;92;63;61;63;60;76;65 09:01:00 INFO - PROCESS | 1930 | |4;audio-oscillator;92;71;89;96;99;98;85;71;68;86 09:01:00 INFO - PROCESS | 1930 | |5;imaging-gaussian-blur;89;90;91;94;74;118;133;89;98;132 09:01:00 INFO - PROCESS | 1930 | |6;imaging-darkroom;96;96;97;126;125;96;96;96;97;96 09:01:00 INFO - PROCESS | 1930 | |7;imaging-desaturate;86;85;69;104;138;137;86;85;87;87 09:01:00 INFO - PROCESS | 1930 | |8;json-parse-financial;62;61;60;62;63;62;62;62;63;62 09:01:00 INFO - PROCESS | 1930 | |9;json-stringify-tinderbox;61;56;63;62;60;57;58;58;58;58 09:01:00 INFO - PROCESS | 1930 | |10;stanford-crypto-aes;88;87;91;87;88;89;88;90;93;91 09:01:00 INFO - PROCESS | 1930 | |11;stanford-crypto-ccm;141;142;140;143;138;140;141;143;180;159 09:01:00 INFO - PROCESS | 1930 | |12;stanford-crypto-pbkdf2;172;172;173;171;173;176;173;173;177;167 09:01:00 INFO - PROCESS | 1930 | |13;stanford-crypto-sha256-iterative;68;67;82;84;69;68;68;66;67;67 09:01:00 INFO - PROCESS | 1930 | __end_tp_report 09:01:00 INFO - PROCESS | 1930 | __start_cc_report 09:01:00 INFO - PROCESS | 1930 | _x_x_mozilla_cycle_collect,2208 09:01:00 INFO - PROCESS | 1930 | __end_cc_report 09:01:00 INFO - PROCESS | 1930 | __startTimestamp1488646860867__endTimestamp 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | ------- Summary: start ------- 09:01:00 INFO - PROCESS | 1930 | Number of tests: 14 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 09:01:00 INFO - PROCESS | 1930 | Values: 116.0 115.0 114.0 114.0 114.0 115.0 115.0 115.0 114.0 115.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:125.00 stddev:18.58 (14.9%) stddev-sans-first:18.34 09:01:00 INFO - PROCESS | 1930 | Values: 138.0 111.0 109.0 148.0 112.0 110.0 110.0 108.0 147.0 94.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#2] audio-dft Cycles:10 Average:186.30 Median:187.50 stddev:2.36 (1.3%) stddev-sans-first:2.29 09:01:00 INFO - PROCESS | 1930 | Values: 189.0 188.0 186.0 187.0 181.0 188.0 188.0 186.0 184.0 186.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#3] audio-fft Cycles:10 Average:68.30 Median:64.00 stddev:10.95 (17.1%) stddev-sans-first:10.61 09:01:00 INFO - PROCESS | 1930 | Values: 81.0 60.0 62.0 92.0 63.0 61.0 63.0 60.0 76.0 65.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:90.50 stddev:11.69 (12.9%) stddev-sans-first:12.16 09:01:00 INFO - PROCESS | 1930 | Values: 92.0 71.0 89.0 96.0 99.0 98.0 85.0 71.0 68.0 86.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:89.50 stddev:19.92 (22.3%) stddev-sans-first:20.66 09:01:00 INFO - PROCESS | 1930 | Values: 89.0 90.0 91.0 94.0 74.0 118.0 133.0 89.0 98.0 132.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:96.00 stddev:12.34 (12.9%) stddev-sans-first:12.89 09:01:00 INFO - PROCESS | 1930 | Values: 96.0 96.0 97.0 126.0 125.0 96.0 96.0 96.0 97.0 96.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:85.50 stddev:23.19 (27.1%) stddev-sans-first:24.29 09:01:00 INFO - PROCESS | 1930 | Values: 86.0 85.0 69.0 104.0 138.0 137.0 86.0 85.0 87.0 87.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 09:01:00 INFO - PROCESS | 1930 | Values: 62.0 61.0 60.0 62.0 63.0 62.0 62.0 62.0 63.0 62.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:2.28 (3.9%) stddev-sans-first:2.32 09:01:00 INFO - PROCESS | 1930 | Values: 61.0 56.0 63.0 62.0 60.0 57.0 58.0 58.0 58.0 58.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:89.50 stddev:1.99 (2.2%) stddev-sans-first:2.06 09:01:00 INFO - PROCESS | 1930 | Values: 88.0 87.0 91.0 87.0 88.0 89.0 88.0 90.0 93.0 91.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:142.50 stddev:13.08 (9.2%) stddev-sans-first:13.71 09:01:00 INFO - PROCESS | 1930 | Values: 141.0 142.0 140.0 143.0 138.0 140.0 141.0 143.0 180.0 159.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:2.71 (1.6%) stddev-sans-first:2.86 09:01:00 INFO - PROCESS | 1930 | Values: 172.0 172.0 173.0 171.0 173.0 176.0 173.0 173.0 177.0 167.0 09:01:00 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:68.00 stddev:6.60 (9.7%) stddev-sans-first:6.94 09:01:00 INFO - PROCESS | 1930 | Values: 68.0 67.0 82.0 84.0 69.0 68.0 68.0 66.0 67.0 67.0 09:01:00 INFO - PROCESS | 1930 | -------- Summary: end -------- 09:01:00 INFO - PROCESS | 1930 | 09:01:01 INFO - TEST-INFO | 1930: exit 0 09:01:01 INFO - TEST-OK | kraken | took 61620ms 09:01:01 INFO - SUITE-END | took 1184s 09:01:02 INFO - Completed test suite (00:19:44) 09:01:02 INFO - javascript benchmark 09:01:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.909884782965, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.5287180487026, 3335.7991123195648, 3352.865885364586, 3383.9492407613875, 3417.3848707232687, 5616.241807356006, 5704.201411802341, 5793.652380857152, 5879.794207202749, 5898.351181370052, 5685.459881311269, 5754.913676294859, 5825.854353641151, 5845.7953971611005, 5886.88226235475, 5204.713740744258, 5239.214117882329, 5271.499207575293, 5289.471052894699, 5292.10034294169, 5390.460953904598, 5398.055340315429, 5398.055340315429, 5398.838034858961, 5447.5641948644015, 5174.223866420067, 5221.6083793715625, 5269.499397557264, 5358.946410535903, 5371.086915224421, 5206.193040078794, 5239.030779305841, 5254.264402983586, 5256.132738098209, 5256.894862102775, 5179.171332586768, 5204.843854684365, 5214.713190774506, 5243.6067294952645, 5246.344206974129, 4903.65674402792, 5616.887662246773, 5743.62666426681, 5757.309122905278, 5759.539236861083, 6249.625022498664, 6254.937450625481, 6270.811875643738, 6272.5922815016875, 6274.0, 6174.938250617526, 6306.747730090791, 6319.0, 6327.525435592349, 6329.746810127589, 5919.230500035011, 5930.1994230779155, 6029.78895738647, 6068.21113255274, 6076.817695469187, 6328.286080865849, 6370.554061215763, 6371.23545174582, 6381.712822922979, 6385.96807015962, 6115.827502811652, 6125.1731016313115, 6183.474404675563, 6301.873962520815, 6336.968315158395, 6272.874542509125, 6279.497640188774, 6281.403266689657, 6282.654454004982, 6295.433410992941, 6226.346233645492, 6238.407351301619, 6243.562950593506, 6248.781292654826, 6256.74973001084, 5622.212890195376, 6204.627722336674, 6209.379062093754, 6261.436470717657, 6266.279377871512, 4939.234418665113, 5076.949230507722, 5112.974435127875, 5132.435432102466, 5135.6918584885025, 4470.262406702857, 4501.729896206238, 4541.6593755468475, 4613.884652883705, 4620.376249206314, 5603.971980140073, 5708.343540492813, 5839.591228614041, 5847.006008978484, 5849.88300233993, 6297.2128483939505, 6300.180976473121, 6301.747930082745, 6303.36966303366, 6307.337729538424, 5678.0, 5687.573431992617, 5691.26013618227, 5698.544116470673, 5699.658020518782, 5374.838754837361, 5436.0, 5437.021336159451, 5446.21029950655, 5456.399796022434, 6047.606905551125, 6184.907226391518, 6248.375162483806, 6268.9969604863, 6346.619202847844, 6235.407636274546, 6280.371962803683, 6287.748490060347, 6299.811005669837, 6315.052742088724, 6403.0, 6420.1974753155855, 6432.195975503062, 6441.291457939529, 6444.4844412445955, 6100.338962863055, 6152.98475751496, 6220.098085777628, 6342.143810585697, 6344.714487847966, 6213.844653883689, 6233.189685340877, 6293.590916590407, 6317.399847014526, 6318.178636777189, 6115.575014303803, 6117.218487018478, 6132.7345309381235, 6180.598261113013, 6248.250209974832, 5248.527632513092, 6210.658413787285, 6247.9062814056915, 6254.249490061222, 6264.655443950626, 6122.326544080059, 6122.602030867979, 6126.417990290915, 6136.325004249618, 6141.477974372228, 6020.729067192075, 6032.1856549365275, 6068.544859135671, 6273.184486016971, 6290.9056364155485, 5949.702514874326, 5961.076033214858, 5970.462658360769, 5975.133605627073, 5979.820605381846], "value": 5755.498544330972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.114466646357, 779.5985067690141, 837.1377481194368, 846.7036537211981, 846.8221673448576, 37363.252734945316, 37900.0, 38019.0, 38071.23857522855, 38117.618823811754, 34518.82740586293, 34662.826685866596, 34734.0, 34736.0, 34755.30489390211, 7224.024756657836, 9089.363744537884, 9252.444853308789, 9283.442993420416, 9297.395669281475, 7352.448566357518, 7424.703011879518, 7428.480006399554, 7437.107547094356, 10846.72883177923, 10977.890221097807, 11035.0, 11039.889601104007, 11040.392778397185, 11041.558337666484, 10935.617253396133, 10989.395583242918, 10994.976381495073, 10996.505157267942, 11004.779904401947, 6462.836689395906, 7108.111486064242, 10772.838407423895, 10850.511726972305, 10857.805641379442, 37021.259574808624, 37406.25187496262, 39279.60720392788, 39282.803585982176, 39326.606733932866, 3757.210985693008, 3793.203427280247, 3806.638369354907, 3835.8082095895093, 3840.8655697050467, 26889.865550672315, 27200.0, 27319.86340068307, 27720.584191237147, 27783.305417364525, 3068.5243787213017, 3111.3932783107302, 3123.984380078085, 3223.1942014496376, 3228.2413632796274, 319422.8057719416, 323567.38216309005, 325188.0, 325632.0, 325716.0, 40059.0, 40958.59041409607, 42802.57197427986, 49190.75404623026, 49416.011679766925, 50400.22798746031, 51804.74097629563, 53903.92192156135, 53914.730426348404, 54017.45982540203, 13007.739845203043, 13097.083204175617, 13108.541201057917, 13108.558058613546, 13129.409176587076, 11202.0, 11205.327680339044, 11231.831522527169, 11239.719007024889, 11241.550337986553, 11568.190226684052, 11630.941845290889, 11679.474423650956, 11782.705432364088, 11804.291742495307, 4359.629431498295, 5072.213806859942, 5097.357128973903, 5130.153524668388, 5130.87172820675, 857.3269983063266, 870.3854350180325, 878.9736307910773, 901.9458832469942, 916.6745805239177, 25141.87429062843, 25588.232353029438, 25712.74287257141, 25779.484410312063, 25795.0, 891.826093911694, 910.8269428808505, 1022.8210063238903, 1027.2552399510444, 1043.95824167034, 13315.334233288297, 13932.95502837271, 14390.0, 14418.711625767426, 14721.852781472047, 414860.8513914883, 416114.0, 416525.0, 416620.0, 417320.0, 46492.302615460794, 46549.0, 46555.30167047497, 46614.300785488245, 46657.83355416074, 1320.227666814924, 1364.3178410794603, 1365.808786769853, 1372.2315503317975, 1374.752544541992, 25467.0, 26323.73676263213, 26326.736732633195, 26408.0, 26490.735092648825, 37864.43203351897, 43885.780571098214, 45014.77492612516, 46783.76608116938, 46830.0, 419782.0, 423139.76860231004, 423313.0, 423991.0, 424281.0, 18463.353782617545, 18768.436946891616, 19173.137208825916, 21534.569308613427, 21635.0, 36922.630773692996, 37071.62928370682, 37935.62064379321, 37973.81013094917, 38700.80649596734, 30322.0, 31362.1182729037, 31932.201694956882, 32147.35705285928, 32189.517157242193, 25283.620745689197, 30437.239069023453, 31057.0, 31576.368472629958, 31602.209944750644, 31580.842095789372, 31585.368292634477, 31687.049388518382, 31694.36611267808, 31695.52456713197, 25522.0, 27388.863055684593, 28312.0, 28407.0, 28413.0, 21620.567588648453, 21919.12323507042, 22037.559248814614, 22159.0, 22209.333719988426], "value": 17321.341778678674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.11665818642564, 392.95284565852086, 411.3418530351438, 420.1387156329525, 436.3193418267503, 11764.82350765108, 20414.877181754997, 21091.789082109193, 22100.88949555254, 22106.557868842614, 21576.676349854766, 21839.78160218397, 22336.776632233672, 22513.887430562867, 22632.54734905301, 5005.624578156653, 6709.36261055199, 6796.694148763293, 6840.213375461811, 6841.0, 4121.258173528764, 4333.718308309965, 4352.107817897323, 4366.781660916941, 6654.3012983636745, 4327.5888790565, 4343.9348409773875, 4345.6523478121835, 4347.760873151976, 6020.795840831829, 4324.437823082995, 7759.8448031039625, 7795.532268063935, 7798.9220107798765, 7806.765797026098, 7242.203357630657, 7412.813949768011, 7488.400927925807, 7502.8124296892465, 7547.3962083033775, 26853.0601428951, 26878.731212687817, 26895.596566051525, 26921.596176057374, 27086.78109485078, 2786.958195627067, 2816.2114607909816, 2957.7929544931862, 3010.081925012892, 3096.783225174239, 15310.540683779505, 16036.599085022968, 16246.268917898722, 16414.0, 16488.505344839676, 1852.1202428846325, 1914.626647803679, 1923.884566925975, 1952.2093552111417, 1979.9010049497467, 131671.68328316786, 162134.1893290526, 165269.0, 165452.17273913673, 168590.0, 14672.335493282866, 18627.813721862607, 18690.81309186918, 19009.61980760377, 19262.518437039187, 28424.57363139513, 29704.96032638847, 29740.256493587833, 31164.68835311618, 31260.374792504022, 8898.822023559493, 9213.63145474187, 9621.759456013515, 9622.326437149331, 9807.970163132768, 7861.764147075597, 7876.803079923047, 7995.922079739375, 8036.0, 8036.517808931483, 7336.96331518339, 7505.761549344297, 8146.0, 8225.725012623054, 8764.342674299452, 3559.6796288334176, 3664.670179683841, 3669.9816500917323, 3674.577423596267, 3678.779273243614, 864.386285737121, 870.4951128345544, 874.1651722604897, 896.5741272895323, 910.9544522773834, 20328.593428131353, 20801.06395212219, 20982.68525972112, 21060.789392106188, 21361.67957480639, 884.5311984648147, 887.4763889305341, 900.3607438718452, 908.123660667459, 908.6637943960644, 10083.798324033478, 10393.752749670088, 10560.419176945341, 10772.892271077346, 10797.190210734227, 601010.0, 699870.0, 703514.0, 703711.0, 724175.0, 121171.39414303048, 130765.0, 138182.92725609124, 150597.0, 155193.0, 1180.2918249050501, 1188.085174415695, 1209.6915286601861, 1209.9879001209874, 1218.415160722858, 14189.787153192918, 17676.82323176803, 18043.278268869097, 18213.54466138357, 18320.45038648843, 59717.402825971185, 62178.37821621726, 63427.682861585396, 63754.0, 63822.361776381644, 76494.61752691201, 81015.5695329141, 87337.56331218558, 89189.21621567663, 90572.0, 11100.167487438313, 11137.0, 11211.551537938718, 11410.54357825711, 11521.53913843437, 11098.616046661686, 12599.685007874876, 12644.0, 12732.108752387245, 12898.548550800677, 10428.687139385831, 10538.89461105379, 11120.555177792798, 11274.492647830702, 11288.98399144081, 10488.947555262175, 10794.56821727122, 10857.262837945891, 10990.780184396108, 11074.723131921766, 9001.36990410665, 10685.091767199876, 10950.06924411434, 11335.263207891461, 11443.027342675632, 10959.178061645249, 11221.158413118885, 11355.602553910903, 11370.431478426211, 11421.942890285496, 10510.369377837354, 10594.0, 10828.0, 10905.400202988912, 10972.506237219504], "value": 10929.089689597606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.454602704946, 1557.0735412429608, 1583.6357637743326, 1599.1844159478667, 1604.5988502874281, 10375.636852710148, 10934.343939363644, 10937.45312734364, 10946.343219406841, 10949.0, 10315.226358023141, 10756.946215268932, 10818.945905270482, 10837.458127093652, 10849.294795838265, 2288.8855557222155, 2320.3039088273536, 2329.5457385809773, 2329.685492458522, 2332.0322066342533, 2209.2267706302746, 2241.7085778848727, 2250.7524172341027, 2253.1212826997485, 2254.5603607296584, 2102.6740855167473, 2121.787821217881, 2127.5213077057615, 2131.007507980036, 2135.3166986564306, 2145.410012246629, 2159.946001349971, 2167.6640120781385, 2170.7829217078324, 2175.575762726269, 1905.8189472000138, 2244.4164517225477, 2289.9313020609407, 2296.0930432479245, 2302.9424264393356, 9606.663766768199, 10495.583096282056, 10759.408232547206, 10827.621033263877, 10839.078678312275, 5592.664440133564, 5755.107958266475, 5766.913496297559, 5779.739911703983, 5792.218050563204, 3288.2765791525826, 3361.4117529432497, 3569.3575156471825, 3576.8748093816853, 3581.3374525712825, 1157.6353448663729, 1192.379962419537, 1195.2290772451806, 1232.383808095952, 1239.6590937492172, 14654.267286635732, 14717.116972981656, 14850.331735071948, 14888.330025148785, 14916.105033698013, 4352.564743525622, 4553.271476563734, 4622.168009758276, 4636.327732478771, 4667.206574882211, 11365.147613928988, 11368.431578421047, 11375.715607109723, 11380.94309528447, 11390.886091138982, 5638.6052976292085, 5648.265725455664, 5653.717314134276, 5654.773809047674, 5659.518940889988, 4677.555632214934, 5000.549950504472, 5102.719350435687, 5182.740862956837, 5189.091908915924, 3645.5807582128396, 3715.5169827922737, 3737.3085979093953, 3783.0353259919093, 3811.8475260989803, 1009.4448053570507, 1014.102519270451, 1024.4672770159475, 1029.5006921642996, 1033.8294181460126, 781.1173374087246, 899.4558292233105, 904.9909500904906, 911.1458530416376, 916.4455504419864, 6217.6891155442045, 6384.808455746335, 6391.265004524539, 6393.9101831517055, 6509.674516274167, 786.984260314802, 916.5463095767504, 954.8446379880422, 980.4901451245313, 987.2299606307092, 3806.809659517013, 4053.5544786931464, 4061.6953728470485, 4094.160697057096, 4112.218678451085, 12422.81365779514, 12855.871441285655, 13065.934670326587, 13356.332183390792, 13416.798748018788, 13082.411291491906, 13196.340182990813, 13209.537666181637, 13396.0, 13399.464021439228, 9711.223102151669, 9750.853737193947, 9905.068511640162, 9908.0, 9909.20726341891, 6221.097940798469, 6418.358164183544, 6449.484041276781, 6453.064305675744, 6495.382938620824, 9927.305088643725, 11301.547938082385, 11510.0, 11914.16600837933, 12035.819462707892, 11532.827007594726, 11770.0, 12143.332116733665, 12225.877741222474, 12350.75298494043, 8073.87889181651, 8091.271785539329, 8144.592770361577, 8199.918000819915, 8267.958660206661, 9677.516124193902, 9723.951380243054, 9879.753006174904, 9890.109890109925, 9891.208703303575, 7529.360004399688, 8764.868526971974, 8775.473471591726, 8842.778930526789, 8861.955690221508, 8501.95749021251, 8558.400911936105, 8561.0, 8588.65645374178, 8615.8707619387, 7480.476366654282, 7658.846823063619, 7678.1170165431695, 7683.0, 7685.385169186564, 5529.834104976857, 5586.888262234651, 5814.127880817911, 5817.272840894888, 5819.621724587888, 5487.506124448819, 5685.573581981451, 5735.8566035849435, 5818.301803783404, 5877.529797616095], "value": 4935.417452119603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2602171136655, 330.98179600121995, 355.26814761591123, 372.3335229938412, 374.47947353179075, 4659.697119687222, 4784.067106914154, 4788.976055119724, 4815.061063092694, 4819.662623616348, 4065.959340406595, 4120.423140760296, 4408.801603927823, 4792.568668819806, 4795.568398844103, 3776.565694945082, 4068.3083875741195, 4347.3261644445, 4348.543402942693, 4376.343548467724, 3726.5341832270965, 4126.628603425691, 4358.8474403395885, 4361.193179261847, 4375.4093197418415, 3347.397468455677, 3472.947905781415, 3740.7942563159017, 4193.43388642534, 4295.656347492209, 3587.641235876418, 4157.817145998345, 4218.186179942623, 4251.471278838557, 4259.978700106511, 3640.3629364861044, 4034.9193016139807, 4048.817803198863, 4064.073866815888, 4133.524644665872, 4516.345129956171, 4838.29844672524, 4918.262260660894, 5002.549770520671, 5008.649394542347, 3887.4168874669026, 4384.386185933972, 4625.32932724753, 5055.0, 5079.6952182869145, 4702.672177272238, 5259.605529585297, 5364.0, 5417.539509141728, 5430.8913821723345, 4628.907421851578, 4640.025594625099, 4645.372874661945, 4656.557627025461, 4664.55686709762, 4505.932411013838, 5183.403908550527, 5615.6630602164005, 5622.662640241599, 5662.112322715445, 4265.232258193493, 4338.457692788402, 4580.885477863014, 4588.541145885451, 4612.469565999886, 4419.624331931822, 4672.299155126758, 4681.6722829401615, 4747.1486120413065, 4760.143544017836, 3915.138669492707, 4510.548945105529, 4629.25931850909, 4887.682300650446, 4911.68074075184, 4884.389451318585, 5010.413389071232, 5016.974915125474, 5044.092063428545, 5398.298221231294, 1441.740486712381, 1543.0, 1558.2676142213143, 1628.7719719239317, 1663.6672665466713, 1142.8913953465292, 1279.7824369857146, 1300.8634093420055, 1403.7964495148146, 1413.9929300353638, 4170.77060761655, 4335.834840566341, 4665.720056796603, 4891.192953162759, 4911.979132833353, 4886.804527818847, 4974.612186150668, 5073.746312684425, 5147.40804807452, 5520.06158952979, 4265.4881414230495, 4362.556968097875, 4648.931225604573, 4921.4832442593015, 4972.925406118911, 2477.876106194683, 2642.8546429946537, 2780.944381112407, 2791.567307067408, 2874.8993785217417, 4823.022560750075, 5481.643693159932, 5524.519552681785, 5669.177969194444, 5755.316597377681, 4011.338129208706, 4695.004623035196, 5050.732131349004, 5079.009593129304, 5656.660600363992, 5621.353544342372, 5652.3217213934595, 5656.717164141776, 5764.13537969308, 5773.910957637644, 4638.6752927294765, 4996.925046124238, 5583.357913839798, 5600.85997850057, 5604.243427137284, 4781.497942715965, 4842.5157484251295, 4885.216895832924, 5424.067551025475, 5539.362973257966, 5165.380154381498, 5684.63049901755, 5739.856503587277, 5807.083662391485, 5819.359870414336, 3807.8857634271017, 4396.373341863531, 4461.933071004002, 4464.4865840428765, 4522.4573051234065, 5375.731213439234, 5538.6399884007415, 5573.693446860461, 5594.608377413542, 5598.0, 4570.771461426849, 5063.518965698253, 5217.31308376179, 5225.335079109757, 5235.534050465875, 4950.801967921243, 5206.817761378334, 5389.679528515539, 5417.724555686542, 5430.864228394322, 4589.151007063704, 4638.373819534319, 4725.085082382838, 5152.639315247897, 5309.495597918191, 5108.66793658411, 5371.973140134274, 5382.273393091882, 5391.0, 5399.406065332889, 4241.727481755523, 4663.906721865612, 4714.5149277977325, 5286.334804536558, 5358.651687640291], "value": 4113.587847859057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8140192848895, 735.8454724507853, 764.9426293028024, 811.2495941254339, 817.9369701547424, 14539.78190327146, 15558.299876505556, 15594.14232217229, 15594.45419410321, 15604.141772202523, 14101.78847317291, 14183.361748721307, 14239.0, 14252.999999999975, 14253.287335633202, 936.5364144748343, 943.8065196634708, 947.7109481608106, 951.9857202141974, 952.1383148250844, 959.3764053365298, 960.5485421851719, 975.024975024975, 976.1946394224793, 977.6529332087114, 1013.0730381700735, 1013.4628646817199, 1013.6806905824642, 1013.751630850439, 1014.6093753904726, 1006.5520843224768, 1006.9144122749575, 1007.365359823314, 1008.6923488336055, 1009.0, 752.2627824731738, 752.5221484357418, 752.7704050264667, 753.0248328414716, 755.316438623047, 15468.5359439217, 15755.44855930037, 15808.972416792987, 15975.92012039944, 16022.919885400615, 13630.454781808816, 13775.724485510334, 13777.724445511134, 13879.375428105659, 13894.096883702527, 9795.332565892686, 11648.767024659544, 11654.30074195551, 11700.824487632608, 11921.523139074427, 3678.3562876496508, 3692.593814680383, 3695.8891233263043, 3710.9257814843822, 3840.519935008124, 112864.43567782108, 114500.42749786198, 115471.26793098194, 116379.0, 116770.83229167685, 10631.308964917256, 10677.733056673489, 10725.08836748885, 10740.979606937328, 11343.886561134448, 22408.103675852784, 22572.66141007886, 22798.31605051851, 22829.0, 22868.31395058151, 7421.517601355895, 7518.812029699192, 7532.811679707942, 7717.768466946, 7778.766637000899, 4218.123337171873, 4218.3289081063995, 4225.19721252961, 4273.914521709548, 4427.203103441347, 3400.7619466637593, 3476.1830969722096, 3516.0682419158943, 3518.2787528556582, 3518.3666939951054, 600.7446835095067, 601.4436646102338, 629.5970578829553, 631.8104568629393, 632.301307055706, 650.3334082565408, 661.3650895140622, 673.6214605067064, 697.9217109565733, 717.7308509309009, 8723.912760872438, 9069.682561110329, 9797.579350994209, 9908.306418550632, 10248.846267305997, 662.6686656671665, 667.7729571945562, 673.845015646404, 720.8450183210634, 724.2359310927022, 3923.8234279457492, 4455.9554404456185, 4601.74690392025, 4769.59458446029, 4845.55295610448, 97736.0, 100133.49933250288, 101011.0, 102171.48914255381, 103014.48492757638, 45885.31172032355, 66603.33491662747, 69035.0, 85590.57204713937, 90152.09847901568, 67733.66133169303, 69025.96461052987, 69903.0, 70752.0, 70994.64502677454, 7106.467014973794, 8922.197002269568, 9304.069593040913, 9374.798597994224, 9456.14894659484, 43242.35136472892, 43339.0, 43768.78115609402, 46258.768706156254, 46504.0, 53426.93146136978, 56274.87450251054, 56864.43135568591, 63852.68073659602, 66863.66568167128, 12663.810042849549, 12859.807102893652, 12953.676158096123, 13006.0, 13051.608451746462, 14612.269386530843, 14642.70714585681, 14696.55910322692, 14858.702825943637, 14875.47935822241, 13612.931935340655, 13779.517716879862, 13858.376373063438, 13879.375428105961, 14735.705285894008, 13277.468901243841, 13627.863721362659, 13641.454341826216, 13710.24593647359, 13958.0, 13296.0, 13424.0, 13459.327033648475, 13465.528706495226, 14040.508582199574, 10724.785504289714, 10921.56313747473, 11090.445477726244, 11155.888441115485, 11243.212975091992, 9426.915904670775, 9602.759931001781, 10868.565257389932, 10990.505427255634, 11151.721206969567], "value": 7482.456663012267, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 109.0, 148.0, 112.0, 110.0, 110.0, 108.0, 147.0, 94.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 188.0, 186.0, 187.0, 181.0, 188.0, 188.0, 186.0, 184.0, 186.0], "value": 186.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 62.0, 92.0, 63.0, 61.0, 63.0, 60.0, 76.0, 65.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 89.0, 96.0, 99.0, 98.0, 85.0, 71.0, 68.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 91.0, 94.0, 74.0, 118.0, 133.0, 89.0, 98.0, 132.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 126.0, 125.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 69.0, 104.0, 138.0, 137.0, 86.0, 85.0, 87.0, 87.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 63.0, 62.0, 60.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 91.0, 87.0, 88.0, 89.0, 88.0, 90.0, 93.0, 91.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 140.0, 143.0, 138.0, 140.0, 141.0, 143.0, 180.0, 159.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 171.0, 173.0, 176.0, 173.0, 173.0, 177.0, 167.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 82.0, 84.0, 69.0, 68.0, 68.0, 66.0, 67.0, 67.0], "value": 70.6, "unit": "score"}]}]} 09:01:02 INFO - Return code: 0 09:01:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:02 ERROR - # TBPL SUCCESS # 09:01:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:02 INFO - 2017-03-04 09:01:02.211 screenresolution[1934:28038] starting screenresolution argv=screenresolution get 09:01:02 INFO - 2017-03-04 09:01:02.214 screenresolution[1934:28038] Display 0: 1600x1200x32@60 09:01:02 INFO - 2017-03-04 09:01:02.220 screenresolution[1935:28041] starting screenresolution argv=screenresolution list 09:01:02 INFO - Available Modes on Display 0 09:01:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:02 INFO - Intel Iris: 09:01:02 INFO - Chipset Model: Intel Iris 09:01:02 INFO - Type: GPU 09:01:02 INFO - Bus: Built-In 09:01:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:02 INFO - Vendor: Intel (0x8086) 09:01:02 INFO - Device ID: 0x0a2e 09:01:02 INFO - Revision ID: 0x0009 09:01:02 INFO - Displays: 09:01:02 INFO - Display: 09:01:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:02 INFO - Display Serial Number: 1600x1200 60 09:01:02 INFO - Main Display: Yes 09:01:02 INFO - Mirror: Off 09:01:02 INFO - Online: Yes 09:01:02 INFO - Rotation: Supported 09:01:02 INFO - Return code: 0 09:01:02 INFO - Running post-action listener: _resource_record_post_action 09:01:02 INFO - [mozharness: 2017-03-04 17:01:02.466032Z] Finished run-tests step (success) 09:01:02 INFO - Running post-run listener: _resource_record_post_run 09:01:02 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 3010560; Write bytes: 512876544; Read time: 13; Write time: 1740 09:01:02 INFO - TinderboxPrint: CPU usage
53.9% 09:01:02 INFO - TinderboxPrint: I/O read bytes / time
3,010,560 / 13 09:01:02 INFO - TinderboxPrint: I/O write bytes / time
512,876,544 / 1,740 09:01:02 INFO - TinderboxPrint: CPU idle
2,223.3 (46.1%) 09:01:02 INFO - TinderboxPrint: CPU system
960.2 (19.9%) 09:01:02 INFO - TinderboxPrint: CPU user
1,638.2 (34.0%) 09:01:02 INFO - TinderboxPrint: Swap in / out
212,684,800 / 0 09:01:02 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202344960; Write bytes: 202929664; Read time: 15686; Write time: 459 09:01:02 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 3010560; Write bytes: 300100096; Read time: 13; Write time: 1248 09:01:02 INFO - Running post-run listener: _upload_blobber_files 09:01:02 INFO - Blob upload gear active. 09:01:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:02 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:01:02 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:01:02 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:01:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:04 INFO - (blobuploader) - INFO - Done attempting. 09:01:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:05 INFO - (blobuploader) - INFO - Done attempting. 09:01:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:01:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:01:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:06 INFO - (blobuploader) - INFO - Done attempting. 09:01:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:08 INFO - (blobuploader) - INFO - Done attempting. 09:01:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:08 INFO - Return code: 0 09:01:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74969a446704367fcda62896b0d31b36e1742f8db7680913c03079c4aa83cfb29444853be0ca58e1a025c8db3d96ab7104359feb5f7351e7f6c14fa253a94c9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbb5e6eef2a31f7bb9179e7587e5aa4006b3db3a36b96813e723641812a6fe5408349f21455c85589ac67cb67bd12e21f0c82760eee4d5ff1df91f71a98a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0bf3148fab016ce668492afafa86a4e6913db160896666b3e10358a6d8a46476d89b6a189f63898e49b38a5e8c46fcc1b12353f6d4be9f718800fdb8ad2143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1f059d3d6a87d5f3e0201a6947c6d057f14b6b126c46892b8c52c47334978496ec607176aadb349edce3b1cdf049de3f113e686ac356ab044f4566ae9ff1af"} 09:01:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:08 INFO - Contents: 09:01:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74969a446704367fcda62896b0d31b36e1742f8db7680913c03079c4aa83cfb29444853be0ca58e1a025c8db3d96ab7104359feb5f7351e7f6c14fa253a94c9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbb5e6eef2a31f7bb9179e7587e5aa4006b3db3a36b96813e723641812a6fe5408349f21455c85589ac67cb67bd12e21f0c82760eee4d5ff1df91f71a98a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0bf3148fab016ce668492afafa86a4e6913db160896666b3e10358a6d8a46476d89b6a189f63898e49b38a5e8c46fcc1b12353f6d4be9f718800fdb8ad2143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1f059d3d6a87d5f3e0201a6947c6d057f14b6b126c46892b8c52c47334978496ec607176aadb349edce3b1cdf049de3f113e686ac356ab044f4566ae9ff1af"} 09:01:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:08 INFO - Copying logs to upload dir... 09:01:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.807454 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-04 09:01:09.326692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 09:01:09.329929) ========= 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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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/74969a446704367fcda62896b0d31b36e1742f8db7680913c03079c4aa83cfb29444853be0ca58e1a025c8db3d96ab7104359feb5f7351e7f6c14fa253a94c9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbb5e6eef2a31f7bb9179e7587e5aa4006b3db3a36b96813e723641812a6fe5408349f21455c85589ac67cb67bd12e21f0c82760eee4d5ff1df91f71a98a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0bf3148fab016ce668492afafa86a4e6913db160896666b3e10358a6d8a46476d89b6a189f63898e49b38a5e8c46fcc1b12353f6d4be9f718800fdb8ad2143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1f059d3d6a87d5f3e0201a6947c6d057f14b6b126c46892b8c52c47334978496ec607176aadb349edce3b1cdf049de3f113e686ac356ab044f4566ae9ff1af"} build_url:https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/PCuhms7zTOCmsPRckB_ZQQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74969a446704367fcda62896b0d31b36e1742f8db7680913c03079c4aa83cfb29444853be0ca58e1a025c8db3d96ab7104359feb5f7351e7f6c14fa253a94c9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dbbb5e6eef2a31f7bb9179e7587e5aa4006b3db3a36b96813e723641812a6fe5408349f21455c85589ac67cb67bd12e21f0c82760eee4d5ff1df91f71a98a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be0bf3148fab016ce668492afafa86a4e6913db160896666b3e10358a6d8a46476d89b6a189f63898e49b38a5e8c46fcc1b12353f6d4be9f718800fdb8ad2143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c1f059d3d6a87d5f3e0201a6947c6d057f14b6b126c46892b8c52c47334978496ec607176aadb349edce3b1cdf049de3f113e686ac356ab044f4566ae9ff1af"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 09:01:09.443685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-03-04 09:01:09.443974) ========= 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.f92Mk5xB7Y/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.oHC5C7Tyvh/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005354 ========= master_lag: 2.69 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-03-04 09:01:12.141610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 09:01:12.141935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 09:01:12.147394) ========= ========= Total master_lag: 3.62 =========