builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0076 starttime: 1489510531.36 results: success (0) buildid: 20170314084636 builduid: f2ba7629ca6e40ae854859c956b58390 revision: efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.355723) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.356212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.356504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.382870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.383256) ========= 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.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/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-14 09:55:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2017-03-14 09:55:31 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.505146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.505471) ========= 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.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/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.019515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:31.554227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 09:55:31.554588) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/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-14 09:55:31,645 truncating revision to first 12 chars 2017-03-14 09:55:31,645 Setting DEBUG logging. 2017-03-14 09:55:31,645 attempt 1/10 2017-03-14 09:55:31,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/efbf7a1aff27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 09:55:32,599 unpacking tar archive at: mozilla-aurora-efbf7a1aff27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.206143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 09:55:32.784358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:32.784700) ========= script_repo_revision: efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:32.785089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:32.785350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 09:55:32.804951) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-14 09:55:32.805313) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:55:33 INFO - MultiFileLogger online at 20170314 09:55:33 in /builds/slave/test 09:55:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:55:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:33 INFO - {'append_to_log': False, 09:55:33 INFO - 'base_work_dir': '/builds/slave/test', 09:55:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:55:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:33 INFO - 'branch': 'Mozilla-Aurora', 09:55:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:33 INFO - 'config_files': ('talos/mac_config.py',), 09:55:33 INFO - 'default_actions': ('clobber', 09:55:33 INFO - 'read-buildbot-config', 09:55:33 INFO - 'download-and-extract', 09:55:33 INFO - 'populate-webroot', 09:55:33 INFO - 'create-virtualenv', 09:55:33 INFO - 'install', 09:55:33 INFO - 'run-tests'), 09:55:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:33 INFO - 'download_minidump_stackwalk': True, 09:55:33 INFO - 'download_symbols': 'ondemand', 09:55:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:33 INFO - 'gecko_profile': False, 09:55:33 INFO - 'gecko_profile_interval': 0, 09:55:33 INFO - 'installer_path': 'installer.exe', 09:55:33 INFO - 'log_level': 'info', 09:55:33 INFO - 'log_name': 'talos', 09:55:33 INFO - 'log_to_console': True, 09:55:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:55:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:55:33 INFO - 'opt_config_files': (), 09:55:33 INFO - 'pip_index': False, 09:55:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:33 INFO - 'cmd': ('bash', 09:55:33 INFO - '-c', 09:55:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:33 INFO - 'enabled': True, 09:55:33 INFO - 'halt_on_failure': False, 09:55:33 INFO - 'name': 'check_screen_resolution'},), 09:55:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:33 INFO - 'cmd': ('bash', 09:55:33 INFO - '-c', 09:55:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:33 INFO - 'enabled': True, 09:55:33 INFO - 'halt_on_failure': False, 09:55:33 INFO - 'name': 'check_screen_resolution'},), 09:55:33 INFO - 'run_cmd_checks_enabled': True, 09:55:33 INFO - 'suite': 'dromaeojs', 09:55:33 INFO - 'system_bits': '32', 09:55:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:33 INFO - 'title': 't-yosemite-r7-0076', 09:55:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:33 INFO - 'use_talos_json': True, 09:55:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:33 INFO - 'work_dir': 'build'} 09:55:33 INFO - [mozharness: 2017-03-14 16:55:33.024246Z] Running clobber step. 09:55:33 INFO - Running pre-action listener: _resource_record_pre_action 09:55:33 INFO - Running main action method: clobber 09:55:33 INFO - rmtree: /builds/slave/test/build 09:55:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:34 INFO - Running post-action listener: _resource_record_post_action 09:55:34 INFO - [mozharness: 2017-03-14 16:55:34.543248Z] Finished clobber step (success) 09:55:34 INFO - [mozharness: 2017-03-14 16:55:34.543401Z] Running read-buildbot-config step. 09:55:34 INFO - Running pre-action listener: _resource_record_pre_action 09:55:34 INFO - Running main action method: read_buildbot_config 09:55:34 INFO - Using buildbot properties: 09:55:34 INFO - { 09:55:34 INFO - "project": "", 09:55:34 INFO - "product": "firefox", 09:55:34 INFO - "script_repo_revision": "production", 09:55:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:55:34 INFO - "repository": "", 09:55:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:55:34 INFO - "buildid": "20170314084636", 09:55:34 INFO - "pgo_build": "False", 09:55:34 INFO - "basedir": "/builds/slave/test", 09:55:34 INFO - "buildnumber": 87, 09:55:34 INFO - "slavename": "t-yosemite-r7-0076", 09:55:34 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:55:34 INFO - "platform": "yosemite_r7", 09:55:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:55:34 INFO - "branch": "mozilla-aurora", 09:55:34 INFO - "repo_path": "releases/mozilla-aurora", 09:55:34 INFO - "revision": "efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff", 09:55:34 INFO - "stage_platform": "macosx64", 09:55:34 INFO - "builduid": "f2ba7629ca6e40ae854859c956b58390", 09:55:34 INFO - "slavebuilddir": "test" 09:55:34 INFO - } 09:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:55:34 INFO - Running post-action listener: _resource_record_post_action 09:55:34 INFO - [mozharness: 2017-03-14 16:55:34.546851Z] Finished read-buildbot-config step (success) 09:55:34 INFO - [mozharness: 2017-03-14 16:55:34.546983Z] Running download-and-extract step. 09:55:34 INFO - Running pre-action listener: _resource_record_pre_action 09:55:34 INFO - Running main action method: download_and_extract 09:55:34 INFO - mkdir: /builds/slave/test/build/tests 09:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:34 INFO - trying https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:34 INFO - Downloading https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:55:36 INFO - Downloaded 1199 bytes. 09:55:36 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:36 INFO - Using the following test package requirements: 09:55:36 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:36 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:55:36 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:55:36 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'jsshell-mac.zip'], 09:55:36 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:55:36 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:36 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:55:36 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:55:36 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:55:36 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:36 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:55:36 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:55:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:36 INFO - Fetch https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:38 INFO - Expected file size: 51779108 09:55:38 INFO - Obtained file size: 51779108 09:55:54 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:54 INFO - Fetch https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:56 INFO - Expected file size: 51779108 09:55:56 INFO - Obtained file size: 51779108 09:56:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:56:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:56:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:56:13 INFO - Expected file size: 14404424 09:56:13 INFO - Obtained file size: 14404424 09:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:13 INFO - trying https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:56:17 INFO - Downloaded 74624893 bytes. 09:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:17 INFO - mkdir: /builds/slave/test/properties 09:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:17 INFO - Contents: 09:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:17 INFO - Running post-action listener: _resource_record_post_action 09:56:17 INFO - Running post-action listener: set_extra_try_arguments 09:56:17 INFO - [mozharness: 2017-03-14 16:56:17.672337Z] Finished download-and-extract step (success) 09:56:17 INFO - [mozharness: 2017-03-14 16:56:17.672467Z] Running populate-webroot step. 09:56:17 INFO - Running pre-action listener: _resource_record_pre_action 09:56:17 INFO - Running main action method: populate_webroot 09:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:17 INFO - '--tppagecycles', 09:56:17 INFO - '7'], 09:56:17 INFO - 'tests': ['tsvgm']}}, 09:56:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['damp', 'tps']}, 09:56:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'tests': ['damp', 'tps']}, 09:56:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['dromaeo_dom']}, 09:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['basic_compositor_video']}, 09:56:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:56:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['a11yr', 09:56:17 INFO - 'ts_paint', 09:56:17 INFO - 'tpaint', 09:56:17 INFO - 'sessionrestore', 09:56:17 INFO - 'sessionrestore_no_auto_restore', 09:56:17 INFO - 'tabpaint']}, 09:56:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['tsvgx', 09:56:17 INFO - 'tsvgr_opacity', 09:56:17 INFO - 'tart', 09:56:17 INFO - 'tscrollx', 09:56:17 INFO - 'cart', 09:56:17 INFO - 'tsvg_static']}, 09:56:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:17 INFO - 'tsvgr_opacity', 09:56:17 INFO - 'tart', 09:56:17 INFO - 'tscrollx', 09:56:17 INFO - 'cart', 09:56:17 INFO - 'tsvg_static']}, 09:56:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'talos_options': ['--disable-e10s'], 09:56:17 INFO - 'tests': ['tp5o']}, 09:56:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:56:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'talos_options': ['--disable-e10s', 09:56:17 INFO - '--xperf_path', 09:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:17 INFO - 'tests': ['tp5n']}, 09:56:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:56:17 INFO - 'talos_options': ['--xperf_path', 09:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:17 INFO - 'tests': ['tp5n']}}, 09:56:17 INFO - 'talos.zip': {'path': '', 09:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:17 INFO - Running post-action listener: _resource_record_post_action 09:56:17 INFO - [mozharness: 2017-03-14 16:56:17.690950Z] Finished populate-webroot step (success) 09:56:17 INFO - [mozharness: 2017-03-14 16:56:17.691089Z] Running create-virtualenv step. 09:56:17 INFO - Running pre-action listener: _resource_record_pre_action 09:56:17 INFO - Running main action method: create_virtualenv 09:56:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:17 INFO - Using real prefix '/tools/python27' 09:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:21 INFO - Installing pip.................done. 09:56:21 INFO - Return code: 0 09:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Output received: 09:56:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:56:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:22 INFO - 'HOME': '/Users/cltbld', 09:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:22 INFO - 'LOGNAME': 'cltbld', 09:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:22 INFO - 'MOZ_NO_REMOTE': '1', 09:56:22 INFO - 'NO_EM_RESTART': '1', 09:56:22 INFO - 'PAGER': '/bin/cat', 09:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:22 INFO - 'PWD': '/builds/slave/test', 09:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:22 INFO - 'SHELL': '/bin/bash', 09:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:22 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:22 INFO - 'USER': 'cltbld', 09:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:22 INFO - 'XPC_FLAGS': '0x0', 09:56:22 INFO - 'XPC_SERVICE_NAME': '0', 09:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:56:22 INFO - Cleaning up... 09:56:22 INFO - Return code: 0 09:56:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:56:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:23 INFO - 'HOME': '/Users/cltbld', 09:56:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:23 INFO - 'LOGNAME': 'cltbld', 09:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:23 INFO - 'MOZ_NO_REMOTE': '1', 09:56:23 INFO - 'NO_EM_RESTART': '1', 09:56:23 INFO - 'PAGER': '/bin/cat', 09:56:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:23 INFO - 'PWD': '/builds/slave/test', 09:56:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:23 INFO - 'SHELL': '/bin/bash', 09:56:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:23 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:23 INFO - 'USER': 'cltbld', 09:56:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:23 INFO - 'XPC_FLAGS': '0x0', 09:56:23 INFO - 'XPC_SERVICE_NAME': '0', 09:56:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:23 INFO - Downloading/unpacking psutil>=3.1.1 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:28 INFO - Installing collected packages: psutil 09:56:28 INFO - Running setup.py install for psutil 09:56:28 INFO - building 'psutil._psutil_osx' extension 09:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:56:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:56:28 INFO - building 'psutil._psutil_posix' extension 09:56:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:56:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:56:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:56:28 INFO - ^ 09:56:28 INFO - 1 warning generated. 09:56:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:56:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:29 INFO - Successfully installed psutil 09:56:29 INFO - Cleaning up... 09:56:29 INFO - Return code: 0 09:56:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:29 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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:29 INFO - 'HOME': '/Users/cltbld', 09:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:29 INFO - 'LOGNAME': 'cltbld', 09:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:29 INFO - 'MOZ_NO_REMOTE': '1', 09:56:29 INFO - 'NO_EM_RESTART': '1', 09:56:29 INFO - 'PAGER': '/bin/cat', 09:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:29 INFO - 'PWD': '/builds/slave/test', 09:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:29 INFO - 'SHELL': '/bin/bash', 09:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:29 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:29 INFO - 'USER': 'cltbld', 09:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:29 INFO - 'XPC_FLAGS': '0x0', 09:56:29 INFO - 'XPC_SERVICE_NAME': '0', 09:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:32 INFO - Installing collected packages: mozsystemmonitor 09:56:32 INFO - Running setup.py install for mozsystemmonitor 09:56:32 INFO - Successfully installed mozsystemmonitor 09:56:32 INFO - Cleaning up... 09:56:32 INFO - Return code: 0 09:56:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:32 INFO - 'HOME': '/Users/cltbld', 09:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:32 INFO - 'LOGNAME': 'cltbld', 09:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:32 INFO - 'MOZ_NO_REMOTE': '1', 09:56:32 INFO - 'NO_EM_RESTART': '1', 09:56:32 INFO - 'PAGER': '/bin/cat', 09:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:32 INFO - 'PWD': '/builds/slave/test', 09:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:32 INFO - 'SHELL': '/bin/bash', 09:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:32 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:32 INFO - 'USER': 'cltbld', 09:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:32 INFO - 'XPC_FLAGS': '0x0', 09:56:32 INFO - 'XPC_SERVICE_NAME': '0', 09:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:32 INFO - Downloading/unpacking jsonschema==2.5.1 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:35 INFO - warning: no files found matching '*.txt' 09:56:35 INFO - no previously-included directories found matching 'build' 09:56:35 INFO - no previously-included directories found matching 'dist' 09:56:35 INFO - no previously-included directories found matching '.git*' 09:56:35 INFO - Installing collected packages: jsonschema, functools32 09:56:35 INFO - Running setup.py install for functools32 09:56:35 INFO - warning: no files found matching '*.txt' 09:56:35 INFO - no previously-included directories found matching 'build' 09:56:35 INFO - no previously-included directories found matching 'dist' 09:56:35 INFO - no previously-included directories found matching '.git*' 09:56:36 INFO - Successfully installed jsonschema functools32 09:56:36 INFO - Cleaning up... 09:56:36 INFO - Return code: 0 09:56:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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', '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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:56: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 functools32==3.2.3-2 09:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:36 INFO - 'HOME': '/Users/cltbld', 09:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PAGER': '/bin/cat', 09:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:36 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - 'XPC_FLAGS': '0x0', 09:56:36 INFO - 'XPC_SERVICE_NAME': '0', 09:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:56:36 INFO - Cleaning up... 09:56:36 INFO - Return code: 0 09:56:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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', '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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:56: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 blobuploader==1.2.4 09:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:36 INFO - 'HOME': '/Users/cltbld', 09:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PAGER': '/bin/cat', 09:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:36 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - 'XPC_FLAGS': '0x0', 09:56:36 INFO - 'XPC_SERVICE_NAME': '0', 09:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:40 INFO - Downloading docopt-0.6.1.tar.gz 09:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:40 INFO - Running setup.py install for blobuploader 09:56:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:40 INFO - Running setup.py install for requests 09:56:41 INFO - Running setup.py install for docopt 09:56:41 INFO - Successfully installed blobuploader requests docopt 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:41 INFO - 'HOME': '/Users/cltbld', 09:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PAGER': '/bin/cat', 09:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test', 09:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:41 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - 'XPC_FLAGS': '0x0', 09:56:41 INFO - 'XPC_SERVICE_NAME': '0', 09:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:41 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-TS27g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:41 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-zVJvSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:41 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-PGVDaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-NO0uEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-c7wF8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-uUnvJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-6po14C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-FOwYVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-31ezZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-_uJf4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-Hbs57H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:42 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-A45tXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:43 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-qU0Xyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:43 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-MdCb1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:43 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-a6hiXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:43 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-f4iqJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:43 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-7FHsWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:43 INFO - Running setup.py install for manifestparser 09:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:43 INFO - Running setup.py install for mozcrash 09:56:43 INFO - Running setup.py install for mozdebug 09:56:44 INFO - Running setup.py install for mozdevice 09:56:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozfile 09:56:44 INFO - Running setup.py install for mozhttpd 09:56:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozinfo 09:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozInstall 09:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozleak 09:56:44 INFO - Running setup.py install for mozlog 09:56:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for moznetwork 09:56:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozprocess 09:56:45 INFO - Running setup.py install for mozprofile 09:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozrunner 09:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozscreenshot 09:56:45 INFO - Running setup.py install for moztest 09:56:46 INFO - Running setup.py install for mozversion 09:56:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:46 INFO - Cleaning up... 09:56:46 INFO - Return code: 0 09:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:46 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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:46 INFO - 'HOME': '/Users/cltbld', 09:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:46 INFO - 'LOGNAME': 'cltbld', 09:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:46 INFO - 'MOZ_NO_REMOTE': '1', 09:56:46 INFO - 'NO_EM_RESTART': '1', 09:56:46 INFO - 'PAGER': '/bin/cat', 09:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:46 INFO - 'PWD': '/builds/slave/test', 09:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:46 INFO - 'SHELL': '/bin/bash', 09:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:46 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:46 INFO - 'USER': 'cltbld', 09:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:46 INFO - 'XPC_FLAGS': '0x0', 09:56:46 INFO - 'XPC_SERVICE_NAME': '0', 09:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:46 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-V4iMMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:46 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-NeoHm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:46 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-RZbOKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:46 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-O1Yn6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:46 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-yzemQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-0CxZF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-ujRhLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-lUcyAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-uMpMFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-AgB8Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-z1hy4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-g5MaSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:47 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)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-joOxol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-m2uqX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:47 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-1u5K0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:48 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-uIrCLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:48 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)) 09:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:48 INFO - Running setup.py (path:/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/pip-6oZL2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:50 INFO - Downloading blessings-1.6.tar.gz 09:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:51 INFO - Installing collected packages: blessings 09:56:51 INFO - Running setup.py install for blessings 09:56:51 INFO - Successfully installed blessings 09:56:51 INFO - Cleaning up... 09:56:51 INFO - Return code: 0 09:56:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:51 INFO - Reading from file tmpfile_stdout 09:56:51 INFO - Current package versions: 09:56:51 INFO - blessings == 1.6 09:56:51 INFO - blobuploader == 1.2.4 09:56:51 INFO - docopt == 0.6.1 09:56:51 INFO - functools32 == 3.2.3-2 09:56:51 INFO - jsonschema == 2.5.1 09:56:51 INFO - manifestparser == 1.1 09:56:51 INFO - mozInstall == 1.12 09:56:51 INFO - mozcrash == 1.0 09:56:51 INFO - mozdebug == 0.1 09:56:51 INFO - mozdevice == 0.49 09:56:51 INFO - mozfile == 1.2 09:56:51 INFO - mozhttpd == 0.7 09:56:51 INFO - mozinfo == 0.9 09:56:51 INFO - mozleak == 0.1 09:56:51 INFO - mozlog == 3.4 09:56:51 INFO - moznetwork == 0.27 09:56:51 INFO - mozprocess == 0.25 09:56:51 INFO - mozprofile == 0.28 09:56:51 INFO - mozrunner == 6.13 09:56:51 INFO - mozscreenshot == 0.1 09:56:51 INFO - mozsystemmonitor == 0.3 09:56:51 INFO - moztest == 0.8 09:56:51 INFO - mozversion == 1.4 09:56:51 INFO - psutil == 3.1.1 09:56:51 INFO - requests == 1.2.3 09:56:51 INFO - wsgiref == 0.1.2 09:56:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 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 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:51 INFO - 'HOME': '/Users/cltbld', 09:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:51 INFO - 'LOGNAME': 'cltbld', 09:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:51 INFO - 'MOZ_NO_REMOTE': '1', 09:56:51 INFO - 'NO_EM_RESTART': '1', 09:56:51 INFO - 'PAGER': '/bin/cat', 09:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:51 INFO - 'PWD': '/builds/slave/test', 09:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:51 INFO - 'SHELL': '/bin/bash', 09:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:51 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:51 INFO - 'USER': 'cltbld', 09:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:51 INFO - 'XPC_FLAGS': '0x0', 09:56:51 INFO - 'XPC_SERVICE_NAME': '0', 09:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:56:51 INFO - Cleaning up... 09:56:51 INFO - Return code: 0 09:56:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10109bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10109e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff013456560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, '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.CHc1PogPpk/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.C1UuD02LIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:51 INFO - 'HOME': '/Users/cltbld', 09:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:51 INFO - 'LOGNAME': 'cltbld', 09:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:51 INFO - 'MOZ_NO_REMOTE': '1', 09:56:51 INFO - 'NO_EM_RESTART': '1', 09:56:51 INFO - 'PAGER': '/bin/cat', 09:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:51 INFO - 'PWD': '/builds/slave/test', 09:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:51 INFO - 'SHELL': '/bin/bash', 09:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:56:51 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:51 INFO - 'USER': 'cltbld', 09:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:51 INFO - 'XPC_FLAGS': '0x0', 09:56:51 INFO - 'XPC_SERVICE_NAME': '0', 09:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:52 INFO - Cleaning up... 09:56:52 INFO - Return code: 0 09:56:52 INFO - Running post-action listener: _resource_record_post_action 09:56:52 INFO - Running post-action listener: _start_resource_monitoring 09:56:52 INFO - Starting resource monitoring. 09:56:52 INFO - [mozharness: 2017-03-14 16:56:52.214590Z] Finished create-virtualenv step (success) 09:56:52 INFO - [mozharness: 2017-03-14 16:56:52.215923Z] Running install step. 09:56:52 INFO - Running pre-action listener: _resource_record_pre_action 09:56:52 INFO - Running main action method: install 09:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:52 INFO - Reading from file tmpfile_stdout 09:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:52 INFO - Reading from file tmpfile_stdout 09:56:52 INFO - Output received: 09:56:52 INFO - Usage: mozinstall [options] installer 09:56:52 INFO - Options: 09:56:52 INFO - -h, --help show this help message and exit 09:56:52 INFO - -d DEST, --destination=DEST 09:56:52 INFO - Directory to install application into. [default: 09:56:52 INFO - "/builds/slave/test"] 09:56:52 INFO - --app=APP Application being installed. [default: firefox] 09:56:52 INFO - mkdir: /builds/slave/test/build/application 09:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:57:12 INFO - Reading from file tmpfile_stdout 09:57:12 INFO - Output received: 09:57:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:57:12 INFO - Running post-action listener: _resource_record_post_action 09:57:12 INFO - [mozharness: 2017-03-14 16:57:12.560626Z] Finished install step (success) 09:57:12 INFO - [mozharness: 2017-03-14 16:57:12.560804Z] Running run-tests step. 09:57:12 INFO - Running pre-action listener: _resource_record_pre_action 09:57:12 INFO - Running main action method: run_tests 09:57:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:12 INFO - 2017-03-14 09:57:12.574 screenresolution[1907:12892] starting screenresolution argv=screenresolution get 09:57:12 INFO - 2017-03-14 09:57:12.577 screenresolution[1907:12892] Display 0: 1600x1200x32@60 09:57:12 INFO - 2017-03-14 09:57:12.582 screenresolution[1908:12896] starting screenresolution argv=screenresolution list 09:57:12 INFO - Available Modes on Display 0 09:57:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:12 INFO - Intel Iris: 09:57:12 INFO - Chipset Model: Intel Iris 09:57:12 INFO - Type: GPU 09:57:12 INFO - Bus: Built-In 09:57:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:12 INFO - Vendor: Intel (0x8086) 09:57:12 INFO - Device ID: 0x0a2e 09:57:12 INFO - Revision ID: 0x0009 09:57:12 INFO - Displays: 09:57:12 INFO - Display: 09:57:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:12 INFO - Display Serial Number: 1600x1200 60 09:57:12 INFO - Main Display: Yes 09:57:12 INFO - Mirror: Off 09:57:12 INFO - Online: Yes 09:57:12 INFO - Rotation: Supported 09:57:12 INFO - Return code: 0 09:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:12 INFO - Python 2.7.3 09:57:12 INFO - Return code: 0 09:57:12 INFO - grabbing minidump binary from tooltool 09:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:12 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 0x100e79d30>, '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 0x100da0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:57:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:57:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:12 INFO - Return code: 0 09:57:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: RUST_BACKTRACE is now 1 09:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CHc1PogPpk/Render', 09:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:12 INFO - 'HOME': '/Users/cltbld', 09:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:12 INFO - 'LOGNAME': 'cltbld', 09:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:12 INFO - 'MOZ_NO_REMOTE': '1', 09:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'NO_EM_RESTART': '1', 09:57:12 INFO - 'PAGER': '/bin/cat', 09:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:12 INFO - 'PWD': '/builds/slave/test', 09:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:12 INFO - 'RUST_BACKTRACE': '1', 09:57:12 INFO - 'SHELL': '/bin/bash', 09:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C1UuD02LIh/Listeners', 09:57:12 INFO - 'TMPDIR': '/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/', 09:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:12 INFO - 'USER': 'cltbld', 09:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:12 INFO - 'XPC_FLAGS': '0x0', 09:57:12 INFO - 'XPC_SERVICE_NAME': '0', 09:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:57:13 INFO - mozversion application_buildid: 20170314084636 09:57:13 INFO - mozversion application_changeset: efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff 09:57:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:13 INFO - mozversion application_name: Firefox 09:57:13 INFO - mozversion application_remotingname: firefox-dev 09:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:13 INFO - mozversion application_vendor: Mozilla 09:57:13 INFO - mozversion application_version: 54.0a2 09:57:13 INFO - mozversion platform_buildid: 20170314084636 09:57:13 INFO - mozversion platform_changeset: efbf7a1aff2739dfcbbfc01eb4a6e51daa9d31ff 09:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:13 INFO - mozversion platform_version: 54.0a2 09:57:13 INFO - using testdate: 1489510633 09:57:13 INFO - actual date: 1489510633 09:57:13 INFO - starting webserver on 'localhost:51433' 09:57:13 INFO - SUITE-START | Running 2 tests 09:57:13 INFO - TEST-START | dromaeo_css 09:57:13 INFO - operating with platform_type : mac_ 09:57:13 INFO - Initialising browser for dromaeo_css test... 09:57:13 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/tmpypHfAf/profile http://localhost:51433/getInfo.html) 09:57:15 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 09:57:15 INFO - PROCESS | 1918 | colorDepth:24 09:57:15 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 09:57:15 INFO - PROCESS | 1918 | __metrics 09:57:15 INFO - PROCESS | 1918 | 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:57:15 INFO - PROCESS | 1918 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:16 INFO - TEST-INFO | 1918: exit 0 09:57:16 INFO - Browser initialized. 09:57:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:16 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/tmpypHfAf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:28 INFO - PROCESS | 1920 | RSS: Main: 214953984 09:57:28 INFO - PROCESS | 1920 | 10:00:31 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51433/tests/dromaeo/cssquery-ext.html) 10:00:35 INFO - PROCESS | 1920 | RSS: Main: 497799168 10:00:35 INFO - PROCESS | 1920 | 10:02:18 INFO - PROCESS | 1920 | ************************* 10:02:18 INFO - PROCESS | 1920 | A coding exception was thrown and uncaught in a Task. 10:02:18 INFO - PROCESS | 1920 | 10:02:18 ERROR - PROCESS | 1920 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:02:18 INFO - PROCESS | 1920 | Full stack: 10:02:18 INFO - PROCESS | 1920 | ************************* 10:03:38 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-ext.html (next: http://localhost:51433/tests/dromaeo/cssquery-jquery.html) 10:03:39 INFO - PROCESS | 1920 | RSS: Main: 355385344 10:03:39 INFO - PROCESS | 1920 | 10:06:41 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51433/tests/dromaeo/cssquery-mootools.html) 10:06:42 INFO - PROCESS | 1920 | RSS: Main: 345006080 10:06:42 INFO - PROCESS | 1920 | 10:09:44 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51433/tests/dromaeo/cssquery-prototype.html) 10:09:45 INFO - PROCESS | 1920 | RSS: Main: 339914752 10:09:45 INFO - PROCESS | 1920 | 10:12:49 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51433/tests/dromaeo/cssquery-yui.html) 10:12:50 INFO - PROCESS | 1920 | RSS: Main: 338116608 10:12:50 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51433/tests/dromaeo/cssquery-yui.html (next: http://localhost:51433/tests/dromaeo/cssquery-dojo.html) 10:15:53 INFO - PROCESS | 1920 | RSS: Main: 520519680 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | __start_tp_report 10:15:53 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 10:15:53 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 10:15:53 INFO - PROCESS | 1920 | |i|pagename|runs| 10:15:53 INFO - PROCESS | 1920 | |0;dojo.html;3196.5205219217114;3377.7466689998255;3396.8471418786153;3419.025577710353;3426;5829.0964900440395;5906.497947674442;5910.438508341701;5912.290525136978;5947.078202878561;5923.644581325124;5993.310769261536;5999;6008.399160083989;6019.939800602004;5316.255724198606;5341.1988201769655;5359.330083739533;5402.459754024586;5429.267048948401;5242.056429842627;5249.42256351801;5306.336707911511;5439.184122381655;5496.367917689477;5317.12267475866;5342.946570534304;5345.118055520854;5347.7058761768285;5348.117560602496;5336.092864213093;5336.092864213093;5341.679499230058;5343.412224655285;5352.598555108363;4352.303631418989;5264.552513036397;5290.127129023706;5291.788328466857;5305.65513241638;5922.851928701817;5933.288005439332;5936.376680448534;5954.732037058343;5963;5147.536721695028;6143.74053319073;6159.969200153971;6160.1991741073825;6165.013597824372;6217.68911554425;6226.097215903668;6229.6573688447115;6230.96884515579;6288.52836037299;4418.734875907456;6020.367861374536;6026.9026089645595;6030.185924900126;6064.272287325549;6174.320824709278;6485.675716214218;6505.772297969548;6518.348165183444;6531.542792004561;6119.020956646915;6168.321484636686;6180.81457556265;6184.752609895644;6198.907016394758;4845.75771211438;6125.571210015256;6220.471259942956;6235.594686345373;6268.717907694165;6226.315105338409;6263.906041409383;6271.341509141565;6273.278572964076;6275.121482992385;6251.031090181029;6273.968630156911;6278.874422511524;6291.811245662638;6311.936880631227;4857.955539559011;4884.998575292057;4897.657163998486;5122.743862806919;5160.690358578422;4389.078293558388;4403.4495688039;4408.294672852328;4421;4422.049259409242;5608.242887210256;5681.318241811009;5682.573806964411;5684.801031963944;5686.630369026;6177.4749146322165;6189.566730328924;6195.845103872439;6200.596961197508;6211.565190436717;5723.084306511021;5963.5825492216;5966.701664916737;6006.399360064046;6011.879762404727;5585.99452098618;5597.608167428241;5618.69097199658;5619.016672082369;5622.240997465372;6194.4115309045565;6536.901946470712;6550.377714117151;6560.573562718503;6575.8027259181345;6208.906866396917;6241.750329986749;6243.96878015607;6248.062790581449;6270.6864656766065;6304.464120549805;6332.923403021406;6372.107904893226;6400.711967961546;6537.640429776408;6225.937740622717;6259.812205633838;6263.655498947602;6271.31015588294;6272.153259309935;6263.872502949331;6267.279262884645;6282;6296.433321001132;6316.431521163117;6140.8771824564155;6151.6924153793025;6166.889959807278;6238.220222472191;6282.905756413566;6135.570510064253;6161.44546990773;6174.876502470015;6183.412575805291;6187.3503282154725;6073.089036644538;6077.908831367445;6082.239720034996;6085.208922840003;6100.450959413674;6158.599691020069;6191.071339298961;6215.06773983906;6228.377162283736;6289.874202516015;5970.223870896755;6016.909746353896;6170.969145154246;6174.25908890936;6197.566170368212 10:15:53 INFO - PROCESS | 1920 | |1;ext.html;752.6876346316279;772.9497582657127;841.2470838599454;857.8756080368343;858.8024754306506;21761.347159585217;27766.583501247496;37895;38377.23245535087;40180.39729404061;39232;39267.60732392675;39377.8031109844;39397.21205575894;39464.80267598658;8788.999999999984;8965.193132618064;8967.551622418885;8967.64129434825;8974.416662916921;7130.5365151265005;7312.341889229968;7331.5601063936065;7354.632268386559;8886.911130888706;7282.271772822728;10638.946805265963;10885.510152043176;10996.23026388153;11012.339259644406;10718.088962438163;10775.892241077567;10780.622678206226;10785.029347358775;10797.892021079806;10457;10520.894791052144;10523.684289471328;10523.84214236787;10552.630657927013;22306.32702547299;26157.869210654015;36431.08922276938;36845.63154368476;38604.80697596522;3768.5477742670782;3774.8867533974026;3850.4609354690365;3855.20968201518;3859.1895701902636;25218.747812522008;25230.873845630653;26178.82195301216;26718.866405667846;26949.461010779676;2961.511350627144;3043.9695603043906;3118.3919135768533;3183.761217908643;3249.5125731140283;347675.52324476937;348025;348383;349163;350197;39925.80037099854;48806.75596621994;48898.26652600214;49106;49145.01709965781;43635.34546981798;43903.12193756171;50275.24587131196;51093.97812043739;53950.92098158015;14082.647933801736;14152.646183845487;14163.150210987375;14171.574852754435;14181.936354773434;12109.757804843854;12449.377531123408;12451.315177665134;12478.18891772032;12536.934360579271;11267.380294083903;11280.887191128148;11350.545978160946;11362.545498180145;11411.942940285246;5169.586433085344;5190.221466779938;5228.05894938907;5235.083860324504;5241.633085684041;1116.5087361560886;1134;1135.8977692007593;1144.5421831267392;1180.557291015869;25266.804714877086;25536.361590960005;25728.228153155436;25734;25922.963081476908;1212.3938030984507;1223.1988047828686;1241.5654520917788;1277;1281.2312612432465;11603.941980290214;11878.109141814226;13136.540221092217;13341.533046343331;13355.732885342433;446896;447110;447252;447463;447713;43500.78249608795;43705.34441983373;53685.731571341894;53849;53889.46110538923;1387.084524214014;1418.5744276716944;1421.182819878574;1421.48115937682;1427.9143251404948;24614.630780537947;25217.74782252154;25368.873155634104;25422.745772542778;25426.237212882905;44029.77985110054;44049.55950440455;44151.77924110487;44157.77921110374;44169.77915110404;414510;416239;416572;417149;417422.91288543364;25584.23247302584;26684.866575666998;28449.28876778097;32311.35377292488;32494.72536922393;42069.78965105155;42077.36883946804;42546.361804572334;42854.78572607117;43114;34314.656853431145;34539.654603453644;34898.47652285167;35805.64194358023;36272.91181264566;32733.345333093683;34721.65278347184;36016.63983360133;36034.45948310725;36165.81917090503;34378.31243375068;35453.822730887216;35606.465903011995;35889;35912.92261232167;30530.84734576313;31301.373972520876;31434.84282578664;31556.36887262196;31608.841955790074;22056.448588784766;23253.883730581914;23272.952717128108;23769.881150594138;23932.40168995789 10:15:53 INFO - PROCESS | 1920 | |2;jquery.html;389.0759446315002;403.5057055107492;422.3432562365521;428.0860363124728;444.8354108979678;13335.666608334797;19462.610747785035;20242.29151979681;20343.49141271469;20388.796112038875;19454.416367509;20950.685739713917;20979.580408391823;21141.894290528566;21305.467363315925;6218.657973811439;6226.06609008649;6511.413972742453;6515.153030106079;6522.380373864499;6258.561900666955;6392.872142557146;6414.294427612959;6453.999630057325;6473.546851720382;6311.842203944892;6397.61614303141;6458.838529036765;6462.806115816533;6472;6484.837879053038;6525.934740652604;6537.5750576212395;6550.181227346582;6555.278919318871;6091.208142941389;6247.156633854417;6325.462335701471;6339.334369891141;6344.619322840645;25348.366290842692;25381.873090634614;25420.618690719653;25437.10970116037;25752.87123564389;3096.2878537936176;3249.8375081245845;3349.681780230874;3369;3448.2069124101345;15209.391624335014;15365.769513457195;15799.605009874846;15853.841461585353;16304.51086467408;1986.45372522556;2095.245711543843;2103.8954548861816;2121.63932131538;2147.2377306056437;135665;158201;163957.18021409816;164095;168344;14832.851671483362;19800.90099549493;20259.594808103757;20465.897670511553;20977.58044839125;30215.395692086477;31141.532877006863;31182.88171182909;32561.18597035093;32573.674263257537;8320.16798320163;8732.650693972297;8846.461415433749;9358.906410935939;9844.163246124017;6917.654117294115;7276.163241227327;7298.854022919512;8676;8705.173008564176;7805.570693611906;9422.670206542738;9436.952815236018;9560.665376711782;9661.32370734056;3929.25344184604;3973.7814420207164;4002.719129878411;4008.4588580541836;4017.77902215381;880.6081293824187;890.4879694175875;893.7274131389988;925.1303774452128;936.3211671538216;20982.68525972112;21385.358439246847;21408.464788380414;21554.676679849814;21637.459063523223;913.1057531630455;922.6032805893396;926.2497377124416;934.9158575728217;942.9528523573794;10898.564057437772;11203.106206924029;11221.438928053565;11226.101911847196;11296.774064518664;765597;767366;772281;780644;782166;119257;151658;154329;155598;156773.2161339186;1156.7686462707493;1158.9710257243469;1185.4724647531766;1186.9050475961903;1189.0665827325336;17771.02259375747;18394.356197533023;18586.535336616693;18618.720719188954;18654.720179197593;63060;63321;63944.3605563957;63975;64881;88827.55586222028;89714.10285897058;89861.55069224612;91107;91153.08846911446;8543;10869.836952445561;11486.94256528712;11665.883341166818;11715.765684686088;9811.705648830546;11310.681310331198;12292.815607765711;12705.237685738884;12765;8935.419197752126;10691.411972341595;10775.6228532001;11034.393108379116;11115.555377785122;10779.461026948778;10802.567897284334;10860.728481788019;10939.726506837393;11130.554777808797;11443.599474018369;11479.4260286987;11532.59635912739;11579.42102894835;11613.825792613286;11279.210455268381;11299.491522881326;11548.96059354662;11564.595239166589;11656.708582285171;10844.024037836632;11222.382768947786;11267.436628168723;11323.15076369292;11334.603288885179 10:15:53 INFO - PROCESS | 1920 | |3;mootools.html;1531.2420351925798;1536.7771673107393;1557.8520040596147;1563.8905276630637;1564.7652852072192;10588.735281617954;11159.051480624146;11163.441827908593;11164.162687798407;11168.274062185952;10593.417362045084;10869.130469562437;10986.505607247673;11114.277571957837;11146.498407571658;2382.404398900275;2419.733829278778;2422.176460003607;2423.7697418745192;2424;2345.038534200978;2383.4041489627593;2383.4041489627593;2388.283514945518;2392.449736560592;2328.464453175771;2348.2250857217077;2356.670066190726;2359.2096647623066;2363.2201373546686;2302.8272879533934;2325.7557956414585;2334.323046316566;2337.614293641547;2342.367560758603;1762.7355896615481;2241.764614715464;2270.9318720438414;2302.5855346037706;2304.8040916522114;10928.836067458995;10991.010809027226;10991.120710343153;11006.339619622768;11009.724756881062;5684.516816070639;5872.089826076922;5875.764969401219;5876.882462350772;5880.7353669085;3144.4182826177002;3332.8500217490273;3455.3262113887804;3636.781793092423;3664.926701465956;1128.2497139402287;1166.5217260923066;1183.627157445402;1236.1717649175075;1241.2738547949461;13689.383977721027;14038.719225615532;14314.785278220836;15380.30788614515;15389.769153462596;4166.437530933345;4282.593153650399;4288.056627541936;4306.138772245564;4569.360289559398;9710.70867873965;11529.423528823525;11585.594504192313;11643.126765492621;11663.066954643607;5648.6893220872425;5650.434956504317;5664.85837854057;5668.659880407189;5680.6591604503865;4926.605871530269;5194.272801807674;5250.632455728139;5270.314859068373;5280.996610643965;3760.6239376062176;3848.5381754189675;3888.0279930017496;3929.115948911472;3950.940735888964;1021.3718563083798;1022.2792930983787;1026.7360470163271;1038.46000079958;1039.184240371305;926.4996901673156;938.1931538876561;943.8772959515219;946.2760987844305;973.9610415583297;6487.124238227873;6563.638999855054;6607.7775611512025;6676.933230667728;6784.660766961632;919.9540022998823;944.8110377924443;953.5565961827783;958.6548842416724;966.5167416291854;3690.5017822593604;4063.4108054331955;4121.91756164875;4133.524644665842;4212.398399368557;10274.767027956543;12606.369681515887;13997.720045599031;14032.08791428554;14070.155790652594;12845.550405735754;13417.597472075659;13689.589312320448;13874.65313367174;14030.368633411521;9670.323077384515;9678.661246856327;9977.850332245021;9994.900050999542;10031.949840250752;6719.731210751515;6762.797116086525;6816.318368163144;6848.315168483311;7013.193482749345;11944.940275298915;12212.32832194238;12252.75494490123;12426.254424734545;12429.502819887104;12161.452734626786;12302.384880755748;12425.93787031059;12708.046896482616;12843.357832108544;9068.365214434927;9357.578908948977;9358;9364.578593963424;9379.624815007322;10015.849762253718;10095.242856785624;10137.493125343555;10258.384496930208;10276.794464110826;8948.328875334246;9033.412828166149;9087.772805679911;9118;9292.39599426035;8783.648654054023;8822.735317940473;8838.469691818511;8871.911280887367;8883.289336853166;6436.549441539048;6808.148981377328;7925.484843485155;7937.8412431752195;7942.602869856369;5813.912791308218;5857.882842343044;5898.587098903035;6005.729742161526;6043.395660433922;5792;5963.761449541969;6031.819045428644;6061.242344706911;6185.659788711484 10:15:53 INFO - PROCESS | 1920 | |4;prototype.html;337.61849110505125;362.90201645555703;373.4379758463512;379.918317561724;383.2564824240972;4340.392345071685;4859.538343857333;4886.511348865111;4909.3126962225315;4958.330625365579;4213.915721685565;4503.864884053475;4611.100835337111;4832.323474713534;4867.221244600864;3518.577770667511;4341.39220509129;4355.80398882051;4360.890977725567;4381.152251036828;3677.577078635951;3869.6710779583627;3923.3526468132723;4315.654747620199;4383.904023994001;3552;3713.6843368313725;3751.5873253942045;4281.892952676177;4346.717463364887;3431.965680343202;3867.38121900496;3913.4521167036637;4222.43769805171;4331.924333723029;3680.834362453669;3718.8326525306156;4132.768305115234;4146.295129827907;4159.83360665573;4550.0217453247715;4915.238138088602;4916.483769204217;4928.99331407841;4959.677620954662;4028.556858745565;4218.282891908352;4770.880727981828;4772.546608072227;5072.746362681888;4780.617550595944;4853.441854186778;4973.607389930825;5164.941187056645;5389.951818309057;4483.753393563353;4501.977490112561;4696.553827386393;4710.929336059962;4765.642576806753;4803.9039219215765;4895.412550493964;4921.040397122562;4980.8754781130765;5810.88378232433;3852.499175107218;4372.278574035312;4396.956030439718;4427;4428;3951.940720889189;4084.65280451159;4504.009117994036;4537.9352394660355;4587.816487340469;3817.9618203818163;3897.2205558888336;4012.051142410326;4737.360456338351;4737.715737055788;4760.500147484464;4974.303597496353;5351.976133484569;5358.615416139781;5386.569074474032;1268.467243757624;1375.6079517337712;1421.985780142206;1430;1508.4192585854305;955.7753927826955;1003.508280942333;1018.8981101889751;1100.8881030159596;1130.383940752292;4607.654425918069;5023.196288593807;5026.321446604735;5045.596352291808;5047.646664733434;4931.506849315111;5121.437961421728;5260.894782104337;5264.9736751315995;5503.091989821714;4192.245395828719;4912.704633619144;5027.924581131213;5042.655165348131;5052.469490703496;2557.8976840926525;2599.4541146359475;2631.7762990146052;2689.6878664637184;2824.4633519631616;5085.160948443539;5599.636023658449;5614.2701448811395;5735.0214176109175;5739.655620662774;5375.016865639529;5477.233187353773;5502.394736578973;5612.831615051555;5670.603057785916;4995.800167993312;5080.339555857715;5239.816606418757;5538.6521580559875;5803.419658034247;5010.970556924452;5493.313335833021;5515.924394742987;5517.751701173376;5582.358028826737;5091.389033315878;5341.359036915595;5465.660913076322;5475.330024342614;5484.8354549363585;5008.549230569266;5169.974150129226;5641.266635337544;5728.391113598406;5735.311762588516;4005.4178599453635;4358.673099517486;4396.098799746108;4431.401760762385;4452.755098469615;4924.310596516419;5064.746762661778;5479.698616576126;5515.448455154613;5557.888842223214;4850.005748821553;4871.658983871095;5118.923216151687;5278.829724517742;5422.972885135549;4823.3729615149805;5037.748112594282;5321.068812957639;5357.437139504076;5385.8114965977575;5039.740064983754;5109.284700141909;5237.266782650356;5268.446813084571;5284.9471505284455;4365.890852728708;4627.838025669085;4679;5322.897455504976;5381.896711174121;4842.757862106951;4854.237965576706;4859.659823812299;5091.66904151229;5146.974265128651 10:15:53 INFO - PROCESS | 1920 | |5;yui.html;767.6622286194074;777.0946846923331;790.7904405332584;807.9272865442109;813.3899575318513;14925.179115148663;15727.60680982976;15732.449364272254;15740.763888541653;15796.052236865797;14371.856281437182;14461.78307325391;14470.493532726357;14473.63815904603;14483.493077742281;925.4771054354302;934.2479304160165;942.3074040580168;943.8961714211431;945.0313428735533;939.1922946266205;941.2658126661215;941.4915945389481;943.118184497497;943.6791490893095;1005.1305620638168;1006.5470538257777;1006.8338724110549;1006.8741407324085;1010.4442556593881;997.2122023601346;1000.3897622450299;1001.519270750044;1002.7743757654542;1005.5977608956402;743.9107307123126;744.5272252119888;744.7765670298888;745.1654147354943;745.3552676934466;15480.993735407275;15705.293261803246;15752.527424177179;16058.518244452685;16273.674526509521;12456.81314780279;13528.932355338258;13760.31198440074;14121.576352709333;14279.714405711931;10325.070743633109;10609.78780424395;10938;11880.346580938045;12157.209781364183;4382.780860956971;4400.295952647561;4508.954910450919;4533.387992620987;4658.720476771371;86810;96184.51907740417;97817;100681;101329.98670013352;10662.520186591622;10681.252312338218;10740.087092597218;10752.731181720519;10867.673969780919;17777.911110444365;21223.78776212218;21577.244796432362;21581.24465643695;21592.784072159076;7188.568685878759;7418.962905185547;7473.140588832354;7558.470907036564;7686.96156519225;4188.267053265667;4214.831406743757;4285.442892423965;4318.179545886272;4422.336649502536;3476.5132881396626;3493.2664140530774;3551.9289614207573;3558.217192217708;3581;565.4289167940327;618.6257314324858;619.789271647642;627.5262177056293;639.859230969186;638.1247270850704;674.723363420995;695.9582425054513;704.1972151747012;707.6461769115442;8706.956465217634;10067.59729610822;10135;10140.543675534618;10475;666.8932970724661;706.0151089230598;711.360851241888;717.275551692794;725.8004048886598;4503.594676479132;4890.486498917634;4901.289313049588;4936.640978787606;4937.5556199942175;84438;95523;106172;110550.23624409454;110717;50747.746261268454;82179;88328;89659.65510517347;92666;76699;78168.04579885435;79823;81455.59272203602;81460;9168.404053736485;10262.179025677779;10661.520231589442;10867.619633312795;10890.183236257153;46449.30326045045;46464;46869.53130468788;47300.81747956329;47821.521784781704;59215.70392148184;59636.50908727317;61029;61120.69439652773;61639.691801542496;12272.754544908874;12356.505739770308;12484.812727808909;12610.369481525704;13186.934065329995;14118.50585229512;14197.574072777834;14376.568702938928;14738.705225895208;14819;12996.870031299944;13462.932685336511;13472.326383680973;13485.190888546718;13506.122102063335;12627.547203686805;12722;13560.79658805099;13661.795073073714;13760.724785504433;12931.159474634118;13347.265900375573;13564.262371731467;13658.863411365759;14031.859681403055;10846.511906964048;11087.33475991443;11207.71980700489;11498.367589782307;11669.649910502698;9719.652271060948;9789.9021009789;11060.264260393104;11279.661610151708;11312.83030754523 10:15:53 INFO - PROCESS | 1920 | __end_tp_report 10:15:53 INFO - PROCESS | 1920 | __start_cc_report 10:15:53 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,3382 10:15:53 INFO - PROCESS | 1920 | __end_cc_report 10:15:53 INFO - PROCESS | 1920 | __startTimestamp1489511753346__endTimestamp 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | ------- Summary: start ------- 10:15:53 INFO - PROCESS | 1920 | Number of tests: 6 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#0] dojo.html Cycles:165 Average:5816.00 Median:6085.21 stddev:667.16 (11.0%) stddev-sans-first:636.77 10:15:53 INFO - PROCESS | 1920 | Values: 3196.5 3377.7 3396.8 3419.0 3426.0 5829.1 5906.5 5910.4 5912.3 5947.1 5923.6 5993.3 5999.0 6008.4 6019.9 5316.3 5341.2 5359.3 5402.5 5429.3 5242.1 5249.4 5306.3 5439.2 5496.4 5317.1 5342.9 5345.1 5347.7 5348.1 5336.1 5336.1 5341.7 5343.4 5352.6 4352.3 5264.6 5290.1 5291.8 5305.7 5922.9 5933.3 5936.4 5954.7 5963.0 5147.5 6143.7 6160.0 6160.2 6165.0 6217.7 6226.1 6229.7 6231.0 6288.5 4418.7 6020.4 6026.9 6030.2 6064.3 6174.3 6485.7 6505.8 6518.3 6531.5 6119.0 6168.3 6180.8 6184.8 6198.9 4845.8 6125.6 6220.5 6235.6 6268.7 6226.3 6263.9 6271.3 6273.3 6275.1 6251.0 6274.0 6278.9 6291.8 6311.9 4858.0 4885.0 4897.7 5122.7 5160.7 4389.1 4403.4 4408.3 4421.0 4422.0 5608.2 5681.3 5682.6 5684.8 5686.6 6177.5 6189.6 6195.8 6200.6 6211.6 5723.1 5963.6 5966.7 6006.4 6011.9 5586.0 5597.6 5618.7 5619.0 5622.2 6194.4 6536.9 6550.4 6560.6 6575.8 6208.9 6241.8 6244.0 6248.1 6270.7 6304.5 6332.9 6372.1 6400.7 6537.6 6225.9 6259.8 6263.7 6271.3 6272.2 6263.9 6267.3 6282.0 6296.4 6316.4 6140.9 6151.7 6166.9 6238.2 6282.9 6135.6 6161.4 6174.9 6183.4 6187.4 6073.1 6077.9 6082.2 6085.2 6100.5 6158.6 6191.1 6215.1 6228.4 6289.9 5970.2 6016.9 6171.0 6174.3 6197.6 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#1] ext.html Cycles:180 Average:53630.46 Median:34458.98 stddev:107714.70 (312.6%) stddev-sans-first:107943.70 10:15:53 INFO - PROCESS | 1920 | Values: 752.7 772.9 841.2 857.9 858.8 21761.3 27766.6 37895.0 38377.2 40180.4 39232.0 39267.6 39377.8 39397.2 39464.8 8789.0 8965.2 8967.6 8967.6 8974.4 7130.5 7312.3 7331.6 7354.6 8886.9 7282.3 10638.9 10885.5 10996.2 11012.3 10718.1 10775.9 10780.6 10785.0 10797.9 10457.0 10520.9 10523.7 10523.8 10552.6 22306.3 26157.9 36431.1 36845.6 38604.8 3768.5 3774.9 3850.5 3855.2 3859.2 25218.7 25230.9 26178.8 26718.9 26949.5 2961.5 3044.0 3118.4 3183.8 3249.5 347675.5 348025.0 348383.0 349163.0 350197.0 39925.8 48806.8 48898.3 49106.0 49145.0 43635.3 43903.1 50275.2 51094.0 53950.9 14082.6 14152.6 14163.2 14171.6 14181.9 12109.8 12449.4 12451.3 12478.2 12536.9 11267.4 11280.9 11350.5 11362.5 11411.9 5169.6 5190.2 5228.1 5235.1 5241.6 1116.5 1134.0 1135.9 1144.5 1180.6 25266.8 25536.4 25728.2 25734.0 25923.0 1212.4 1223.2 1241.6 1277.0 1281.2 11603.9 11878.1 13136.5 13341.5 13355.7 446896.0 447110.0 447252.0 447463.0 447713.0 43500.8 43705.3 53685.7 53849.0 53889.5 1387.1 1418.6 1421.2 1421.5 1427.9 24614.6 25217.7 25368.9 25422.7 25426.2 44029.8 44049.6 44151.8 44157.8 44169.8 414510.0 416239.0 416572.0 417149.0 417422.9 25584.2 26684.9 28449.3 32311.4 32494.7 42069.8 42077.4 42546.4 42854.8 43114.0 34314.7 34539.7 34898.5 35805.6 36272.9 32733.3 34721.7 36016.6 36034.5 36165.8 34378.3 35453.8 35606.5 35889.0 35912.9 30530.8 31301.4 31434.8 31556.4 31608.8 22056.4 23253.9 23273.0 23769.9 23932.4 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#2] jquery.html Cycles:180 Average:43462.85 Median:25594.99 stddev:128932.23 (503.7%) stddev-sans-first:129253.35 10:15:53 INFO - PROCESS | 1920 | Values: 389.1 403.5 422.3 428.1 444.8 13335.7 19462.6 20242.3 20343.5 20388.8 19454.4 20950.7 20979.6 21141.9 21305.5 6218.7 6226.1 6511.4 6515.2 6522.4 6258.6 6392.9 6414.3 6454.0 6473.5 6311.8 6397.6 6458.8 6462.8 6472.0 6484.8 6525.9 6537.6 6550.2 6555.3 6091.2 6247.2 6325.5 6339.3 6344.6 25348.4 25381.9 25420.6 25437.1 25752.9 3096.3 3249.8 3349.7 3369.0 3448.2 15209.4 15365.8 15799.6 15853.8 16304.5 1986.5 2095.2 2103.9 2121.6 2147.2 135665.0 158201.0 163957.2 164095.0 168344.0 14832.9 19800.9 20259.6 20465.9 20977.6 30215.4 31141.5 31182.9 32561.2 32573.7 8320.2 8732.7 8846.5 9358.9 9844.2 6917.7 7276.2 7298.9 8676.0 8705.2 7805.6 9422.7 9437.0 9560.7 9661.3 3929.3 3973.8 4002.7 4008.5 4017.8 880.6 890.5 893.7 925.1 936.3 20982.7 21385.4 21408.5 21554.7 21637.5 913.1 922.6 926.2 934.9 943.0 10898.6 11203.1 11221.4 11226.1 11296.8 765597.0 767366.0 772281.0 780644.0 782166.0 119257.0 151658.0 154329.0 155598.0 156773.2 1156.8 1159.0 1185.5 1186.9 1189.1 17771.0 18394.4 18586.5 18618.7 18654.7 63060.0 63321.0 63944.4 63975.0 64881.0 88827.6 89714.1 89861.6 91107.0 91153.1 8543.0 10869.8 11486.9 11665.9 11715.8 9811.7 11310.7 12292.8 12705.2 12765.0 8935.4 10691.4 10775.6 11034.4 11115.6 10779.5 10802.6 10860.7 10939.7 11130.6 11443.6 11479.4 11532.6 11579.4 11613.8 11279.2 11299.5 11549.0 11564.6 11656.7 10844.0 11222.4 11267.4 11323.2 11334.6 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#3] mootools.html Cycles:180 Average:6661.95 Median:3238.63 stddev:4161.03 (128.5%) stddev-sans-first:4154.84 10:15:53 INFO - PROCESS | 1920 | Values: 1531.2 1536.8 1557.9 1563.9 1564.8 10588.7 11159.1 11163.4 11164.2 11168.3 10593.4 10869.1 10986.5 11114.3 11146.5 2382.4 2419.7 2422.2 2423.8 2424.0 2345.0 2383.4 2383.4 2388.3 2392.4 2328.5 2348.2 2356.7 2359.2 2363.2 2302.8 2325.8 2334.3 2337.6 2342.4 1762.7 2241.8 2270.9 2302.6 2304.8 10928.8 10991.0 10991.1 11006.3 11009.7 5684.5 5872.1 5875.8 5876.9 5880.7 3144.4 3332.9 3455.3 3636.8 3664.9 1128.2 1166.5 1183.6 1236.2 1241.3 13689.4 14038.7 14314.8 15380.3 15389.8 4166.4 4282.6 4288.1 4306.1 4569.4 9710.7 11529.4 11585.6 11643.1 11663.1 5648.7 5650.4 5664.9 5668.7 5680.7 4926.6 5194.3 5250.6 5270.3 5281.0 3760.6 3848.5 3888.0 3929.1 3950.9 1021.4 1022.3 1026.7 1038.5 1039.2 926.5 938.2 943.9 946.3 974.0 6487.1 6563.6 6607.8 6676.9 6784.7 920.0 944.8 953.6 958.7 966.5 3690.5 4063.4 4121.9 4133.5 4212.4 10274.8 12606.4 13997.7 14032.1 14070.2 12845.6 13417.6 13689.6 13874.7 14030.4 9670.3 9678.7 9977.9 9994.9 10031.9 6719.7 6762.8 6816.3 6848.3 7013.2 11944.9 12212.3 12252.8 12426.3 12429.5 12161.5 12302.4 12425.9 12708.0 12843.4 9068.4 9357.6 9358.0 9364.6 9379.6 10015.8 10095.2 10137.5 10258.4 10276.8 8948.3 9033.4 9087.8 9118.0 9292.4 8783.6 8822.7 8838.5 8871.9 8883.3 6436.5 6808.1 7925.5 7937.8 7942.6 5813.9 5857.9 5898.6 6005.7 6043.4 5792.0 5963.8 6031.8 6061.2 6185.7 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#4] prototype.html Cycles:180 Average:4438.44 Median:4853.84 stddev:1242.78 (25.6%) stddev-sans-first:1207.54 10:15:53 INFO - PROCESS | 1920 | Values: 337.6 362.9 373.4 379.9 383.3 4340.4 4859.5 4886.5 4909.3 4958.3 4213.9 4503.9 4611.1 4832.3 4867.2 3518.6 4341.4 4355.8 4360.9 4381.2 3677.6 3869.7 3923.4 4315.7 4383.9 3552.0 3713.7 3751.6 4281.9 4346.7 3432.0 3867.4 3913.5 4222.4 4331.9 3680.8 3718.8 4132.8 4146.3 4159.8 4550.0 4915.2 4916.5 4929.0 4959.7 4028.6 4218.3 4770.9 4772.5 5072.7 4780.6 4853.4 4973.6 5164.9 5390.0 4483.8 4502.0 4696.6 4710.9 4765.6 4803.9 4895.4 4921.0 4980.9 5810.9 3852.5 4372.3 4397.0 4427.0 4428.0 3951.9 4084.7 4504.0 4537.9 4587.8 3818.0 3897.2 4012.1 4737.4 4737.7 4760.5 4974.3 5352.0 5358.6 5386.6 1268.5 1375.6 1422.0 1430.0 1508.4 955.8 1003.5 1018.9 1100.9 1130.4 4607.7 5023.2 5026.3 5045.6 5047.6 4931.5 5121.4 5260.9 5265.0 5503.1 4192.2 4912.7 5027.9 5042.7 5052.5 2557.9 2599.5 2631.8 2689.7 2824.5 5085.2 5599.6 5614.3 5735.0 5739.7 5375.0 5477.2 5502.4 5612.8 5670.6 4995.8 5080.3 5239.8 5538.7 5803.4 5011.0 5493.3 5515.9 5517.8 5582.4 5091.4 5341.4 5465.7 5475.3 5484.8 5008.5 5170.0 5641.3 5728.4 5735.3 4005.4 4358.7 4396.1 4431.4 4452.8 4924.3 5064.7 5479.7 5515.4 5557.9 4850.0 4871.7 5118.9 5278.8 5423.0 4823.4 5037.7 5321.1 5357.4 5385.8 5039.7 5109.3 5237.3 5268.4 5284.9 4365.9 4627.8 4679.0 5322.9 5381.9 4842.8 4854.2 4859.7 5091.7 5147.0 10:15:53 INFO - PROCESS | 1920 | 10:15:53 INFO - PROCESS | 1920 | [#5] yui.html Cycles:180 Average:19705.20 Median:3484.89 stddev:27854.90 (799.3%) stddev-sans-first:27896.75 10:15:53 INFO - PROCESS | 1920 | Values: 767.7 777.1 790.8 807.9 813.4 14925.2 15727.6 15732.4 15740.8 15796.1 14371.9 14461.8 14470.5 14473.6 14483.5 925.5 934.2 942.3 943.9 945.0 939.2 941.3 941.5 943.1 943.7 1005.1 1006.5 1006.8 1006.9 1010.4 997.2 1000.4 1001.5 1002.8 1005.6 743.9 744.5 744.8 745.2 745.4 15481.0 15705.3 15752.5 16058.5 16273.7 12456.8 13528.9 13760.3 14121.6 14279.7 10325.1 10609.8 10938.0 11880.3 12157.2 4382.8 4400.3 4509.0 4533.4 4658.7 86810.0 96184.5 97817.0 100681.0 101330.0 10662.5 10681.3 10740.1 10752.7 10867.7 17777.9 21223.8 21577.2 21581.2 21592.8 7188.6 7419.0 7473.1 7558.5 7687.0 4188.3 4214.8 4285.4 4318.2 4422.3 3476.5 3493.3 3551.9 3558.2 3581.0 565.4 618.6 619.8 627.5 639.9 638.1 674.7 696.0 704.2 707.6 8707.0 10067.6 10135.0 10140.5 10475.0 666.9 706.0 711.4 717.3 725.8 4503.6 4890.5 4901.3 4936.6 4937.6 84438.0 95523.0 106172.0 110550.2 110717.0 50747.7 82179.0 88328.0 89659.7 92666.0 76699.0 78168.0 79823.0 81455.6 81460.0 9168.4 10262.2 10661.5 10867.6 10890.2 46449.3 46464.0 46869.5 47300.8 47821.5 59215.7 59636.5 61029.0 61120.7 61639.7 12272.8 12356.5 12484.8 12610.4 13186.9 14118.5 14197.6 14376.6 14738.7 14819.0 12996.9 13462.9 13472.3 13485.2 13506.1 12627.5 12722.0 13560.8 13661.8 13760.7 12931.2 13347.3 13564.3 13658.9 14031.9 10846.5 11087.3 11207.7 11498.4 11669.6 9719.7 9789.9 11060.3 11279.7 11312.8 10:15:53 INFO - PROCESS | 1920 | -------- Summary: end -------- 10:15:53 INFO - PROCESS | 1920 | 10:15:54 INFO - TEST-INFO | 1920: exit 0 10:15:54 INFO - TEST-OK | dromaeo_css | took 1120876ms 10:15:54 INFO - TEST-START | kraken 10:15:54 INFO - operating with platform_type : mac_ 10:15:54 INFO - Initialising browser for kraken test... 10:15:54 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/tmp03d2lo/profile http://localhost:51433/getInfo.html) 10:15:56 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 10:15:56 INFO - PROCESS | 1924 | colorDepth:24 10:15:56 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 10:15:56 INFO - PROCESS | 1924 | __metrics 10:15:56 INFO - PROCESS | 1924 | 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" 10:15:56 INFO - PROCESS | 1924 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:57 INFO - TEST-INFO | 1924: exit 0 10:15:57 INFO - Browser initialized. 10:15:57 INFO - Running cycle 1/1 for kraken test... 10:15:57 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/T/tmp03d2lo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:09 INFO - PROCESS | 1925 | RSS: Main: 214269952 10:16:09 INFO - PROCESS | 1925 | 10:16:12 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:13 INFO - PROCESS | 1925 | RSS: Main: 267329536 10:16:13 INFO - PROCESS | 1925 | 10:16:15 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-dft) 10:16:16 INFO - PROCESS | 1925 | RSS: Main: 277434368 10:16:16 INFO - PROCESS | 1925 | 10:16:19 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-fft) 10:16:20 INFO - PROCESS | 1925 | RSS: Main: 373854208 10:16:20 INFO - PROCESS | 1925 | 10:16:22 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51433/tests/kraken/driver.html?testName=audio-oscillator) 10:16:22 INFO - PROCESS | 1925 | RSS: Main: 278724608 10:16:22 INFO - PROCESS | 1925 | 10:16:24 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:25 INFO - PROCESS | 1925 | RSS: Main: 279769088 10:16:25 INFO - PROCESS | 1925 | 10:16:28 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:28 INFO - PROCESS | 1925 | RSS: Main: 319717376 10:16:28 INFO - PROCESS | 1925 | 10:16:31 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51433/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:32 INFO - PROCESS | 1925 | RSS: Main: 321794048 10:16:32 INFO - PROCESS | 1925 | 10:16:35 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51433/tests/kraken/driver.html?testName=json-parse-financial) 10:16:36 INFO - PROCESS | 1925 | RSS: Main: 320925696 10:16:36 INFO - PROCESS | 1925 | 10:16:37 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:38 INFO - PROCESS | 1925 | RSS: Main: 295403520 10:16:38 INFO - PROCESS | 1925 | 10:16:40 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:40 INFO - PROCESS | 1925 | RSS: Main: 296427520 10:16:40 INFO - PROCESS | 1925 | 10:16:42 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:43 INFO - PROCESS | 1925 | RSS: Main: 307728384 10:16:43 INFO - PROCESS | 1925 | 10:16:46 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:47 INFO - PROCESS | 1925 | RSS: Main: 319447040 10:16:47 INFO - PROCESS | 1925 | 10:16:50 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:50 INFO - PROCESS | 1925 | RSS: Main: 313491456 10:16:50 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:51433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51433/tests/kraken/driver.html?testName=ai-astar) 10:16:52 INFO - PROCESS | 1925 | RSS: Main: 358006784 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | __start_tp_report 10:16:52 INFO - PROCESS | 1925 | _x_x_mozilla_page_load 10:16:52 INFO - PROCESS | 1925 | _x_x_mozilla_page_load_details 10:16:52 INFO - PROCESS | 1925 | |i|pagename|runs| 10:16:52 INFO - PROCESS | 1925 | |0;ai-astar;118;115;115;116;116;116;115;116;115;116 10:16:52 INFO - PROCESS | 1925 | |1;audio-beat-detection;148;111;109;144;109;106;109;111;151;128 10:16:52 INFO - PROCESS | 1925 | |2;audio-dft;185;185;180;185;185;182;187;185;186;184 10:16:52 INFO - PROCESS | 1925 | |3;audio-fft;85;60;60;91;63;62;57;60;76;57 10:16:52 INFO - PROCESS | 1925 | |4;audio-oscillator;89;68;88;70;71;69;81;74;95;115 10:16:52 INFO - PROCESS | 1925 | |5;imaging-gaussian-blur;88;88;87;87;88;88;88;88;91;113 10:16:52 INFO - PROCESS | 1925 | |6;imaging-darkroom;94;94;96;95;94;95;96;94;94;94 10:16:52 INFO - PROCESS | 1925 | |7;imaging-desaturate;83;85;86;83;85;87;84;84;84;85 10:16:52 INFO - PROCESS | 1925 | |8;json-parse-financial;65;61;58;61;62;65;64;64;62;63 10:16:52 INFO - PROCESS | 1925 | |9;json-stringify-tinderbox;54;67;65;63;60;57;58;58;57;58 10:16:52 INFO - PROCESS | 1925 | |10;stanford-crypto-aes;87;83;86;86;82;85;85;90;91;85 10:16:52 INFO - PROCESS | 1925 | |11;stanford-crypto-ccm;137;135;141;134;145;150;135;139;178;138 10:16:52 INFO - PROCESS | 1925 | |12;stanford-crypto-pbkdf2;163;162;163;221;181;166;164;163;162;162 10:16:52 INFO - PROCESS | 1925 | |13;stanford-crypto-sha256-iterative;65;65;64;63;65;64;64;64;63;64 10:16:52 INFO - PROCESS | 1925 | __end_tp_report 10:16:52 INFO - PROCESS | 1925 | __start_cc_report 10:16:52 INFO - PROCESS | 1925 | _x_x_mozilla_cycle_collect,2092 10:16:52 INFO - PROCESS | 1925 | __end_cc_report 10:16:52 INFO - PROCESS | 1925 | __startTimestamp1489511812708__endTimestamp 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | ------- Summary: start ------- 10:16:52 INFO - PROCESS | 1925 | Number of tests: 14 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 10:16:52 INFO - PROCESS | 1925 | Values: 118.0 115.0 115.0 116.0 116.0 116.0 115.0 116.0 115.0 116.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:119.50 stddev:18.37 (15.4%) stddev-sans-first:17.04 10:16:52 INFO - PROCESS | 1925 | Values: 148.0 111.0 109.0 144.0 109.0 106.0 109.0 111.0 151.0 128.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:2.01 (1.1%) stddev-sans-first:2.12 10:16:52 INFO - PROCESS | 1925 | Values: 185.0 185.0 180.0 185.0 185.0 182.0 187.0 185.0 186.0 184.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#3] audio-fft Cycles:10 Average:67.10 Median:62.50 stddev:12.33 (19.7%) stddev-sans-first:11.25 10:16:52 INFO - PROCESS | 1925 | Values: 85.0 60.0 60.0 91.0 63.0 62.0 57.0 60.0 76.0 57.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:77.50 stddev:15.05 (19.4%) stddev-sans-first:15.75 10:16:52 INFO - PROCESS | 1925 | Values: 89.0 68.0 88.0 70.0 71.0 69.0 81.0 74.0 95.0 115.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:88.00 stddev:7.95 (9.0%) stddev-sans-first:8.37 10:16:52 INFO - PROCESS | 1925 | Values: 88.0 88.0 87.0 87.0 88.0 88.0 88.0 88.0 91.0 113.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 10:16:52 INFO - PROCESS | 1925 | Values: 94.0 94.0 96.0 95.0 94.0 95.0 96.0 94.0 94.0 94.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 10:16:52 INFO - PROCESS | 1925 | Values: 83.0 85.0 86.0 83.0 85.0 87.0 84.0 84.0 84.0 85.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.50 stddev:2.17 (3.4%) stddev-sans-first:2.11 10:16:52 INFO - PROCESS | 1925 | Values: 65.0 61.0 58.0 61.0 62.0 65.0 64.0 64.0 62.0 63.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:4.06 (6.9%) stddev-sans-first:3.74 10:16:52 INFO - PROCESS | 1925 | Values: 54.0 67.0 65.0 63.0 60.0 57.0 58.0 58.0 57.0 58.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.79 (3.2%) stddev-sans-first:2.93 10:16:52 INFO - PROCESS | 1925 | Values: 87.0 83.0 86.0 86.0 82.0 85.0 85.0 90.0 91.0 85.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:140.00 stddev:13.20 (9.4%) stddev-sans-first:13.81 10:16:52 INFO - PROCESS | 1925 | Values: 137.0 135.0 141.0 134.0 145.0 150.0 135.0 139.0 178.0 138.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:163.50 stddev:18.58 (11.4%) stddev-sans-first:19.50 10:16:52 INFO - PROCESS | 1925 | Values: 163.0 162.0 163.0 221.0 181.0 166.0 164.0 163.0 162.0 162.0 10:16:52 INFO - PROCESS | 1925 | 10:16:52 INFO - PROCESS | 1925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 10:16:52 INFO - PROCESS | 1925 | Values: 65.0 65.0 64.0 63.0 65.0 64.0 64.0 64.0 63.0 64.0 10:16:52 INFO - PROCESS | 1925 | -------- Summary: end -------- 10:16:52 INFO - PROCESS | 1925 | 10:16:53 INFO - TEST-INFO | 1925: exit 0 10:16:53 INFO - TEST-OK | kraken | took 59569ms 10:16:53 INFO - SUITE-END | took 1180s 10:16:53 INFO - Completed test suite (00:19:40) 10:16:53 INFO - javascript benchmark 10:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7541.66190665695, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.5205219217114, 3377.7466689998255, 3396.8471418786153, 3419.025577710353, 3426.0, 5829.0964900440395, 5906.497947674442, 5910.438508341701, 5912.290525136978, 5947.078202878561, 5923.644581325124, 5993.310769261536, 5999.0, 6008.399160083989, 6019.939800602004, 5316.255724198606, 5341.1988201769655, 5359.330083739533, 5402.459754024586, 5429.267048948401, 5242.056429842627, 5249.42256351801, 5306.336707911511, 5439.184122381655, 5496.367917689477, 5317.12267475866, 5342.946570534304, 5345.118055520854, 5347.7058761768285, 5348.117560602496, 5336.092864213093, 5336.092864213093, 5341.679499230058, 5343.412224655285, 5352.598555108363, 4352.303631418989, 5264.552513036397, 5290.127129023706, 5291.788328466857, 5305.65513241638, 5922.851928701817, 5933.288005439332, 5936.376680448534, 5954.732037058343, 5963.0, 5147.536721695028, 6143.74053319073, 6159.969200153971, 6160.1991741073825, 6165.013597824372, 6217.68911554425, 6226.097215903668, 6229.6573688447115, 6230.96884515579, 6288.52836037299, 4418.734875907456, 6020.367861374536, 6026.9026089645595, 6030.185924900126, 6064.272287325549, 6174.320824709278, 6485.675716214218, 6505.772297969548, 6518.348165183444, 6531.542792004561, 6119.020956646915, 6168.321484636686, 6180.81457556265, 6184.752609895644, 6198.907016394758, 4845.75771211438, 6125.571210015256, 6220.471259942956, 6235.594686345373, 6268.717907694165, 6226.315105338409, 6263.906041409383, 6271.341509141565, 6273.278572964076, 6275.121482992385, 6251.031090181029, 6273.968630156911, 6278.874422511524, 6291.811245662638, 6311.936880631227, 4857.955539559011, 4884.998575292057, 4897.657163998486, 5122.743862806919, 5160.690358578422, 4389.078293558388, 4403.4495688039, 4408.294672852328, 4421.0, 4422.049259409242, 5608.242887210256, 5681.318241811009, 5682.573806964411, 5684.801031963944, 5686.630369026, 6177.4749146322165, 6189.566730328924, 6195.845103872439, 6200.596961197508, 6211.565190436717, 5723.084306511021, 5963.5825492216, 5966.701664916737, 6006.399360064046, 6011.879762404727, 5585.99452098618, 5597.608167428241, 5618.69097199658, 5619.016672082369, 5622.240997465372, 6194.4115309045565, 6536.901946470712, 6550.377714117151, 6560.573562718503, 6575.8027259181345, 6208.906866396917, 6241.750329986749, 6243.96878015607, 6248.062790581449, 6270.6864656766065, 6304.464120549805, 6332.923403021406, 6372.107904893226, 6400.711967961546, 6537.640429776408, 6225.937740622717, 6259.812205633838, 6263.655498947602, 6271.31015588294, 6272.153259309935, 6263.872502949331, 6267.279262884645, 6282.0, 6296.433321001132, 6316.431521163117, 6140.8771824564155, 6151.6924153793025, 6166.889959807278, 6238.220222472191, 6282.905756413566, 6135.570510064253, 6161.44546990773, 6174.876502470015, 6183.412575805291, 6187.3503282154725, 6073.089036644538, 6077.908831367445, 6082.239720034996, 6085.208922840003, 6100.450959413674, 6158.599691020069, 6191.071339298961, 6215.06773983906, 6228.377162283736, 6289.874202516015, 5970.223870896755, 6016.909746353896, 6170.969145154246, 6174.25908890936, 6197.566170368212], "value": 5773.541080072782, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.6876346316279, 772.9497582657127, 841.2470838599454, 857.8756080368343, 858.8024754306506, 21761.347159585217, 27766.583501247496, 37895.0, 38377.23245535087, 40180.39729404061, 39232.0, 39267.60732392675, 39377.8031109844, 39397.21205575894, 39464.80267598658, 8788.999999999984, 8965.193132618064, 8967.551622418885, 8967.64129434825, 8974.416662916921, 7130.5365151265005, 7312.341889229968, 7331.5601063936065, 7354.632268386559, 8886.911130888706, 7282.271772822728, 10638.946805265963, 10885.510152043176, 10996.23026388153, 11012.339259644406, 10718.088962438163, 10775.892241077567, 10780.622678206226, 10785.029347358775, 10797.892021079806, 10457.0, 10520.894791052144, 10523.684289471328, 10523.84214236787, 10552.630657927013, 22306.32702547299, 26157.869210654015, 36431.08922276938, 36845.63154368476, 38604.80697596522, 3768.5477742670782, 3774.8867533974026, 3850.4609354690365, 3855.20968201518, 3859.1895701902636, 25218.747812522008, 25230.873845630653, 26178.82195301216, 26718.866405667846, 26949.461010779676, 2961.511350627144, 3043.9695603043906, 3118.3919135768533, 3183.761217908643, 3249.5125731140283, 347675.52324476937, 348025.0, 348383.0, 349163.0, 350197.0, 39925.80037099854, 48806.75596621994, 48898.26652600214, 49106.0, 49145.01709965781, 43635.34546981798, 43903.12193756171, 50275.24587131196, 51093.97812043739, 53950.92098158015, 14082.647933801736, 14152.646183845487, 14163.150210987375, 14171.574852754435, 14181.936354773434, 12109.757804843854, 12449.377531123408, 12451.315177665134, 12478.18891772032, 12536.934360579271, 11267.380294083903, 11280.887191128148, 11350.545978160946, 11362.545498180145, 11411.942940285246, 5169.586433085344, 5190.221466779938, 5228.05894938907, 5235.083860324504, 5241.633085684041, 1116.5087361560886, 1134.0, 1135.8977692007593, 1144.5421831267392, 1180.557291015869, 25266.804714877086, 25536.361590960005, 25728.228153155436, 25734.0, 25922.963081476908, 1212.3938030984507, 1223.1988047828686, 1241.5654520917788, 1277.0, 1281.2312612432465, 11603.941980290214, 11878.109141814226, 13136.540221092217, 13341.533046343331, 13355.732885342433, 446896.0, 447110.0, 447252.0, 447463.0, 447713.0, 43500.78249608795, 43705.34441983373, 53685.731571341894, 53849.0, 53889.46110538923, 1387.084524214014, 1418.5744276716944, 1421.182819878574, 1421.48115937682, 1427.9143251404948, 24614.630780537947, 25217.74782252154, 25368.873155634104, 25422.745772542778, 25426.237212882905, 44029.77985110054, 44049.55950440455, 44151.77924110487, 44157.77921110374, 44169.77915110404, 414510.0, 416239.0, 416572.0, 417149.0, 417422.91288543364, 25584.23247302584, 26684.866575666998, 28449.28876778097, 32311.35377292488, 32494.72536922393, 42069.78965105155, 42077.36883946804, 42546.361804572334, 42854.78572607117, 43114.0, 34314.656853431145, 34539.654603453644, 34898.47652285167, 35805.64194358023, 36272.91181264566, 32733.345333093683, 34721.65278347184, 36016.63983360133, 36034.45948310725, 36165.81917090503, 34378.31243375068, 35453.822730887216, 35606.465903011995, 35889.0, 35912.92261232167, 30530.84734576313, 31301.373972520876, 31434.84282578664, 31556.36887262196, 31608.841955790074, 22056.448588784766, 23253.883730581914, 23272.952717128108, 23769.881150594138, 23932.40168995789], "value": 18084.757186317293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.0759446315002, 403.5057055107492, 422.3432562365521, 428.0860363124728, 444.8354108979678, 13335.666608334797, 19462.610747785035, 20242.29151979681, 20343.49141271469, 20388.796112038875, 19454.416367509, 20950.685739713917, 20979.580408391823, 21141.894290528566, 21305.467363315925, 6218.657973811439, 6226.06609008649, 6511.413972742453, 6515.153030106079, 6522.380373864499, 6258.561900666955, 6392.872142557146, 6414.294427612959, 6453.999630057325, 6473.546851720382, 6311.842203944892, 6397.61614303141, 6458.838529036765, 6462.806115816533, 6472.0, 6484.837879053038, 6525.934740652604, 6537.5750576212395, 6550.181227346582, 6555.278919318871, 6091.208142941389, 6247.156633854417, 6325.462335701471, 6339.334369891141, 6344.619322840645, 25348.366290842692, 25381.873090634614, 25420.618690719653, 25437.10970116037, 25752.87123564389, 3096.2878537936176, 3249.8375081245845, 3349.681780230874, 3369.0, 3448.2069124101345, 15209.391624335014, 15365.769513457195, 15799.605009874846, 15853.841461585353, 16304.51086467408, 1986.45372522556, 2095.245711543843, 2103.8954548861816, 2121.63932131538, 2147.2377306056437, 135665.0, 158201.0, 163957.18021409816, 164095.0, 168344.0, 14832.851671483362, 19800.90099549493, 20259.594808103757, 20465.897670511553, 20977.58044839125, 30215.395692086477, 31141.532877006863, 31182.88171182909, 32561.18597035093, 32573.674263257537, 8320.16798320163, 8732.650693972297, 8846.461415433749, 9358.906410935939, 9844.163246124017, 6917.654117294115, 7276.163241227327, 7298.854022919512, 8676.0, 8705.173008564176, 7805.570693611906, 9422.670206542738, 9436.952815236018, 9560.665376711782, 9661.32370734056, 3929.25344184604, 3973.7814420207164, 4002.719129878411, 4008.4588580541836, 4017.77902215381, 880.6081293824187, 890.4879694175875, 893.7274131389988, 925.1303774452128, 936.3211671538216, 20982.68525972112, 21385.358439246847, 21408.464788380414, 21554.676679849814, 21637.459063523223, 913.1057531630455, 922.6032805893396, 926.2497377124416, 934.9158575728217, 942.9528523573794, 10898.564057437772, 11203.106206924029, 11221.438928053565, 11226.101911847196, 11296.774064518664, 765597.0, 767366.0, 772281.0, 780644.0, 782166.0, 119257.0, 151658.0, 154329.0, 155598.0, 156773.2161339186, 1156.7686462707493, 1158.9710257243469, 1185.4724647531766, 1186.9050475961903, 1189.0665827325336, 17771.02259375747, 18394.356197533023, 18586.535336616693, 18618.720719188954, 18654.720179197593, 63060.0, 63321.0, 63944.3605563957, 63975.0, 64881.0, 88827.55586222028, 89714.10285897058, 89861.55069224612, 91107.0, 91153.08846911446, 8543.0, 10869.836952445561, 11486.94256528712, 11665.883341166818, 11715.765684686088, 9811.705648830546, 11310.681310331198, 12292.815607765711, 12705.237685738884, 12765.0, 8935.419197752126, 10691.411972341595, 10775.6228532001, 11034.393108379116, 11115.555377785122, 10779.461026948778, 10802.567897284334, 10860.728481788019, 10939.726506837393, 11130.554777808797, 11443.599474018369, 11479.4260286987, 11532.59635912739, 11579.42102894835, 11613.825792613286, 11279.210455268381, 11299.491522881326, 11548.96059354662, 11564.595239166589, 11656.708582285171, 10844.024037836632, 11222.382768947786, 11267.436628168723, 11323.15076369292, 11334.603288885179], "value": 11270.494434951623, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.2420351925798, 1536.7771673107393, 1557.8520040596147, 1563.8905276630637, 1564.7652852072192, 10588.735281617954, 11159.051480624146, 11163.441827908593, 11164.162687798407, 11168.274062185952, 10593.417362045084, 10869.130469562437, 10986.505607247673, 11114.277571957837, 11146.498407571658, 2382.404398900275, 2419.733829278778, 2422.176460003607, 2423.7697418745192, 2424.0, 2345.038534200978, 2383.4041489627593, 2383.4041489627593, 2388.283514945518, 2392.449736560592, 2328.464453175771, 2348.2250857217077, 2356.670066190726, 2359.2096647623066, 2363.2201373546686, 2302.8272879533934, 2325.7557956414585, 2334.323046316566, 2337.614293641547, 2342.367560758603, 1762.7355896615481, 2241.764614715464, 2270.9318720438414, 2302.5855346037706, 2304.8040916522114, 10928.836067458995, 10991.010809027226, 10991.120710343153, 11006.339619622768, 11009.724756881062, 5684.516816070639, 5872.089826076922, 5875.764969401219, 5876.882462350772, 5880.7353669085, 3144.4182826177002, 3332.8500217490273, 3455.3262113887804, 3636.781793092423, 3664.926701465956, 1128.2497139402287, 1166.5217260923066, 1183.627157445402, 1236.1717649175075, 1241.2738547949461, 13689.383977721027, 14038.719225615532, 14314.785278220836, 15380.30788614515, 15389.769153462596, 4166.437530933345, 4282.593153650399, 4288.056627541936, 4306.138772245564, 4569.360289559398, 9710.70867873965, 11529.423528823525, 11585.594504192313, 11643.126765492621, 11663.066954643607, 5648.6893220872425, 5650.434956504317, 5664.85837854057, 5668.659880407189, 5680.6591604503865, 4926.605871530269, 5194.272801807674, 5250.632455728139, 5270.314859068373, 5280.996610643965, 3760.6239376062176, 3848.5381754189675, 3888.0279930017496, 3929.115948911472, 3950.940735888964, 1021.3718563083798, 1022.2792930983787, 1026.7360470163271, 1038.46000079958, 1039.184240371305, 926.4996901673156, 938.1931538876561, 943.8772959515219, 946.2760987844305, 973.9610415583297, 6487.124238227873, 6563.638999855054, 6607.7775611512025, 6676.933230667728, 6784.660766961632, 919.9540022998823, 944.8110377924443, 953.5565961827783, 958.6548842416724, 966.5167416291854, 3690.5017822593604, 4063.4108054331955, 4121.91756164875, 4133.524644665842, 4212.398399368557, 10274.767027956543, 12606.369681515887, 13997.720045599031, 14032.08791428554, 14070.155790652594, 12845.550405735754, 13417.597472075659, 13689.589312320448, 13874.65313367174, 14030.368633411521, 9670.323077384515, 9678.661246856327, 9977.850332245021, 9994.900050999542, 10031.949840250752, 6719.731210751515, 6762.797116086525, 6816.318368163144, 6848.315168483311, 7013.193482749345, 11944.940275298915, 12212.32832194238, 12252.75494490123, 12426.254424734545, 12429.502819887104, 12161.452734626786, 12302.384880755748, 12425.93787031059, 12708.046896482616, 12843.357832108544, 9068.365214434927, 9357.578908948977, 9358.0, 9364.578593963424, 9379.624815007322, 10015.849762253718, 10095.242856785624, 10137.493125343555, 10258.384496930208, 10276.794464110826, 8948.328875334246, 9033.412828166149, 9087.772805679911, 9118.0, 9292.39599426035, 8783.648654054023, 8822.735317940473, 8838.469691818511, 8871.911280887367, 8883.289336853166, 6436.549441539048, 6808.148981377328, 7925.484843485155, 7937.8412431752195, 7942.602869856369, 5813.912791308218, 5857.882842343044, 5898.587098903035, 6005.729742161526, 6043.395660433922, 5792.0, 5963.761449541969, 6031.819045428644, 6061.242344706911, 6185.659788711484], "value": 5073.455919812468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.61849110505125, 362.90201645555703, 373.4379758463512, 379.918317561724, 383.2564824240972, 4340.392345071685, 4859.538343857333, 4886.511348865111, 4909.3126962225315, 4958.330625365579, 4213.915721685565, 4503.864884053475, 4611.100835337111, 4832.323474713534, 4867.221244600864, 3518.577770667511, 4341.39220509129, 4355.80398882051, 4360.890977725567, 4381.152251036828, 3677.577078635951, 3869.6710779583627, 3923.3526468132723, 4315.654747620199, 4383.904023994001, 3552.0, 3713.6843368313725, 3751.5873253942045, 4281.892952676177, 4346.717463364887, 3431.965680343202, 3867.38121900496, 3913.4521167036637, 4222.43769805171, 4331.924333723029, 3680.834362453669, 3718.8326525306156, 4132.768305115234, 4146.295129827907, 4159.83360665573, 4550.0217453247715, 4915.238138088602, 4916.483769204217, 4928.99331407841, 4959.677620954662, 4028.556858745565, 4218.282891908352, 4770.880727981828, 4772.546608072227, 5072.746362681888, 4780.617550595944, 4853.441854186778, 4973.607389930825, 5164.941187056645, 5389.951818309057, 4483.753393563353, 4501.977490112561, 4696.553827386393, 4710.929336059962, 4765.642576806753, 4803.9039219215765, 4895.412550493964, 4921.040397122562, 4980.8754781130765, 5810.88378232433, 3852.499175107218, 4372.278574035312, 4396.956030439718, 4427.0, 4428.0, 3951.940720889189, 4084.65280451159, 4504.009117994036, 4537.9352394660355, 4587.816487340469, 3817.9618203818163, 3897.2205558888336, 4012.051142410326, 4737.360456338351, 4737.715737055788, 4760.500147484464, 4974.303597496353, 5351.976133484569, 5358.615416139781, 5386.569074474032, 1268.467243757624, 1375.6079517337712, 1421.985780142206, 1430.0, 1508.4192585854305, 955.7753927826955, 1003.508280942333, 1018.8981101889751, 1100.8881030159596, 1130.383940752292, 4607.654425918069, 5023.196288593807, 5026.321446604735, 5045.596352291808, 5047.646664733434, 4931.506849315111, 5121.437961421728, 5260.894782104337, 5264.9736751315995, 5503.091989821714, 4192.245395828719, 4912.704633619144, 5027.924581131213, 5042.655165348131, 5052.469490703496, 2557.8976840926525, 2599.4541146359475, 2631.7762990146052, 2689.6878664637184, 2824.4633519631616, 5085.160948443539, 5599.636023658449, 5614.2701448811395, 5735.0214176109175, 5739.655620662774, 5375.016865639529, 5477.233187353773, 5502.394736578973, 5612.831615051555, 5670.603057785916, 4995.800167993312, 5080.339555857715, 5239.816606418757, 5538.6521580559875, 5803.419658034247, 5010.970556924452, 5493.313335833021, 5515.924394742987, 5517.751701173376, 5582.358028826737, 5091.389033315878, 5341.359036915595, 5465.660913076322, 5475.330024342614, 5484.8354549363585, 5008.549230569266, 5169.974150129226, 5641.266635337544, 5728.391113598406, 5735.311762588516, 4005.4178599453635, 4358.673099517486, 4396.098799746108, 4431.401760762385, 4452.755098469615, 4924.310596516419, 5064.746762661778, 5479.698616576126, 5515.448455154613, 5557.888842223214, 4850.005748821553, 4871.658983871095, 5118.923216151687, 5278.829724517742, 5422.972885135549, 4823.3729615149805, 5037.748112594282, 5321.068812957639, 5357.437139504076, 5385.8114965977575, 5039.740064983754, 5109.284700141909, 5237.266782650356, 5268.446813084571, 5284.9471505284455, 4365.890852728708, 4627.838025669085, 4679.0, 5322.897455504976, 5381.896711174121, 4842.757862106951, 4854.237965576706, 4859.659823812299, 5091.66904151229, 5146.974265128651], "value": 4069.37866790824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.6622286194074, 777.0946846923331, 790.7904405332584, 807.9272865442109, 813.3899575318513, 14925.179115148663, 15727.60680982976, 15732.449364272254, 15740.763888541653, 15796.052236865797, 14371.856281437182, 14461.78307325391, 14470.493532726357, 14473.63815904603, 14483.493077742281, 925.4771054354302, 934.2479304160165, 942.3074040580168, 943.8961714211431, 945.0313428735533, 939.1922946266205, 941.2658126661215, 941.4915945389481, 943.118184497497, 943.6791490893095, 1005.1305620638168, 1006.5470538257777, 1006.8338724110549, 1006.8741407324085, 1010.4442556593881, 997.2122023601346, 1000.3897622450299, 1001.519270750044, 1002.7743757654542, 1005.5977608956402, 743.9107307123126, 744.5272252119888, 744.7765670298888, 745.1654147354943, 745.3552676934466, 15480.993735407275, 15705.293261803246, 15752.527424177179, 16058.518244452685, 16273.674526509521, 12456.81314780279, 13528.932355338258, 13760.31198440074, 14121.576352709333, 14279.714405711931, 10325.070743633109, 10609.78780424395, 10938.0, 11880.346580938045, 12157.209781364183, 4382.780860956971, 4400.295952647561, 4508.954910450919, 4533.387992620987, 4658.720476771371, 86810.0, 96184.51907740417, 97817.0, 100681.0, 101329.98670013352, 10662.520186591622, 10681.252312338218, 10740.087092597218, 10752.731181720519, 10867.673969780919, 17777.911110444365, 21223.78776212218, 21577.244796432362, 21581.24465643695, 21592.784072159076, 7188.568685878759, 7418.962905185547, 7473.140588832354, 7558.470907036564, 7686.96156519225, 4188.267053265667, 4214.831406743757, 4285.442892423965, 4318.179545886272, 4422.336649502536, 3476.5132881396626, 3493.2664140530774, 3551.9289614207573, 3558.217192217708, 3581.0, 565.4289167940327, 618.6257314324858, 619.789271647642, 627.5262177056293, 639.859230969186, 638.1247270850704, 674.723363420995, 695.9582425054513, 704.1972151747012, 707.6461769115442, 8706.956465217634, 10067.59729610822, 10135.0, 10140.543675534618, 10475.0, 666.8932970724661, 706.0151089230598, 711.360851241888, 717.275551692794, 725.8004048886598, 4503.594676479132, 4890.486498917634, 4901.289313049588, 4936.640978787606, 4937.5556199942175, 84438.0, 95523.0, 106172.0, 110550.23624409454, 110717.0, 50747.746261268454, 82179.0, 88328.0, 89659.65510517347, 92666.0, 76699.0, 78168.04579885435, 79823.0, 81455.59272203602, 81460.0, 9168.404053736485, 10262.179025677779, 10661.520231589442, 10867.619633312795, 10890.183236257153, 46449.30326045045, 46464.0, 46869.53130468788, 47300.81747956329, 47821.521784781704, 59215.70392148184, 59636.50908727317, 61029.0, 61120.69439652773, 61639.691801542496, 12272.754544908874, 12356.505739770308, 12484.812727808909, 12610.369481525704, 13186.934065329995, 14118.50585229512, 14197.574072777834, 14376.568702938928, 14738.705225895208, 14819.0, 12996.870031299944, 13462.932685336511, 13472.326383680973, 13485.190888546718, 13506.122102063335, 12627.547203686805, 12722.0, 13560.79658805099, 13661.795073073714, 13760.724785504433, 12931.159474634118, 13347.265900375573, 13564.262371731467, 13658.863411365759, 14031.859681403055, 10846.511906964048, 11087.33475991443, 11207.71980700489, 11498.367589782307, 11669.649910502698, 9719.652271060948, 9789.9021009789, 11060.264260393104, 11279.661610151708, 11312.83030754523], "value": 7572.347378344352, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 115.0, 116.0, 116.0, 116.0, 115.0, 116.0, 115.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 109.0, 144.0, 109.0, 106.0, 109.0, 111.0, 151.0, 128.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 180.0, 185.0, 185.0, 182.0, 187.0, 185.0, 186.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 60.0, 91.0, 63.0, 62.0, 57.0, 60.0, 76.0, 57.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 88.0, 70.0, 71.0, 69.0, 81.0, 74.0, 95.0, 115.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 88.0, 88.0, 88.0, 88.0, 91.0, 113.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 83.0, 85.0, 87.0, 84.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 58.0, 61.0, 62.0, 65.0, 64.0, 64.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 67.0, 65.0, 63.0, 60.0, 57.0, 58.0, 58.0, 57.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 86.0, 82.0, 85.0, 85.0, 90.0, 91.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 141.0, 134.0, 145.0, 150.0, 135.0, 139.0, 178.0, 138.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 221.0, 181.0, 166.0, 164.0, 163.0, 162.0, 162.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 10:16:53 INFO - Return code: 0 10:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:54 ERROR - # TBPL SUCCESS # 10:16:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:54 INFO - 2017-03-14 10:16:54.060 screenresolution[1929:15314] starting screenresolution argv=screenresolution get 10:16:54 INFO - 2017-03-14 10:16:54.063 screenresolution[1929:15314] Display 0: 1600x1200x32@60 10:16:54 INFO - 2017-03-14 10:16:54.069 screenresolution[1930:15317] starting screenresolution argv=screenresolution list 10:16:54 INFO - Available Modes on Display 0 10:16:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:54 INFO - Intel Iris: 10:16:54 INFO - Chipset Model: Intel Iris 10:16:54 INFO - Type: GPU 10:16:54 INFO - Bus: Built-In 10:16:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:54 INFO - Vendor: Intel (0x8086) 10:16:54 INFO - Device ID: 0x0a2e 10:16:54 INFO - Revision ID: 0x0009 10:16:54 INFO - Displays: 10:16:54 INFO - Display: 10:16:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:54 INFO - Display Serial Number: 1600x1200 60 10:16:54 INFO - Main Display: Yes 10:16:54 INFO - Mirror: Off 10:16:54 INFO - Online: Yes 10:16:54 INFO - Rotation: Supported 10:16:54 INFO - Return code: 0 10:16:54 INFO - Running post-action listener: _resource_record_post_action 10:16:54 INFO - [mozharness: 2017-03-14 17:16:54.306779Z] Finished run-tests step (success) 10:16:54 INFO - Running post-run listener: _resource_record_post_run 10:16:54 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 819200; Write bytes: 508536832; Read time: 10; Write time: 1590 10:16:54 INFO - TinderboxPrint: CPU usage
54.0% 10:16:54 INFO - TinderboxPrint: I/O read bytes / time
819,200 / 10 10:16:54 INFO - TinderboxPrint: I/O write bytes / time
508,536,832 / 1,590 10:16:54 INFO - TinderboxPrint: CPU idle
2,208.3 (46.0%) 10:16:54 INFO - TinderboxPrint: CPU system
962.0 (20.0%) 10:16:54 INFO - TinderboxPrint: CPU user
1,635.5 (34.0%) 10:16:54 INFO - TinderboxPrint: Swap in / out
209,723,392 / 0 10:16:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206006784; Write bytes: 199610368; Read time: 15783; Write time: 381 10:16:54 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 782336; Write bytes: 297736192; Read time: 9; Write time: 1171 10:16:54 INFO - Running post-run listener: _upload_blobber_files 10:16:54 INFO - Blob upload gear active. 10:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:54 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 10:16:54 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:54 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:55 INFO - (blobuploader) - INFO - Done attempting. 10:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:56 INFO - (blobuploader) - INFO - Done attempting. 10:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:57 INFO - (blobuploader) - INFO - Done attempting. 10:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:00 INFO - (blobuploader) - INFO - Done attempting. 10:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:00 INFO - Return code: 0 10:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/999a0bddca3190429a7635b8d5c2af9bb9c90956f344bb780fc5cdf58d4e2cee2b2de7065d9a8c39b56c0b78467a78921d501b91296edca407a94f0e318638b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01a0a3d5150b91483c3abfd63cbcee628ddf73a0d9d36eff5908797fd26cdcbc451f90780be9d56dbc56e8ecf1cdd2cc9f60c464d4d80bbd0900f74640f1b9d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e31c8bab6b9a85fb83e89c83c0998ec104194dbd02d97f30a1f75ec324887dcb55c19db90766d42bcb3615ec0125110b9260cc0719f6019814158046e99c5da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6bab5283f769f7f317d7659565d171038988d6d3f501edf4b1e51df724318cf90199c95cdc1d1b6a7667bc442103697653164eb417fc1fb530e7d1cd02b6fbe"} 10:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:00 INFO - Contents: 10:17:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/999a0bddca3190429a7635b8d5c2af9bb9c90956f344bb780fc5cdf58d4e2cee2b2de7065d9a8c39b56c0b78467a78921d501b91296edca407a94f0e318638b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01a0a3d5150b91483c3abfd63cbcee628ddf73a0d9d36eff5908797fd26cdcbc451f90780be9d56dbc56e8ecf1cdd2cc9f60c464d4d80bbd0900f74640f1b9d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e31c8bab6b9a85fb83e89c83c0998ec104194dbd02d97f30a1f75ec324887dcb55c19db90766d42bcb3615ec0125110b9260cc0719f6019814158046e99c5da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6bab5283f769f7f317d7659565d171038988d6d3f501edf4b1e51df724318cf90199c95cdc1d1b6a7667bc442103697653164eb417fc1fb530e7d1cd02b6fbe"} 10:17:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:00 INFO - Copying logs to upload dir... 10:17:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.797571 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-14 10:17:00.642359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 10:17:00.645768) ========= 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.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/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/Mozilla-Aurora/sha512/999a0bddca3190429a7635b8d5c2af9bb9c90956f344bb780fc5cdf58d4e2cee2b2de7065d9a8c39b56c0b78467a78921d501b91296edca407a94f0e318638b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01a0a3d5150b91483c3abfd63cbcee628ddf73a0d9d36eff5908797fd26cdcbc451f90780be9d56dbc56e8ecf1cdd2cc9f60c464d4d80bbd0900f74640f1b9d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e31c8bab6b9a85fb83e89c83c0998ec104194dbd02d97f30a1f75ec324887dcb55c19db90766d42bcb3615ec0125110b9260cc0719f6019814158046e99c5da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6bab5283f769f7f317d7659565d171038988d6d3f501edf4b1e51df724318cf90199c95cdc1d1b6a7667bc442103697653164eb417fc1fb530e7d1cd02b6fbe"} build_url:https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/FO2s8wkGRXuuX5LlnLXRHw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/999a0bddca3190429a7635b8d5c2af9bb9c90956f344bb780fc5cdf58d4e2cee2b2de7065d9a8c39b56c0b78467a78921d501b91296edca407a94f0e318638b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01a0a3d5150b91483c3abfd63cbcee628ddf73a0d9d36eff5908797fd26cdcbc451f90780be9d56dbc56e8ecf1cdd2cc9f60c464d4d80bbd0900f74640f1b9d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e31c8bab6b9a85fb83e89c83c0998ec104194dbd02d97f30a1f75ec324887dcb55c19db90766d42bcb3615ec0125110b9260cc0719f6019814158046e99c5da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6bab5283f769f7f317d7659565d171038988d6d3f501edf4b1e51df724318cf90199c95cdc1d1b6a7667bc442103697653164eb417fc1fb530e7d1cd02b6fbe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 10:17:00.680020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 10:17:00.680312) ========= 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.CHc1PogPpk/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.C1UuD02LIh/Listeners TMPDIR=/var/folders/qf/j5tbbggj5vn1qwthzwd0p6bc00000w/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.005306 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 10:17:00.729031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 10:17:00.729335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 10:17:00.729650) ========= ========= Total master_lag: 0.18 =========