builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0091 starttime: 1484656320.06 results: success (0) buildid: 20170117030218 builduid: 5e48b2bbcdaa4087bcf1b9752bfbd88e revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.061074) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.061941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.062228) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.089153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.089532) ========= 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.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-17 04:32:00-- 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% 16.8M=0.001s 2017-01-17 04:32:00 (16.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.219779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.220086) ========= 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.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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.028973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:00.280974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 04:32:00.281324) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e275d37a06236981bff399b7d7aa0646be3fee7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e275d37a06236981bff399b7d7aa0646be3fee7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-17 04:32:00,383 truncating revision to first 12 chars 2017-01-17 04:32:00,383 Setting DEBUG logging. 2017-01-17 04:32:00,383 attempt 1/10 2017-01-17 04:32:00,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e275d37a062?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 04:32:01,510 unpacking tar archive at: mozilla-central-3e275d37a062/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 04:32:01.722016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:01.722319) ========= script_repo_revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:01.722711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:01.722975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 04:32:01.742660) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-17 04:32:01.743021) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:01 INFO - MultiFileLogger online at 20170117 04:32:01 in /builds/slave/test 04:32:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:32:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:01 INFO - {'append_to_log': False, 04:32:01 INFO - 'base_work_dir': '/builds/slave/test', 04:32:01 INFO - 'blob_upload_branch': 'Firefox', 04:32:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:01 INFO - 'branch': 'Firefox', 04:32:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:01 INFO - 'config_files': ('talos/mac_config.py',), 04:32:01 INFO - 'default_actions': ('clobber', 04:32:01 INFO - 'read-buildbot-config', 04:32:01 INFO - 'download-and-extract', 04:32:01 INFO - 'populate-webroot', 04:32:01 INFO - 'create-virtualenv', 04:32:01 INFO - 'install', 04:32:01 INFO - 'run-tests'), 04:32:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:01 INFO - 'download_minidump_stackwalk': True, 04:32:01 INFO - 'download_symbols': 'ondemand', 04:32:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:01 INFO - 'installer_path': 'installer.exe', 04:32:01 INFO - 'log_level': 'info', 04:32:01 INFO - 'log_name': 'talos', 04:32:01 INFO - 'log_to_console': True, 04:32:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:32:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:32:01 INFO - 'opt_config_files': (), 04:32:01 INFO - 'pip_index': False, 04:32:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:01 INFO - 'cmd': ('bash', 04:32:01 INFO - '-c', 04:32:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:01 INFO - 'enabled': True, 04:32:01 INFO - 'halt_on_failure': False, 04:32:01 INFO - 'name': 'check_screen_resolution'},), 04:32:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:01 INFO - 'cmd': ('bash', 04:32:01 INFO - '-c', 04:32:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:01 INFO - 'enabled': True, 04:32:01 INFO - 'halt_on_failure': False, 04:32:01 INFO - 'name': 'check_screen_resolution'},), 04:32:01 INFO - 'run_cmd_checks_enabled': True, 04:32:01 INFO - 'sps_profile': False, 04:32:01 INFO - 'sps_profile_interval': 0, 04:32:01 INFO - 'suite': 'dromaeojs', 04:32:01 INFO - 'system_bits': '32', 04:32:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:01 INFO - 'title': 't-yosemite-r7-0091', 04:32:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:01 INFO - 'use_talos_json': True, 04:32:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:01 INFO - 'work_dir': 'build'} 04:32:01 INFO - [mozharness: 2017-01-17 12:32:01.951107Z] Running clobber step. 04:32:01 INFO - Running pre-action listener: _resource_record_pre_action 04:32:01 INFO - Running main action method: clobber 04:32:01 INFO - rmtree: /builds/slave/test/build 04:32:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:04 INFO - Running post-action listener: _resource_record_post_action 04:32:04 INFO - [mozharness: 2017-01-17 12:32:04.291911Z] Finished clobber step (success) 04:32:04 INFO - [mozharness: 2017-01-17 12:32:04.292137Z] Running read-buildbot-config step. 04:32:04 INFO - Running pre-action listener: _resource_record_pre_action 04:32:04 INFO - Running main action method: read_buildbot_config 04:32:04 INFO - Using buildbot properties: 04:32:04 INFO - { 04:32:04 INFO - "project": "", 04:32:04 INFO - "product": "firefox", 04:32:04 INFO - "script_repo_revision": "production", 04:32:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:32:04 INFO - "repository": "", 04:32:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:32:04 INFO - "buildid": "20170117030218", 04:32:04 INFO - "stage_platform": "macosx64", 04:32:04 INFO - "basedir": "/builds/slave/test", 04:32:04 INFO - "nightly_build": "True", 04:32:04 INFO - "buildnumber": 27, 04:32:04 INFO - "slavename": "t-yosemite-r7-0091", 04:32:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:32:04 INFO - "platform": "yosemite_r7", 04:32:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:32:04 INFO - "branch": "mozilla-central", 04:32:04 INFO - "repo_path": "mozilla-central", 04:32:04 INFO - "revision": "3e275d37a06236981bff399b7d7aa0646be3fee7", 04:32:04 INFO - "pgo_build": "False", 04:32:04 INFO - "builduid": "5e48b2bbcdaa4087bcf1b9752bfbd88e", 04:32:04 INFO - "slavebuilddir": "test" 04:32:04 INFO - } 04:32:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:32:04 INFO - Running post-action listener: _resource_record_post_action 04:32:04 INFO - [mozharness: 2017-01-17 12:32:04.298125Z] Finished read-buildbot-config step (success) 04:32:04 INFO - [mozharness: 2017-01-17 12:32:04.298347Z] Running download-and-extract step. 04:32:04 INFO - Running pre-action listener: _resource_record_pre_action 04:32:04 INFO - Running main action method: download_and_extract 04:32:04 INFO - mkdir: /builds/slave/test/build/tests 04:32:04 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')]} 04:32:04 INFO - trying https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:32:05 INFO - Downloaded 1199 bytes. 04:32:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:05 INFO - Using the following test package requirements: 04:32:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:32:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:32:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:32:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'jsshell-mac.zip'], 04:32:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:32:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:32:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:32:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:32:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:32:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:32:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:32:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:32:06 INFO - Expected file size: 16326686 04:32:06 INFO - Obtained file size: 16326686 04:32:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:32:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:32:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:32:13 INFO - Expected file size: 16326686 04:32:13 INFO - Obtained file size: 16326686 04:32:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:32:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:20 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:32:22 INFO - Expected file size: 14403463 04:32:22 INFO - Obtained file size: 14403463 04:32: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')]} 04:32:22 INFO - trying https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:22 INFO - Downloading https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:32:24 INFO - Downloaded 70185748 bytes. 04:32:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:24 INFO - mkdir: /builds/slave/test/properties 04:32:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:24 INFO - Contents: 04:32:24 INFO - build_url:https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:25 INFO - Running post-action listener: _resource_record_post_action 04:32:25 INFO - Running post-action listener: set_extra_try_arguments 04:32:25 INFO - [mozharness: 2017-01-17 12:32:25.113775Z] Finished download-and-extract step (success) 04:32:25 INFO - [mozharness: 2017-01-17 12:32:25.113880Z] Running populate-webroot step. 04:32:25 INFO - Running pre-action listener: _resource_record_pre_action 04:32:25 INFO - Running main action method: populate_webroot 04:32:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:25 INFO - '--tppagecycles', 04:32:25 INFO - '7'], 04:32:25 INFO - 'tests': ['tsvgm']}}, 04:32:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['damp', 'tps']}, 04:32:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'tests': ['damp', 'tps']}, 04:32:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['dromaeo_dom']}, 04:32:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['basic_compositor_video']}, 04:32:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['a11yr', 04:32:25 INFO - 'ts_paint', 04:32:25 INFO - 'tpaint', 04:32:25 INFO - 'sessionrestore', 04:32:25 INFO - 'sessionrestore_no_auto_restore', 04:32:25 INFO - 'tabpaint']}, 04:32:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['tsvgx', 04:32:25 INFO - 'tsvgr_opacity', 04:32:25 INFO - 'tart', 04:32:25 INFO - 'tscrollx', 04:32:25 INFO - 'cart', 04:32:25 INFO - 'tsvg_static']}, 04:32:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:25 INFO - 'tsvgr_opacity', 04:32:25 INFO - 'tart', 04:32:25 INFO - 'tscrollx', 04:32:25 INFO - 'cart', 04:32:25 INFO - 'tsvg_static']}, 04:32:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'talos_options': ['--disable-e10s'], 04:32:25 INFO - 'tests': ['tp5o']}, 04:32:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:32:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'talos_options': ['--disable-e10s', 04:32:25 INFO - '--xperf_path', 04:32:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:25 INFO - 'tests': ['tp5n']}, 04:32:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:32:25 INFO - 'talos_options': ['--xperf_path', 04:32:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:25 INFO - 'tests': ['tp5n']}}, 04:32:25 INFO - 'talos.zip': {'path': '', 04:32:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:25 INFO - Running post-action listener: _resource_record_post_action 04:32:25 INFO - [mozharness: 2017-01-17 12:32:25.132731Z] Finished populate-webroot step (success) 04:32:25 INFO - [mozharness: 2017-01-17 12:32:25.132821Z] Running create-virtualenv step. 04:32:25 INFO - Running pre-action listener: _resource_record_pre_action 04:32:25 INFO - Running main action method: create_virtualenv 04:32:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:25 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 04:32:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:25 INFO - Using real prefix '/tools/python27' 04:32:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:28 INFO - Installing pip.................done. 04:32:28 INFO - Return code: 0 04:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Output received: 04:32:29 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) 04:32:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32: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', 'pip>=1.5'] in /builds/slave/test/build 04:32: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 pip>=1.5 04:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:29 INFO - 'HOME': '/Users/cltbld', 04:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:29 INFO - 'LOGNAME': 'cltbld', 04:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:29 INFO - 'MOZ_NO_REMOTE': '1', 04:32:29 INFO - 'NO_EM_RESTART': '1', 04:32:29 INFO - 'PAGER': '/bin/cat', 04:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:29 INFO - 'PWD': '/builds/slave/test', 04:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:29 INFO - 'SHELL': '/bin/bash', 04:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:29 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:29 INFO - 'USER': 'cltbld', 04:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:29 INFO - 'XPC_FLAGS': '0x0', 04:32:29 INFO - 'XPC_SERVICE_NAME': '0', 04:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 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 04:32:29 INFO - Cleaning up... 04:32:29 INFO - Return code: 0 04:32:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', '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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32: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 psutil>=3.1.1 04:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:29 INFO - 'HOME': '/Users/cltbld', 04:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:29 INFO - 'LOGNAME': 'cltbld', 04:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:29 INFO - 'MOZ_NO_REMOTE': '1', 04:32:29 INFO - 'NO_EM_RESTART': '1', 04:32:29 INFO - 'PAGER': '/bin/cat', 04:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:29 INFO - 'PWD': '/builds/slave/test', 04:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:29 INFO - 'SHELL': '/bin/bash', 04:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:29 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:29 INFO - 'USER': 'cltbld', 04:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:29 INFO - 'XPC_FLAGS': '0x0', 04:32:29 INFO - 'XPC_SERVICE_NAME': '0', 04:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 INFO - Downloading/unpacking psutil>=3.1.1 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:33 INFO - Installing collected packages: psutil 04:32:33 INFO - Running setup.py install for psutil 04:32:33 INFO - building 'psutil._psutil_osx' extension 04:32:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 INFO - building 'psutil._psutil_posix' extension 04:32:34 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 04:32:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:34 INFO - ^ 04:32:34 INFO - 1 warning generated. 04:32:34 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 04:32:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:34 INFO - Successfully installed psutil 04:32:34 INFO - Cleaning up... 04:32:34 INFO - Return code: 0 04:32:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:34 INFO - 'HOME': '/Users/cltbld', 04:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:34 INFO - 'LOGNAME': 'cltbld', 04:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:34 INFO - 'MOZ_NO_REMOTE': '1', 04:32:34 INFO - 'NO_EM_RESTART': '1', 04:32:34 INFO - 'PAGER': '/bin/cat', 04:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:34 INFO - 'PWD': '/builds/slave/test', 04:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:34 INFO - 'SHELL': '/bin/bash', 04:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:34 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:34 INFO - 'USER': 'cltbld', 04:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:34 INFO - 'XPC_FLAGS': '0x0', 04:32:34 INFO - 'XPC_SERVICE_NAME': '0', 04:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:37 INFO - Installing collected packages: mozsystemmonitor 04:32:37 INFO - Running setup.py install for mozsystemmonitor 04:32:37 INFO - Successfully installed mozsystemmonitor 04:32:37 INFO - Cleaning up... 04:32:37 INFO - Return code: 0 04:32:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:37 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 04:32:37 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 04:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:37 INFO - 'HOME': '/Users/cltbld', 04:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PAGER': '/bin/cat', 04:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:37 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - 'XPC_FLAGS': '0x0', 04:32:37 INFO - 'XPC_SERVICE_NAME': '0', 04:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:41 INFO - warning: no files found matching '*.txt' 04:32:41 INFO - no previously-included directories found matching 'build' 04:32:41 INFO - no previously-included directories found matching 'dist' 04:32:41 INFO - no previously-included directories found matching '.git*' 04:32:41 INFO - Installing collected packages: jsonschema, functools32 04:32:41 INFO - Running setup.py install for functools32 04:32:41 INFO - warning: no files found matching '*.txt' 04:32:41 INFO - no previously-included directories found matching 'build' 04:32:41 INFO - no previously-included directories found matching 'dist' 04:32:41 INFO - no previously-included directories found matching '.git*' 04:32:41 INFO - Successfully installed jsonschema functools32 04:32:41 INFO - Cleaning up... 04:32:41 INFO - Return code: 0 04:32:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:41 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:41 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 04:32:41 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 04:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:41 INFO - 'HOME': '/Users/cltbld', 04:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:41 INFO - 'LOGNAME': 'cltbld', 04:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:41 INFO - 'MOZ_NO_REMOTE': '1', 04:32:41 INFO - 'NO_EM_RESTART': '1', 04:32:41 INFO - 'PAGER': '/bin/cat', 04:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:41 INFO - 'PWD': '/builds/slave/test', 04:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:41 INFO - 'SHELL': '/bin/bash', 04:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:41 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:41 INFO - 'USER': 'cltbld', 04:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:41 INFO - 'XPC_FLAGS': '0x0', 04:32:41 INFO - 'XPC_SERVICE_NAME': '0', 04:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:41 INFO - Cleaning up... 04:32:41 INFO - Return code: 0 04:32:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:41 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:41 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 04:32:41 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 04:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:41 INFO - 'HOME': '/Users/cltbld', 04:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:41 INFO - 'LOGNAME': 'cltbld', 04:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:41 INFO - 'MOZ_NO_REMOTE': '1', 04:32:41 INFO - 'NO_EM_RESTART': '1', 04:32:41 INFO - 'PAGER': '/bin/cat', 04:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:41 INFO - 'PWD': '/builds/slave/test', 04:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:41 INFO - 'SHELL': '/bin/bash', 04:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:41 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:41 INFO - 'USER': 'cltbld', 04:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:41 INFO - 'XPC_FLAGS': '0x0', 04:32:41 INFO - 'XPC_SERVICE_NAME': '0', 04:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:42 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 04:32:42 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 04:32:42 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 04:32:42 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 04:32:42 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 04:32:42 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 04:32:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:45 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 04:32:45 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 04:32:45 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 04:32:45 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 04:32:45 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 04:32:45 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 04:32:45 INFO - Downloading docopt-0.6.1.tar.gz 04:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:45 INFO - Running setup.py install for blobuploader 04:32:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:46 INFO - Running setup.py install for requests 04:32:46 INFO - Running setup.py install for docopt 04:32:46 INFO - Successfully installed blobuploader requests docopt 04:32:46 INFO - Cleaning up... 04:32:46 INFO - Return code: 0 04:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:46 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:46 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 04:32:46 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 04:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:46 INFO - 'HOME': '/Users/cltbld', 04:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:46 INFO - 'LOGNAME': 'cltbld', 04:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:46 INFO - 'MOZ_NO_REMOTE': '1', 04:32:46 INFO - 'NO_EM_RESTART': '1', 04:32:46 INFO - 'PAGER': '/bin/cat', 04:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:46 INFO - 'PWD': '/builds/slave/test', 04:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:46 INFO - 'SHELL': '/bin/bash', 04:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:46 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:46 INFO - 'USER': 'cltbld', 04:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:46 INFO - 'XPC_FLAGS': '0x0', 04:32:46 INFO - 'XPC_SERVICE_NAME': '0', 04:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-X3unN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-CFt1ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-bgsFhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-uuXjRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-KwmIV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-2fDsEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-1ncxTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-hIp8wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:47 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-km9xlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-lqeZ0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-lSltiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-DPP4jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-bjYPRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-diiLw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-TTWya9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-JJ_3W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:48 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-sOU7r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:48 INFO - Running setup.py install for manifestparser 04:32:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozcrash 04:32:49 INFO - Running setup.py install for mozdebug 04:32:49 INFO - Running setup.py install for mozdevice 04:32:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozfile 04:32:49 INFO - Running setup.py install for mozhttpd 04:32:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozinfo 04:32:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozInstall 04:32:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozleak 04:32:50 INFO - Running setup.py install for mozlog 04:32:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Running setup.py install for moznetwork 04:32:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Running setup.py install for mozprocess 04:32:50 INFO - Running setup.py install for mozprofile 04:32:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Running setup.py install for mozrunner 04:32:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:50 INFO - Running setup.py install for mozscreenshot 04:32:51 INFO - Running setup.py install for moztest 04:32:51 INFO - Running setup.py install for mozversion 04:32:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:51 INFO - Cleaning up... 04:32:51 INFO - Return code: 0 04:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:51 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:51 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 04:32:51 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 04:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:51 INFO - 'HOME': '/Users/cltbld', 04:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:51 INFO - 'LOGNAME': 'cltbld', 04:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:51 INFO - 'MOZ_NO_REMOTE': '1', 04:32:51 INFO - 'NO_EM_RESTART': '1', 04:32:51 INFO - 'PAGER': '/bin/cat', 04:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:51 INFO - 'PWD': '/builds/slave/test', 04:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:51 INFO - 'SHELL': '/bin/bash', 04:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:51 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:51 INFO - 'USER': 'cltbld', 04:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:51 INFO - 'XPC_FLAGS': '0x0', 04:32:51 INFO - 'XPC_SERVICE_NAME': '0', 04:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:51 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Af2VLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:51 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)) 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:51 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-PG6FYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:51 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)) 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:51 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-HYHqOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:51 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)) 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-DQLm1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-qG00aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-94_xfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-tCwMmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-6d6f5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-evMgzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-60sshD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-FBrh2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:52 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)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-IC30Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:52 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-RAnKTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:53 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)) 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:53 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-5xt7m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:53 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)) 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:53 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-bd1nea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:53 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)) 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:53 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-ZIBVHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:53 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)) 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:53 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-nfJBgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:53 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)) 04:32:53 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)) 04:32:53 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)) 04:32:53 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)) 04:32:53 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)) 04:32:53 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)) 04:32:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:53 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 04:32:56 INFO - Downloading blessings-1.6.tar.gz 04:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:56 INFO - Installing collected packages: blessings 04:32:56 INFO - Running setup.py install for blessings 04:32:56 INFO - Successfully installed blessings 04:32:56 INFO - Cleaning up... 04:32:56 INFO - Return code: 0 04:32:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:56 INFO - Reading from file tmpfile_stdout 04:32:56 INFO - Current package versions: 04:32:56 INFO - blessings == 1.6 04:32:56 INFO - blobuploader == 1.2.4 04:32:56 INFO - docopt == 0.6.1 04:32:56 INFO - functools32 == 3.2.3-2 04:32:56 INFO - jsonschema == 2.5.1 04:32:56 INFO - manifestparser == 1.1 04:32:56 INFO - mozInstall == 1.12 04:32:56 INFO - mozcrash == 1.0 04:32:56 INFO - mozdebug == 0.1 04:32:56 INFO - mozdevice == 0.49 04:32:56 INFO - mozfile == 1.2 04:32:56 INFO - mozhttpd == 0.7 04:32:56 INFO - mozinfo == 0.9 04:32:56 INFO - mozleak == 0.1 04:32:56 INFO - mozlog == 3.4 04:32:56 INFO - moznetwork == 0.27 04:32:56 INFO - mozprocess == 0.24 04:32:56 INFO - mozprofile == 0.28 04:32:56 INFO - mozrunner == 6.13 04:32:56 INFO - mozscreenshot == 0.1 04:32:56 INFO - mozsystemmonitor == 0.3 04:32:56 INFO - moztest == 0.8 04:32:56 INFO - mozversion == 1.4 04:32:56 INFO - psutil == 3.1.1 04:32:56 INFO - requests == 1.2.3 04:32:56 INFO - wsgiref == 0.1.2 04:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:56 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')]} 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:56 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')]} 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:56 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:56 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 04:32:56 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 04:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:56 INFO - 'HOME': '/Users/cltbld', 04:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:56 INFO - 'LOGNAME': 'cltbld', 04:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:56 INFO - 'MOZ_NO_REMOTE': '1', 04:32:56 INFO - 'NO_EM_RESTART': '1', 04:32:56 INFO - 'PAGER': '/bin/cat', 04:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:56 INFO - 'PWD': '/builds/slave/test', 04:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:56 INFO - 'SHELL': '/bin/bash', 04:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:56 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:56 INFO - 'USER': 'cltbld', 04:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:56 INFO - 'XPC_FLAGS': '0x0', 04:32:56 INFO - 'XPC_SERVICE_NAME': '0', 04:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 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)) 04:32:56 INFO - Cleaning up... 04:32:56 INFO - Return code: 0 04:32:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:56 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')]} 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:56 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')]} 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:56 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 0x104e87b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e7058c990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, '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.wl89r0TkbZ/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.sP3oAdavgu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:32:56 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 04:32:56 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 04:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:56 INFO - 'HOME': '/Users/cltbld', 04:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:56 INFO - 'LOGNAME': 'cltbld', 04:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:56 INFO - 'MOZ_NO_REMOTE': '1', 04:32:56 INFO - 'NO_EM_RESTART': '1', 04:32:56 INFO - 'PAGER': '/bin/cat', 04:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:56 INFO - 'PWD': '/builds/slave/test', 04:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:56 INFO - 'SHELL': '/bin/bash', 04:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:32:56 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:56 INFO - 'USER': 'cltbld', 04:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:56 INFO - 'XPC_FLAGS': '0x0', 04:32:56 INFO - 'XPC_SERVICE_NAME': '0', 04:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:57 INFO - Cleaning up... 04:32:57 INFO - Return code: 0 04:32:57 INFO - Running post-action listener: _resource_record_post_action 04:32:57 INFO - Running post-action listener: _start_resource_monitoring 04:32:57 INFO - Starting resource monitoring. 04:32:57 INFO - [mozharness: 2017-01-17 12:32:57.255737Z] Finished create-virtualenv step (success) 04:32:57 INFO - [mozharness: 2017-01-17 12:32:57.256697Z] Running install step. 04:32:57 INFO - Running pre-action listener: _resource_record_pre_action 04:32:57 INFO - Running main action method: install 04:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:57 INFO - Reading from file tmpfile_stdout 04:32:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:57 INFO - Reading from file tmpfile_stdout 04:32:57 INFO - Output received: 04:32:57 INFO - Usage: mozinstall [options] installer 04:32:57 INFO - Options: 04:32:57 INFO - -h, --help show this help message and exit 04:32:57 INFO - -d DEST, --destination=DEST 04:32:57 INFO - Directory to install application into. [default: 04:32:57 INFO - "/builds/slave/test"] 04:32:57 INFO - --app=APP Application being installed. [default: firefox] 04:32:57 INFO - mkdir: /builds/slave/test/build/application 04:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:19 INFO - Reading from file tmpfile_stdout 04:33:19 INFO - Output received: 04:33:19 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:33:19 INFO - Running post-action listener: _resource_record_post_action 04:33:19 INFO - [mozharness: 2017-01-17 12:33:19.528897Z] Finished install step (success) 04:33:19 INFO - [mozharness: 2017-01-17 12:33:19.529063Z] Running run-tests step. 04:33:19 INFO - Running pre-action listener: _resource_record_pre_action 04:33:19 INFO - Running main action method: run_tests 04:33:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:19 INFO - 2017-01-17 04:33:19.543 screenresolution[1632:7609] starting screenresolution argv=screenresolution get 04:33:19 INFO - 2017-01-17 04:33:19.546 screenresolution[1632:7609] Display 0: 1600x1200x32@60 04:33:19 INFO - 2017-01-17 04:33:19.551 screenresolution[1633:7611] starting screenresolution argv=screenresolution list 04:33:19 INFO - Available Modes on Display 0 04:33:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:19 INFO - Intel Iris: 04:33:19 INFO - Chipset Model: Intel Iris 04:33:19 INFO - Type: GPU 04:33:19 INFO - Bus: Built-In 04:33:19 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:19 INFO - Vendor: Intel (0x8086) 04:33:19 INFO - Device ID: 0x0a2e 04:33:19 INFO - Revision ID: 0x0009 04:33:19 INFO - Displays: 04:33:19 INFO - Display: 04:33:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:19 INFO - Display Serial Number: 1600x1200 60 04:33:19 INFO - Main Display: Yes 04:33:19 INFO - Mirror: Off 04:33:19 INFO - Online: Yes 04:33:19 INFO - Rotation: Supported 04:33:19 INFO - Return code: 0 04:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:19 INFO - Python 2.7.3 04:33:19 INFO - Return code: 0 04:33:19 INFO - grabbing minidump binary from tooltool 04:33:19 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')]} 04:33:19 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 0x104c65d30>, '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 0x104b8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:19 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 04:33:19 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 04:33:19 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 04:33:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:19 INFO - Return code: 0 04:33:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --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 04:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wl89r0TkbZ/Render', 04:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:19 INFO - 'HOME': '/Users/cltbld', 04:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:19 INFO - 'LOGNAME': 'cltbld', 04:33:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:19 INFO - 'MOZ_NO_REMOTE': '1', 04:33:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:19 INFO - 'NO_EM_RESTART': '1', 04:33:19 INFO - 'PAGER': '/bin/cat', 04:33:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:19 INFO - 'PWD': '/builds/slave/test', 04:33:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:19 INFO - 'SHELL': '/bin/bash', 04:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sP3oAdavgu/Listeners', 04:33:19 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:19 INFO - 'USER': 'cltbld', 04:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:19 INFO - 'XPC_FLAGS': '0x0', 04:33:19 INFO - 'XPC_SERVICE_NAME': '0', 04:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:33:20 INFO - mozversion application_buildid: 20170117030218 04:33:20 INFO - mozversion application_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 04:33:20 INFO - mozversion application_display_name: Nightly 04:33:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:20 INFO - mozversion application_name: Firefox 04:33:20 INFO - mozversion application_remotingname: firefox 04:33:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:20 INFO - mozversion application_vendor: Mozilla 04:33:20 INFO - mozversion application_version: 53.0a1 04:33:20 INFO - mozversion platform_buildid: 20170117030218 04:33:20 INFO - mozversion platform_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 04:33:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:20 INFO - mozversion platform_version: 53.0a1 04:33:20 INFO - using testdate: 1484656400 04:33:20 INFO - actual date: 1484656400 04:33:20 INFO - starting webserver on 'localhost:49244' 04:33:20 INFO - SUITE-START | Running 2 tests 04:33:20 INFO - TEST-START | dromaeo_css 04:33:20 INFO - operating with platform_type : mac_ 04:33:20 INFO - Initialising browser for dromaeo_css test... 04:33:20 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmp1lUXNi/profile http://localhost:49244/getInfo.html) 04:33:22 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 04:33:22 INFO - PROCESS | 1643 | colorDepth:24 04:33:22 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 04:33:22 INFO - PROCESS | 1643 | __metrics 04:33:22 INFO - PROCESS | 1643 | 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" 04:33:22 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:23 INFO - TEST-INFO | 1643: exit 0 04:33:23 INFO - Browser initialized. 04:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:23 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmp1lUXNi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:35 INFO - PROCESS | 1646 | RSS: Main: 226832384 04:33:35 INFO - PROCESS | 1646 | 04:36:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:36:41 INFO - PROCESS | 1646 | RSS: Main: 379559936 04:36:41 INFO - PROCESS | 1646 | 04:38:25 INFO - PROCESS | 1646 | ************************* 04:38:25 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 04:38:25 INFO - PROCESS | 1646 | 04:38:25 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:38:25 INFO - PROCESS | 1646 | Full stack: 04:38:25 INFO - PROCESS | 1646 | ************************* 04:39:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:39:44 INFO - PROCESS | 1646 | RSS: Main: 369197056 04:39:44 INFO - PROCESS | 1646 | 04:42:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:42:47 INFO - PROCESS | 1646 | RSS: Main: 330829824 04:42:47 INFO - PROCESS | 1646 | 04:45:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:45:50 INFO - PROCESS | 1646 | RSS: Main: 341037056 04:45:50 INFO - PROCESS | 1646 | 04:48:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:48:55 INFO - PROCESS | 1646 | RSS: Main: 331038720 04:48:55 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:51:58 INFO - PROCESS | 1646 | RSS: Main: 413155328 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | __start_tp_report 04:51:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 04:51:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 04:51:58 INFO - PROCESS | 1646 | |i|pagename|runs| 04:51:58 INFO - PROCESS | 1646 | |0;dojo.html;3307.9834600826994;3329.317489914567;3333.8499767510475;3360.89917302481;3387.796732196068;5587.7485513151905;5639.436056394358;5670.432956704332;5672.149177623353;5676.744546495407;5614.3543492498375;5642.858928526789;5646.350669672989;5715.428457154282;5757.165211044396;5066.316047333599;5125.538701516863;5144.948550514503;5158.948410515903;5177.275181474578;4679.953200468003;5235.790568377261;5251.816186433475;5274.235235890794;5274.841754747364;5073;5224.4775522447835;5231.921521177185;5233.555147812441;5271.920921186185;5093.745312734349;5108.208227724708;5153.123968925292;5162.6902385856965;5165.586753059783;4439.779060758285;5113.411957624883;5146.0479811235045;5149.871253218699;5161.019406312788;5683.2895888014;5687.374388817227;5694.202811606337;5699.68651724155;5707.086866101446;6086.908696369514;6104.671374792629;6106.035994416554;6116.214037636738;6179;6184.07238914162;6198.256209254873;6227.159333489966;6248.750049997994;6251.562390632612;5794.594378393472;5814.447627475383;5824.446677565625;5828.59199856006;5836.533077353802;6126.111713801474;6138.861138861139;6144.941444616104;6191.473724733358;6221.9377806222265;6103.246756470893;6134.263888333428;6144.941444616104;6147.569670123138;6170.136180934673;5463.743339032045;6067.393260673985;6085.5435842312;6200.472959798468;6228.03465462854;6042.335343112254;6113.419225173601;6137.9286238596105;6141.915626108588;6196.535259855529;6251.499880009679;6251.74993000284;6256.499480041586;6257.374262573706;6260.530460215502;4505.662075344297;4900.509949005071;4936.136176169228;4947.25791131326;4972.90054198914;4447.421835161408;4460.107978404268;4464.888377790581;4483.7533935633855;4490.438695163105;5720.914186287209;5763.971180144156;5781.075027995585;5795.9420405796245;5817.0983497557945;6109.829807539378;6197.070439434121;6211.223597050369;6212;6250.624962502265;5653.095504719226;5721;5734.541236701054;5734.942650573525;5755.194272801811;5405.21624364465;5408.891822163613;5412.621116521806;5413.2692086568595;5413.377461591888;6175.382461753788;6179.721912513858;6217.626942383381;6235.906461403082;6237.095621135;6210.813675589739;6304.810855674337;6311.368863113836;6312.621242725451;6317.905231421624;6283;6283.403076707706;6288.622682639057;6295.276043254901;6300.338464461349;5941.91087133702;5978.730957107027;6192.504599632109;6209.130721698875;6222.160008398808;6104.307579233734;6106.297775755845;6136.693165341804;6142.140100386039;6145.907811382922;5873.148393483007;6021.729022193924;6038.849028774316;6041.24484439445;6046.062860256668;5901.5868889177345;5906.26171728534;5945.791897283574;5956.970215148896;6020.277566692025;5843.590948633555;5886.087656413263;5917.142014407973;5919.91120133207;5971.970140149445;6108.602940809011;6115.449609535163;6119.173911521888;6127.172831667846;6134.723937422916;5732.426757324234;5890.204822349099;5903.970480147572;5911;5914.02418600926 04:51:58 INFO - PROCESS | 1646 | |1;ext.html;403.82837294149977;458.99082018359655;463.93526855865787;503.5342308364763;505.5778425015112;29337.332833395827;32514.349713005755;37835.810820945924;39645.20709585814;39796;41211.79394103025;41549.79225103878;41642.37536436948;41667.58332416675;41764.538241161565;8161;8380.497170169809;9152.72541823743;9348.719538413825;9361.48511831849;10847.403392813392;11133.053690436323;11145.888541114608;11302.265352752085;11314.943425282861;11077.50151243196;11157.888421115766;11166.66500004997;11170.441477926111;11180.888191118065;9559.761005974837;11134.777304453906;11154.940280673323;11197.832032519518;11216.551337946472;11002.449877506093;11049.613263535817;11055.22613417061;11062.502187401506;11067.280626759235;38499.615003850166;38737;38738.41892371617;38748.61251387478;38821.22357552833;3960.4653371794725;4007.2786898358286;4012.4181993611055;4047.4738284022887;4139.8965025874295;28075.29811754702;29936.251593710113;30290.242743931358;30304;30312.696873031207;3141.371725654878;3160.8893688721014;3218.742500599946;3250.1712063423674;3288.588926384202;453358;454248;454513.727431364;455113;455500;57138.714306429036;57462.7126864363;57498.7125064372;57502.7124864373;57658.846823064145;57955.71022144862;58089.8382032357;59439;59575.25521682153;59777.40222597718;15525.767113493306;15748.448804291795;15783.053016819027;15790.36838526469;15797.447089352047;10908.23642345044;11202.887971120348;11216.831747523795;12106.69733256658;12300.077494187793;14960.476383326532;15163.166025868682;15230.695386092437;15359.769603455958;15376.000559963566;7238.203797582261;7312.5246858954;7338.0187349415355;7377.8155546111775;7388.852222955511;869.1916517638531;870.5603670146536;875.3609864798606;892.1925657280042;912.7033714042963;29037;29151.416971660874;29277.56083658747;29851.95518156854;29911.252218694706;916.9042993622691;1044.2220545693508;1081.0702795595782;1100.1693721240413;1180.9586664466703;12876.935615321863;14582.48961286371;15049.097054176784;15315.081095134328;15490.535283941499;605308;610212;611583;612091;612769;47091.76454117707;56776;56922;57013;57027.42972570304;1385.47352006239;1429.9285035748171;1432.7421064208543;1447.5078473319122;1450.0067453794184;23354;28448.715512845436;28477.145685629464;28721;29391.85304073466;46477.838054048916;46829.2975605373;46951.82620434516;47019.52980470152;47025.2946205814;513157;515275.5905511811;516677;517179;517256;36908.63091369052;37159.442608360354;37367;37631.81184094062;37646;44022.77988610036;44310.11379772451;44769.328460073775;45117.32324015077;45299.77350113228;35851.64148358483;36312.9931406369;36314.63685363218;36938.630613693516;37176.81411592925;36210;36242.8187859059;37276.44085338668;37451.625483745906;37566;35425.82287088548;36076.45885311775;36284.81857590695;36402;36729.44905826468;31567.21081972969;33062.66937330596;33141;33147.50278745773;33171.83414082914;18451.354202603383;23314.717690527184;24151.275461736175;24315.175735524175;24369.26892193237 04:51:58 INFO - PROCESS | 1646 | |2;jquery.html;347.47010808517007;370.85721997031135;391.6162161082138;397.7673061259163;425.308873081243;15083.472078477256;15352.385904563818;17122.486325410242;20658.89670551645;21267.214876652746;20258.493537661565;20867.478313042182;22128.33614991549;22168.667469987922;22373.32880013598;5191.247269145972;5251.842444726664;5376.38171610264;5419.5393391561565;5440.401555828856;5319.069162896497;5360.731963401834;5394.217838413428;5402.702851343174;5423.322084739408;3814.389697648377;4038.97980510097;5717.828465146053;5954.732037058343;5985.221921150266;6051.939480605181;6052.243469566304;6062.1209924561135;6070.392960703938;7399.334059934577;7510.549367037996;7588.886166707503;7678.270564296383;7678.731244406419;7688.154303026663;29278.853605731834;30071.548926766118;30139.547906781198;30381;30385.392292154254;2264.52444986553;2611.2427396055123;2876.7842411819197;2880.0927707771984;2951.896683616085;16361.59096022597;16839.242234099373;17068.487945361536;17204.967701937923;17626.647467050716;1947.8246957773868;1973.4770285874256;1978.3273686946507;1981.7423734914512;2005.2780998840406;122035;123617.38191308986;126960;163332;167699.1615041917;23005.539889202457;23355;23403.414914627272;23664;23686.157661080782;40205.79897100496;41587.37618935719;41732.37401438981;41880.37179442311;41909.58090419057;11053;11277.097832173406;11303.660890173307;11358.829617555743;11496.42517874103;9038.593263303168;9070.591823367833;9073.77315567116;9224.769380765534;9243.39917905334;9319.301052421095;10454.006869347551;10659.89340106589;11120.110391168688;11133.443327833576;3577.5528058992627;3985.80070996449;4001.419794129835;4074.2055299216368;4085;929.5398777605129;1009.399407352624;1010.3483253301727;1020.9846852297221;1059.06802014227;14394.496192633207;21016.789832101484;21603.243886463897;21668.241611543835;21724.45688857791;1035.9015893490107;1047.5862034496483;1060.125396547851;1063.1813503602339;1065.6003998500562;10567.788644227227;11280.210385272952;11283.548658053585;11340.886591134147;11353.262037967506;613991;640548;663081.684591574;702072;710367;150645.24677376763;151005.24497377663;152517.47482525033;152677.23661381623;152699.236503819;987.0524296675129;997.5858422617283;1013.7364285285879;1023.7287118913493;1026.594495174402;18371.724424133383;18817.717734233724;18906;18930.864148150606;19035.61928761445;59960;60332.39667603268;60855;60961;62938.68530657318;86653;86901.56549217213;87523;87885;89449.65825512493;5916;5940.079287710412;8119.4722343047515;8332.583370831313;8584.74245772628;12468.438920248793;12560.623181304576;13429.932850335686;13577.660558486117;13837.377318020915;10792.268553424676;11496.712582185512;11539.249948753304;11679.474423650787;11846.99300559462;10821.56713731442;10838.349699018085;10946.507407166855;11150.498227579616;11298.265612735146;11425.31448113116;11564;11625.59310424131;11907;12085.516579336729;8421.452605580618;8502;8513.787155321166;8585.828283434172;8601.784955375915;7760.92239077602;11709.414529273672;11797.410129493663;12011.939940300243;12059.276443413422 04:51:58 INFO - PROCESS | 1646 | |3;mootools.html;1347.743928653556;1464.7436698577746;1470.2575199524244;1494.8878834087445;1498.5504348695392;8013.198680131991;8366.498010119398;8418.200270974263;8432.999999999985;8435.66257349706;7266.96366518168;7616.771496855104;7622.1996690347405;7870.960645196766;8255.669773209065;2265.252466685998;2320.7447180810095;2324.697789287399;2325.6976593042964;2329.3943574670625;2300.5973954557967;2323.2449453927456;2327.1505900346338;2330.021391015769;2333.6499525071204;2272.715910511186;2297.0811675329833;2304.7349554801162;2306.5848147333472;2306.9077236910503;2254.8308876834303;2276.4536511237347;2280.9885950570306;2281.2471884278148;2283.0183021300836;2225.5771403433296;2310.0066971202546;2310.122153581645;2318.0959425823944;2318.5247024360133;8154.959225203836;8244.876326855101;8245;8248.793780155484;8255.42212045157;4952.133376659071;5111.769970351306;5113.335266415379;5114.897702045975;5119.38567371914;3197.232664160608;3289.407906576815;3404.165979335054;3429.3484237994703;3464.359093567698;1185.9169858109935;1195.8758766759217;1220.8046712525954;1225.5649244518156;1234.7592219517198;10539.209559283085;10598.258121931467;10605;10615.416152111631;10618.999999999924;3806;4335.544767799399;4599.379083823641;4624.237000894882;4633.443986721615;9220.677276295432;9226.53867306632;9228.492432916253;9231.861522077174;9242.260619150451;5142.460041695643;5146.812604643012;5155.407128180307;5157.922631160535;5160.148575485003;4185.832566697298;4376.934345984812;4637.373954516164;4697.953020469751;4735.644826638016;3732.8133593320226;3756.1736417988;3797.6392242736897;3845.288621605012;3853.6917046636204;1266.4111188297486;1272.955446559366;1272.968175795594;1281.6283277849507;1286.6847622332589;848.3298194426458;874.903760586335;879.270205729256;907.6596276396351;912.9178373946244;5529.723513824292;5557.666540007613;5581.10702287632;5673.375928647845;5840.941590584125;873.8208667223204;980.4313498171043;1003.4982508745627;1006.7634105985088;1031.875255970995;3302.455094909361;3365.360581489509;3365.3774051800497;3427.211741299515;3660.6705396513908;8313.293370063613;9571.28215383835;9788.657396991071;9883.654072107442;9924.305298629026;9754.414735115774;9868.161206297546;9872.753181170385;9873.80252394948;9892.505374731234;7200.279972002862;7617.428692847948;7751.263629955145;7764.3788496920115;7789.5715735635085;4791.425028996543;5110.974445127899;5243.58051355883;5624.409437009219;5658.830235092953;8647.827043459221;8817.647294108421;8957.417767845069;9228.077192280718;9229.861552076858;9156.084391560791;9243.806390508787;9270;9298.302627303116;9309.208717258838;6634.701438435185;6698.464122870061;6897.862042759217;7611.809704757204;7778.261065198797;7762.805929851799;7866.567338796421;7931.325837303663;7932.127465978853;7943.642536086006;6979.965100174467;7084.645767711697;7086.149662040588;7162.355388015104;7219.2780721929485;6921.204061532988;6925.520437926926;6932.549384290005;6938.23679395256;7041.647917604202;6274.749010039547;6274.74901003973;6314.747410103728;6345.841353966188;6357.713902874474;4182.790860457026;4707.505711900338;4749.810007599657;4760.476347601831;4809.350737650372;4860.270959356125;4873.926891096708;4940.802367905388;4996.425411077773;5122.026814905156 04:51:58 INFO - PROCESS | 1646 | |4;prototype.html;337.37753844157527;362.84579053902104;366.8697612347617;380;382.2488809489356;4760.881192919661;4793.544613261739;5070.898582028357;5151.922721159186;5421.620486565942;4374.825006999724;4590.816367345302;5017.899642007158;5048.29323894655;5402.216678581603;3244.853981570835;4155.293600087993;4157.833686652545;4182.560831112727;4211.663066954637;3547.3969425197647;3633.2370202257557;3986.1429792594586;4134.8966275843195;4160.271952408331;3231.4021905947357;3449.810260435675;3478.8956331309973;4097.89755256118;4133.6693064554765;3642.836072376736;3727.2172843702856;3730.8434385340634;3989.404238304672;4224.4508213931995;2881.8414987175697;3349.7320214383035;3380.2056516718553;3643;3644.8700902720243;4076.5923407659293;4507.827964729194;4842.7723247306285;5209.020572182584;5223.190405487156;3668.669819716212;3975.3700982597284;4524.986381060429;4717.914879577716;4797.71213727174;4728.564789133599;5007.723030627203;5375.989775234911;5517.36550296717;5661.5187709044785;3771.4531392948143;4088.5707000764787;4094.1811637672286;4106.260873042851;4112.91774164518;4952.257161425743;5585;5745.339285982082;5951;5972.939335929141;3300.6369299377047;3728.179800443898;3860.092878173627;3882.5729169791302;3908.5895980922164;3434.6221915589267;3658.048907284125;3948.565657777642;3965.6034396560112;3965.861194858166;4212.789360531961;4319.9416143045155;4385.688804952304;4398.399148315332;4603.838865639686;5110.320569190177;5216.713080780593;5265.420803711589;5647.745851436695;5722.399148089474;1107.734143805481;1130.8303754436736;1189.7923607538355;1191.9940400297944;1205.354690847005;757.6893473675766;819.9344052475788;836.2223132486724;836.7824814894315;857.5540718826176;4344.956550434518;4581.885452863705;4812.51874812516;5017.222330538772;5053.393592768891;4956.553910148104;5112.590992720573;5252.109240673354;5538.224648549206;5552.639078459887;4627.514111018295;4778.856634300976;4920.81900343922;4980.302757613937;4998.200647766801;2878.596372029337;2899.405621847516;2907.7819163562394;2913.7814663900294;2918.6789453160136;5336.879255356341;5566.524870909212;5708.686022268815;5736.971315143481;5755.769769209185;4556.270996640522;4810.95189048105;5028.34631497903;5057.229969510642;5246.213068039825;5257.947420525822;5651.208830763697;5657.349404818417;5679.716014199274;5710.5146062585145;4554.157480866051;5113.7187454688865;5121.8719532012;5178.508041736029;5480.369088120532;4908.9754551227015;4985.202367621163;5362.812301569426;5458.344998600034;5494.313210848644;5182.818601349086;5351.705656188947;5599.356074051536;5663.2071509989455;5676.68778217202;3167.0498850345266;3248.5289633003554;3321.4021476134526;3667.5965643778627;3687.0229389211345;4556.309389394601;5368.382635996754;5467.343918729778;5468.535174510212;5500.1124409685235;4496.582597226197;5104.498795590208;5111.309973153725;5313.688545482727;5336.012837625051;5066.240063990431;5298.947010529845;5307.310049693515;5325.707086110301;5358.598105142052;5161.948380516147;5163.5610973066205;5202.271681964604;5210.270562121382;5219.608529360389;5338.4394638563945;5509.787846673726;5516.91724624139;5523.6409633373705;5554.777808887599;4809.326694262736;5025.748712564284;5389.487998640123;5390.541803946709;5501 04:51:58 INFO - PROCESS | 1646 | |5;yui.html;711.3029231353271;726.2954933714295;762.0664685759941;808.1958451340914;813.9593020348981;14609.926950365247;15541.300641471133;15542.145182014985;15547.689046219082;15557.922210388931;14206.076605020666;14375.64060898478;14419.206943618123;14422.35099420526;14477.2761361932;670.2727540618434;690.2407351912881;694.3507820188115;856.3106699107216;860.1097863711045;867.2195024477958;868.6438560190323;875.4222213339198;877.4910551879926;884.4914174349742;912.0924679943432;925.7546750111226;949.8290307744603;949.8670186173941;952.1620973543306;713.4613366908003;942.9198518125968;943.8489841625376;943.9716808495756;945.3854994253721;547.5947798629026;674.5244602555186;689.0422312984955;692.2800287700785;698.9965050174717;14785.556433307018;14814.851851481455;14827.036242644193;14828.70342593142;14868.553943381716;13315.600531984055;13316.267605281706;13385.397657105454;13405.262710550916;13413.865861341359;12258.20321679088;12369.62891113268;12579.496820127184;12681;12826.486940522462;4244.108737165199;4398.868033958986;4412.536683648203;4476.977615111936;4559.110973360196;91993.54003230008;102773.9722602772;105281.47359263155;105676;105689.47155264251;10664.146868250522;10875.728106797393;10875.945620271848;10888.782224355627;11079.50142243601;20575.279865204648;20758.896205519177;20999.79000210009;21158.682619760715;21159.8942005289;7607.239276072459;7625.961870190614;7637.312641862259;7724.188960159102;7788.532688038736;4133.731307465066;4216.810243539048;4241.851535196315;4245.957540424618;4294.205571969195;3360.5799275090612;3367.51171080192;3406.5571475707998;3463.4977928200774;3466.9479957800654;630.5901164243279;639.6481934935766;643.1446176585131;648.8961766117399;653.0139489371084;621.3506885304868;628.7422156915643;638.3648269971408;639.5682914033009;644.4135836388864;8616.48301101936;9337.533123343806;9355.532223388804;9565;9749.903770689194;617.200725061047;647.7020570537511;653.8692261547709;654.2476152424655;667.5393978155057;4389.934150987738;4410.2282100632265;4696.342512048316;4698.3187437821325;4791.161546729309;102944;105544.41683374756;105585.47207264068;107381;107850.46074769576;58496.70751646214;70714.64642676753;75219.62390188014;75796;76953.30663426865;70606.9408958866;75435.85727326754;76352;78061.60969195118;79150.6042469784;10166.491675416348;10451.790964180826;10759.30064545802;11001.834972475259;11124.332540047622;48767.512324877716;49706.751466243884;50087.24869127039;52034;52675;65585.01622475762;65885.68228635304;67060.32939670736;67276;67941;12722.61832145037;12770.978321734425;12872.970162387173;12888;13252.933735331262;14361.497347592784;14460.638484037983;14504.347304371118;14728.189949552878;14897.851021489647;13540.458381664623;13581.660458488617;13622.727545449234;13668.726625467236;14098.859011410164;12636.684082897633;13080.934595327342;13364.131331463812;13476.393562289524;13561.796573051215;13084.934575327063;13249.205047697169;13433.454323958422;13664.795028074786;13816.24010679382;11078.778424431628;11177.72055698614;11200.607978720705;11297.661070167907;11448.656540303804;10681.788864743561;10795.892041079489;10922.617708380169;10952.835707464554;11068.889311106786 04:51:58 INFO - PROCESS | 1646 | __end_tp_report 04:51:58 INFO - PROCESS | 1646 | __start_cc_report 04:51:58 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1399 04:51:58 INFO - PROCESS | 1646 | __end_cc_report 04:51:58 INFO - PROCESS | 1646 | __startTimestamp1484657518689__endTimestamp 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | ------- Summary: start ------- 04:51:58 INFO - PROCESS | 1646 | Number of tests: 6 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5701.30 Median:5903.97 stddev:635.88 (10.8%) stddev-sans-first:609.48 04:51:58 INFO - PROCESS | 1646 | Values: 3308.0 3329.3 3333.8 3360.9 3387.8 5587.7 5639.4 5670.4 5672.1 5676.7 5614.4 5642.9 5646.4 5715.4 5757.2 5066.3 5125.5 5144.9 5158.9 5177.3 4680.0 5235.8 5251.8 5274.2 5274.8 5073.0 5224.5 5231.9 5233.6 5271.9 5093.7 5108.2 5153.1 5162.7 5165.6 4439.8 5113.4 5146.0 5149.9 5161.0 5683.3 5687.4 5694.2 5699.7 5707.1 6086.9 6104.7 6106.0 6116.2 6179.0 6184.1 6198.3 6227.2 6248.8 6251.6 5794.6 5814.4 5824.4 5828.6 5836.5 6126.1 6138.9 6144.9 6191.5 6221.9 6103.2 6134.3 6144.9 6147.6 6170.1 5463.7 6067.4 6085.5 6200.5 6228.0 6042.3 6113.4 6137.9 6141.9 6196.5 6251.5 6251.7 6256.5 6257.4 6260.5 4505.7 4900.5 4936.1 4947.3 4972.9 4447.4 4460.1 4464.9 4483.8 4490.4 5720.9 5764.0 5781.1 5795.9 5817.1 6109.8 6197.1 6211.2 6212.0 6250.6 5653.1 5721.0 5734.5 5734.9 5755.2 5405.2 5408.9 5412.6 5413.3 5413.4 6175.4 6179.7 6217.6 6235.9 6237.1 6210.8 6304.8 6311.4 6312.6 6317.9 6283.0 6283.4 6288.6 6295.3 6300.3 5941.9 5978.7 6192.5 6209.1 6222.2 6104.3 6106.3 6136.7 6142.1 6145.9 5873.1 6021.7 6038.8 6041.2 6046.1 5901.6 5906.3 5945.8 5957.0 6020.3 5843.6 5886.1 5917.1 5919.9 5972.0 6108.6 6115.4 6119.2 6127.2 6134.7 5732.4 5890.2 5904.0 5911.0 5914.0 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:66061.12 Median:36923.63 stddev:141600.28 (383.5%) stddev-sans-first:141911.69 04:51:58 INFO - PROCESS | 1646 | Values: 403.8 459.0 463.9 503.5 505.6 29337.3 32514.3 37835.8 39645.2 39796.0 41211.8 41549.8 41642.4 41667.6 41764.5 8161.0 8380.5 9152.7 9348.7 9361.5 10847.4 11133.1 11145.9 11302.3 11314.9 11077.5 11157.9 11166.7 11170.4 11180.9 9559.8 11134.8 11154.9 11197.8 11216.6 11002.4 11049.6 11055.2 11062.5 11067.3 38499.6 38737.0 38738.4 38748.6 38821.2 3960.5 4007.3 4012.4 4047.5 4139.9 28075.3 29936.3 30290.2 30304.0 30312.7 3141.4 3160.9 3218.7 3250.2 3288.6 453358.0 454248.0 454513.7 455113.0 455500.0 57138.7 57462.7 57498.7 57502.7 57658.8 57955.7 58089.8 59439.0 59575.3 59777.4 15525.8 15748.4 15783.1 15790.4 15797.4 10908.2 11202.9 11216.8 12106.7 12300.1 14960.5 15163.2 15230.7 15359.8 15376.0 7238.2 7312.5 7338.0 7377.8 7388.9 869.2 870.6 875.4 892.2 912.7 29037.0 29151.4 29277.6 29852.0 29911.3 916.9 1044.2 1081.1 1100.2 1181.0 12876.9 14582.5 15049.1 15315.1 15490.5 605308.0 610212.0 611583.0 612091.0 612769.0 47091.8 56776.0 56922.0 57013.0 57027.4 1385.5 1429.9 1432.7 1447.5 1450.0 23354.0 28448.7 28477.1 28721.0 29391.9 46477.8 46829.3 46951.8 47019.5 47025.3 513157.0 515275.6 516677.0 517179.0 517256.0 36908.6 37159.4 37367.0 37631.8 37646.0 44022.8 44310.1 44769.3 45117.3 45299.8 35851.6 36313.0 36314.6 36938.6 37176.8 36210.0 36242.8 37276.4 37451.6 37566.0 35425.8 36076.5 36284.8 36402.0 36729.4 31567.2 33062.7 33141.0 33147.5 33171.8 18451.4 23314.7 24151.3 24315.2 24369.3 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:40444.41 Median:12635.03 stddev:111768.05 (884.6%) stddev-sans-first:112041.04 04:51:58 INFO - PROCESS | 1646 | Values: 347.5 370.9 391.6 397.8 425.3 15083.5 15352.4 17122.5 20658.9 21267.2 20258.5 20867.5 22128.3 22168.7 22373.3 5191.2 5251.8 5376.4 5419.5 5440.4 5319.1 5360.7 5394.2 5402.7 5423.3 3814.4 4039.0 5717.8 5954.7 5985.2 6051.9 6052.2 6062.1 6070.4 7399.3 7510.5 7588.9 7678.3 7678.7 7688.2 29278.9 30071.5 30139.5 30381.0 30385.4 2264.5 2611.2 2876.8 2880.1 2951.9 16361.6 16839.2 17068.5 17205.0 17626.6 1947.8 1973.5 1978.3 1981.7 2005.3 122035.0 123617.4 126960.0 163332.0 167699.2 23005.5 23355.0 23403.4 23664.0 23686.2 40205.8 41587.4 41732.4 41880.4 41909.6 11053.0 11277.1 11303.7 11358.8 11496.4 9038.6 9070.6 9073.8 9224.8 9243.4 9319.3 10454.0 10659.9 11120.1 11133.4 3577.6 3985.8 4001.4 4074.2 4085.0 929.5 1009.4 1010.3 1021.0 1059.1 14394.5 21016.8 21603.2 21668.2 21724.5 1035.9 1047.6 1060.1 1063.2 1065.6 10567.8 11280.2 11283.5 11340.9 11353.3 613991.0 640548.0 663081.7 702072.0 710367.0 150645.2 151005.2 152517.5 152677.2 152699.2 987.1 997.6 1013.7 1023.7 1026.6 18371.7 18817.7 18906.0 18930.9 19035.6 59960.0 60332.4 60855.0 60961.0 62938.7 86653.0 86901.6 87523.0 87885.0 89449.7 5916.0 5940.1 8119.5 8332.6 8584.7 12468.4 12560.6 13429.9 13577.7 13837.4 10792.3 11496.7 11539.2 11679.5 11847.0 10821.6 10838.3 10946.5 11150.5 11298.3 11425.3 11564.0 11625.6 11907.0 12085.5 8421.5 8502.0 8513.8 8585.8 8601.8 7760.9 11709.4 11797.4 12011.9 12059.3 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5341.09 Median:5144.64 stddev:2898.46 (56.3%) stddev-sans-first:2891.05 04:51:58 INFO - PROCESS | 1646 | Values: 1347.7 1464.7 1470.3 1494.9 1498.6 8013.2 8366.5 8418.2 8433.0 8435.7 7267.0 7616.8 7622.2 7871.0 8255.7 2265.3 2320.7 2324.7 2325.7 2329.4 2300.6 2323.2 2327.2 2330.0 2333.6 2272.7 2297.1 2304.7 2306.6 2306.9 2254.8 2276.5 2281.0 2281.2 2283.0 2225.6 2310.0 2310.1 2318.1 2318.5 8155.0 8244.9 8245.0 8248.8 8255.4 4952.1 5111.8 5113.3 5114.9 5119.4 3197.2 3289.4 3404.2 3429.3 3464.4 1185.9 1195.9 1220.8 1225.6 1234.8 10539.2 10598.3 10605.0 10615.4 10619.0 3806.0 4335.5 4599.4 4624.2 4633.4 9220.7 9226.5 9228.5 9231.9 9242.3 5142.5 5146.8 5155.4 5157.9 5160.1 4185.8 4376.9 4637.4 4698.0 4735.6 3732.8 3756.2 3797.6 3845.3 3853.7 1266.4 1273.0 1273.0 1281.6 1286.7 848.3 874.9 879.3 907.7 912.9 5529.7 5557.7 5581.1 5673.4 5840.9 873.8 980.4 1003.5 1006.8 1031.9 3302.5 3365.4 3365.4 3427.2 3660.7 8313.3 9571.3 9788.7 9883.7 9924.3 9754.4 9868.2 9872.8 9873.8 9892.5 7200.3 7617.4 7751.3 7764.4 7789.6 4791.4 5111.0 5243.6 5624.4 5658.8 8647.8 8817.6 8957.4 9228.1 9229.9 9156.1 9243.8 9270.0 9298.3 9309.2 6634.7 6698.5 6897.9 7611.8 7778.3 7762.8 7866.6 7931.3 7932.1 7943.6 6980.0 7084.6 7086.1 7162.4 7219.3 6921.2 6925.5 6932.5 6938.2 7041.6 6274.7 6274.7 6314.7 6345.8 6357.7 4182.8 4707.5 4749.8 4760.5 4809.4 4860.3 4873.9 4940.8 4996.4 5122.0 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4365.53 Median:4936.54 stddev:1331.06 (27.0%) stddev-sans-first:1300.00 04:51:58 INFO - PROCESS | 1646 | Values: 337.4 362.8 366.9 380.0 382.2 4760.9 4793.5 5070.9 5151.9 5421.6 4374.8 4590.8 5017.9 5048.3 5402.2 3244.9 4155.3 4157.8 4182.6 4211.7 3547.4 3633.2 3986.1 4134.9 4160.3 3231.4 3449.8 3478.9 4097.9 4133.7 3642.8 3727.2 3730.8 3989.4 4224.5 2881.8 3349.7 3380.2 3643.0 3644.9 4076.6 4507.8 4842.8 5209.0 5223.2 3668.7 3975.4 4525.0 4717.9 4797.7 4728.6 5007.7 5376.0 5517.4 5661.5 3771.5 4088.6 4094.2 4106.3 4112.9 4952.3 5585.0 5745.3 5951.0 5972.9 3300.6 3728.2 3860.1 3882.6 3908.6 3434.6 3658.0 3948.6 3965.6 3965.9 4212.8 4319.9 4385.7 4398.4 4603.8 5110.3 5216.7 5265.4 5647.7 5722.4 1107.7 1130.8 1189.8 1192.0 1205.4 757.7 819.9 836.2 836.8 857.6 4345.0 4581.9 4812.5 5017.2 5053.4 4956.6 5112.6 5252.1 5538.2 5552.6 4627.5 4778.9 4920.8 4980.3 4998.2 2878.6 2899.4 2907.8 2913.8 2918.7 5336.9 5566.5 5708.7 5737.0 5755.8 4556.3 4811.0 5028.3 5057.2 5246.2 5257.9 5651.2 5657.3 5679.7 5710.5 4554.2 5113.7 5121.9 5178.5 5480.4 4909.0 4985.2 5362.8 5458.3 5494.3 5182.8 5351.7 5599.4 5663.2 5676.7 3167.0 3248.5 3321.4 3667.6 3687.0 4556.3 5368.4 5467.3 5468.5 5500.1 4496.6 5104.5 5111.3 5313.7 5336.0 5066.2 5298.9 5307.3 5325.7 5358.6 5161.9 5163.6 5202.3 5210.3 5219.6 5338.4 5509.8 5516.9 5523.6 5554.8 4809.3 5025.7 5389.5 5390.5 5501.0 04:51:58 INFO - PROCESS | 1646 | 04:51:58 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19898.71 Median:4229.33 stddev:28190.47 (666.5%) stddev-sans-first:28232.74 04:51:58 INFO - PROCESS | 1646 | Values: 711.3 726.3 762.1 808.2 814.0 14609.9 15541.3 15542.1 15547.7 15557.9 14206.1 14375.6 14419.2 14422.4 14477.3 670.3 690.2 694.4 856.3 860.1 867.2 868.6 875.4 877.5 884.5 912.1 925.8 949.8 949.9 952.2 713.5 942.9 943.8 944.0 945.4 547.6 674.5 689.0 692.3 699.0 14785.6 14814.9 14827.0 14828.7 14868.6 13315.6 13316.3 13385.4 13405.3 13413.9 12258.2 12369.6 12579.5 12681.0 12826.5 4244.1 4398.9 4412.5 4477.0 4559.1 91993.5 102774.0 105281.5 105676.0 105689.5 10664.1 10875.7 10875.9 10888.8 11079.5 20575.3 20758.9 20999.8 21158.7 21159.9 7607.2 7626.0 7637.3 7724.2 7788.5 4133.7 4216.8 4241.9 4246.0 4294.2 3360.6 3367.5 3406.6 3463.5 3466.9 630.6 639.6 643.1 648.9 653.0 621.4 628.7 638.4 639.6 644.4 8616.5 9337.5 9355.5 9565.0 9749.9 617.2 647.7 653.9 654.2 667.5 4389.9 4410.2 4696.3 4698.3 4791.2 102944.0 105544.4 105585.5 107381.0 107850.5 58496.7 70714.6 75219.6 75796.0 76953.3 70606.9 75435.9 76352.0 78061.6 79150.6 10166.5 10451.8 10759.3 11001.8 11124.3 48767.5 49706.8 50087.2 52034.0 52675.0 65585.0 65885.7 67060.3 67276.0 67941.0 12722.6 12771.0 12873.0 12888.0 13252.9 14361.5 14460.6 14504.3 14728.2 14897.9 13540.5 13581.7 13622.7 13668.7 14098.9 12636.7 13080.9 13364.1 13476.4 13561.8 13084.9 13249.2 13433.5 13664.8 13816.2 11078.8 11177.7 11200.6 11297.7 11448.7 10681.8 10795.9 10922.6 10952.8 11068.9 04:51:58 INFO - PROCESS | 1646 | -------- Summary: end -------- 04:51:58 INFO - PROCESS | 1646 | 04:51:59 INFO - TEST-INFO | 1646: exit 0 04:51:59 INFO - TEST-OK | dromaeo_css | took 1119197ms 04:51:59 INFO - TEST-START | kraken 04:51:59 INFO - operating with platform_type : mac_ 04:51:59 INFO - Initialising browser for kraken test... 04:51:59 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpHCAfCc/profile http://localhost:49244/getInfo.html) 04:52:01 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 04:52:01 INFO - PROCESS | 1653 | colorDepth:24 04:52:01 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 04:52:01 INFO - PROCESS | 1653 | __metrics 04:52:01 INFO - PROCESS | 1653 | 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" 04:52:01 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:02 INFO - TEST-INFO | 1653: exit 0 04:52:02 INFO - Browser initialized. 04:52:02 INFO - Running cycle 1/1 for kraken test... 04:52:02 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpHCAfCc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:14 INFO - PROCESS | 1655 | RSS: Main: 235859968 04:52:14 INFO - PROCESS | 1655 | 04:52:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:18 INFO - PROCESS | 1655 | RSS: Main: 288587776 04:52:18 INFO - PROCESS | 1655 | 04:52:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:52:21 INFO - PROCESS | 1655 | RSS: Main: 288882688 04:52:21 INFO - PROCESS | 1655 | 04:52:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:52:25 INFO - PROCESS | 1655 | RSS: Main: 381845504 04:52:25 INFO - PROCESS | 1655 | 04:52:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:52:27 INFO - PROCESS | 1655 | RSS: Main: 281985024 04:52:27 INFO - PROCESS | 1655 | 04:52:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:30 INFO - PROCESS | 1655 | RSS: Main: 285646848 04:52:30 INFO - PROCESS | 1655 | 04:52:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:33 INFO - PROCESS | 1655 | RSS: Main: 327241728 04:52:33 INFO - PROCESS | 1655 | 04:52:36 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:37 INFO - PROCESS | 1655 | RSS: Main: 331882496 04:52:37 INFO - PROCESS | 1655 | 04:52:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:52:41 INFO - PROCESS | 1655 | RSS: Main: 328036352 04:52:41 INFO - PROCESS | 1655 | 04:52:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:43 INFO - PROCESS | 1655 | RSS: Main: 303714304 04:52:43 INFO - PROCESS | 1655 | 04:52:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:45 INFO - PROCESS | 1655 | RSS: Main: 306835456 04:52:45 INFO - PROCESS | 1655 | 04:52:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:48 INFO - PROCESS | 1655 | RSS: Main: 309944320 04:52:48 INFO - PROCESS | 1655 | 04:52:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:52 INFO - PROCESS | 1655 | RSS: Main: 325689344 04:52:52 INFO - PROCESS | 1655 | 04:52:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:55 INFO - PROCESS | 1655 | RSS: Main: 319991808 04:52:55 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:52:57 INFO - PROCESS | 1655 | RSS: Main: 363999232 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | __start_tp_report 04:52:57 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:52:57 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:52:57 INFO - PROCESS | 1655 | |i|pagename|runs| 04:52:57 INFO - PROCESS | 1655 | |0;ai-astar;114;113;113;112;113;113;112;113;111;115 04:52:57 INFO - PROCESS | 1655 | |1;audio-beat-detection;146;110;110;145;112;109;107;114;157;140 04:52:57 INFO - PROCESS | 1655 | |2;audio-dft;180;183;183;183;184;185;182;184;185;183 04:52:57 INFO - PROCESS | 1655 | |3;audio-fft;81;62;59;87;60;60;59;60;88;82 04:52:57 INFO - PROCESS | 1655 | |4;audio-oscillator;87;72;85;70;68;70;81;68;69;85 04:52:57 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;86;84;87;91;86;83;92;84;91;130 04:52:57 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;95;96;95;95;96;96;96;95;95 04:52:57 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;87;99;133;132;86;86;89;85;86 04:52:57 INFO - PROCESS | 1655 | |8;json-parse-financial;58;57;57;57;57;55;56;57;56;55 04:52:57 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;66;68;82;75;74;69;71;69;71;71 04:52:57 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;86;87;87;90;87;86;86;90;92;91 04:52:57 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;145;143;152;141;130;150;141;139;179;150 04:52:57 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;176;171;173;172;172;171;173;196;228;191 04:52:57 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;69;69;71;64;67;67;66;67;67;67 04:52:57 INFO - PROCESS | 1655 | __end_tp_report 04:52:57 INFO - PROCESS | 1655 | __start_cc_report 04:52:57 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1967 04:52:57 INFO - PROCESS | 1655 | __end_cc_report 04:52:57 INFO - PROCESS | 1655 | __startTimestamp1484657577831__endTimestamp 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:52:57 INFO - PROCESS | 1655 | Number of tests: 14 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 04:52:57 INFO - PROCESS | 1655 | Values: 114.0 113.0 113.0 112.0 113.0 113.0 112.0 113.0 111.0 115.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:127.00 stddev:19.47 (15.3%) stddev-sans-first:19.10 04:52:57 INFO - PROCESS | 1655 | Values: 146.0 110.0 110.0 145.0 112.0 109.0 107.0 114.0 157.0 140.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.48 (0.8%) stddev-sans-first:1.01 04:52:57 INFO - PROCESS | 1655 | Values: 180.0 183.0 183.0 183.0 184.0 185.0 182.0 184.0 185.0 183.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:69.80 Median:71.50 stddev:12.84 (18.0%) stddev-sans-first:12.96 04:52:57 INFO - PROCESS | 1655 | Values: 81.0 62.0 59.0 87.0 60.0 60.0 59.0 60.0 88.0 82.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.50 stddev:7.96 (10.4%) stddev-sans-first:7.28 04:52:57 INFO - PROCESS | 1655 | Values: 87.0 72.0 85.0 70.0 68.0 70.0 81.0 68.0 69.0 85.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:86.50 stddev:13.94 (16.1%) stddev-sans-first:14.65 04:52:57 INFO - PROCESS | 1655 | Values: 86.0 84.0 87.0 91.0 86.0 83.0 92.0 84.0 91.0 130.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:52:57 INFO - PROCESS | 1655 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:86.00 stddev:19.20 (22.3%) stddev-sans-first:19.95 04:52:57 INFO - PROCESS | 1655 | Values: 86.0 87.0 99.0 133.0 132.0 86.0 86.0 89.0 85.0 86.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:0.97 (1.7%) stddev-sans-first:0.87 04:52:57 INFO - PROCESS | 1655 | Values: 58.0 57.0 57.0 57.0 57.0 55.0 56.0 57.0 56.0 55.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:4.53 (6.4%) stddev-sans-first:4.32 04:52:57 INFO - PROCESS | 1655 | Values: 66.0 68.0 82.0 75.0 74.0 69.0 71.0 69.0 71.0 71.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.50 stddev:2.30 (2.6%) stddev-sans-first:2.30 04:52:57 INFO - PROCESS | 1655 | Values: 86.0 87.0 87.0 90.0 87.0 86.0 86.0 90.0 92.0 91.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:147.50 stddev:12.96 (8.8%) stddev-sans-first:13.73 04:52:57 INFO - PROCESS | 1655 | Values: 145.0 143.0 152.0 141.0 130.0 150.0 141.0 139.0 179.0 150.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:174.50 stddev:18.35 (10.5%) stddev-sans-first:19.33 04:52:57 INFO - PROCESS | 1655 | Values: 176.0 171.0 173.0 172.0 172.0 171.0 173.0 196.0 228.0 191.0 04:52:57 INFO - PROCESS | 1655 | 04:52:57 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:1.92 04:52:57 INFO - PROCESS | 1655 | Values: 69.0 69.0 71.0 64.0 67.0 67.0 66.0 67.0 67.0 67.0 04:52:57 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:52:57 INFO - PROCESS | 1655 | 04:52:58 INFO - TEST-INFO | 1655: exit 0 04:52:58 INFO - TEST-OK | kraken | took 59425ms 04:52:58 INFO - SUITE-END | took 1178s 04:52:59 INFO - Completed test suite (00:19:38) 04:52:59 INFO - javascript benchmark 04:52:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.9834600826994, 3329.317489914567, 3333.8499767510475, 3360.89917302481, 3387.796732196068, 5587.7485513151905, 5639.436056394358, 5670.432956704332, 5672.149177623353, 5676.744546495407, 5614.3543492498375, 5642.858928526789, 5646.350669672989, 5715.428457154282, 5757.165211044396, 5066.316047333599, 5125.538701516863, 5144.948550514503, 5158.948410515903, 5177.275181474578, 4679.953200468003, 5235.790568377261, 5251.816186433475, 5274.235235890794, 5274.841754747364, 5073.0, 5224.4775522447835, 5231.921521177185, 5233.555147812441, 5271.920921186185, 5093.745312734349, 5108.208227724708, 5153.123968925292, 5162.6902385856965, 5165.586753059783, 4439.779060758285, 5113.411957624883, 5146.0479811235045, 5149.871253218699, 5161.019406312788, 5683.2895888014, 5687.374388817227, 5694.202811606337, 5699.68651724155, 5707.086866101446, 6086.908696369514, 6104.671374792629, 6106.035994416554, 6116.214037636738, 6179.0, 6184.07238914162, 6198.256209254873, 6227.159333489966, 6248.750049997994, 6251.562390632612, 5794.594378393472, 5814.447627475383, 5824.446677565625, 5828.59199856006, 5836.533077353802, 6126.111713801474, 6138.861138861139, 6144.941444616104, 6191.473724733358, 6221.9377806222265, 6103.246756470893, 6134.263888333428, 6144.941444616104, 6147.569670123138, 6170.136180934673, 5463.743339032045, 6067.393260673985, 6085.5435842312, 6200.472959798468, 6228.03465462854, 6042.335343112254, 6113.419225173601, 6137.9286238596105, 6141.915626108588, 6196.535259855529, 6251.499880009679, 6251.74993000284, 6256.499480041586, 6257.374262573706, 6260.530460215502, 4505.662075344297, 4900.509949005071, 4936.136176169228, 4947.25791131326, 4972.90054198914, 4447.421835161408, 4460.107978404268, 4464.888377790581, 4483.7533935633855, 4490.438695163105, 5720.914186287209, 5763.971180144156, 5781.075027995585, 5795.9420405796245, 5817.0983497557945, 6109.829807539378, 6197.070439434121, 6211.223597050369, 6212.0, 6250.624962502265, 5653.095504719226, 5721.0, 5734.541236701054, 5734.942650573525, 5755.194272801811, 5405.21624364465, 5408.891822163613, 5412.621116521806, 5413.2692086568595, 5413.377461591888, 6175.382461753788, 6179.721912513858, 6217.626942383381, 6235.906461403082, 6237.095621135, 6210.813675589739, 6304.810855674337, 6311.368863113836, 6312.621242725451, 6317.905231421624, 6283.0, 6283.403076707706, 6288.622682639057, 6295.276043254901, 6300.338464461349, 5941.91087133702, 5978.730957107027, 6192.504599632109, 6209.130721698875, 6222.160008398808, 6104.307579233734, 6106.297775755845, 6136.693165341804, 6142.140100386039, 6145.907811382922, 5873.148393483007, 6021.729022193924, 6038.849028774316, 6041.24484439445, 6046.062860256668, 5901.5868889177345, 5906.26171728534, 5945.791897283574, 5956.970215148896, 6020.277566692025, 5843.590948633555, 5886.087656413263, 5917.142014407973, 5919.91120133207, 5971.970140149445, 6108.602940809011, 6115.449609535163, 6119.173911521888, 6127.172831667846, 6134.723937422916, 5732.426757324234, 5890.204822349099, 5903.970480147572, 5911.0, 5914.02418600926], "value": 5660.234970898392, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.82837294149977, 458.99082018359655, 463.93526855865787, 503.5342308364763, 505.5778425015112, 29337.332833395827, 32514.349713005755, 37835.810820945924, 39645.20709585814, 39796.0, 41211.79394103025, 41549.79225103878, 41642.37536436948, 41667.58332416675, 41764.538241161565, 8161.0, 8380.497170169809, 9152.72541823743, 9348.719538413825, 9361.48511831849, 10847.403392813392, 11133.053690436323, 11145.888541114608, 11302.265352752085, 11314.943425282861, 11077.50151243196, 11157.888421115766, 11166.66500004997, 11170.441477926111, 11180.888191118065, 9559.761005974837, 11134.777304453906, 11154.940280673323, 11197.832032519518, 11216.551337946472, 11002.449877506093, 11049.613263535817, 11055.22613417061, 11062.502187401506, 11067.280626759235, 38499.615003850166, 38737.0, 38738.41892371617, 38748.61251387478, 38821.22357552833, 3960.4653371794725, 4007.2786898358286, 4012.4181993611055, 4047.4738284022887, 4139.8965025874295, 28075.29811754702, 29936.251593710113, 30290.242743931358, 30304.0, 30312.696873031207, 3141.371725654878, 3160.8893688721014, 3218.742500599946, 3250.1712063423674, 3288.588926384202, 453358.0, 454248.0, 454513.727431364, 455113.0, 455500.0, 57138.714306429036, 57462.7126864363, 57498.7125064372, 57502.7124864373, 57658.846823064145, 57955.71022144862, 58089.8382032357, 59439.0, 59575.25521682153, 59777.40222597718, 15525.767113493306, 15748.448804291795, 15783.053016819027, 15790.36838526469, 15797.447089352047, 10908.23642345044, 11202.887971120348, 11216.831747523795, 12106.69733256658, 12300.077494187793, 14960.476383326532, 15163.166025868682, 15230.695386092437, 15359.769603455958, 15376.000559963566, 7238.203797582261, 7312.5246858954, 7338.0187349415355, 7377.8155546111775, 7388.852222955511, 869.1916517638531, 870.5603670146536, 875.3609864798606, 892.1925657280042, 912.7033714042963, 29037.0, 29151.416971660874, 29277.56083658747, 29851.95518156854, 29911.252218694706, 916.9042993622691, 1044.2220545693508, 1081.0702795595782, 1100.1693721240413, 1180.9586664466703, 12876.935615321863, 14582.48961286371, 15049.097054176784, 15315.081095134328, 15490.535283941499, 605308.0, 610212.0, 611583.0, 612091.0, 612769.0, 47091.76454117707, 56776.0, 56922.0, 57013.0, 57027.42972570304, 1385.47352006239, 1429.9285035748171, 1432.7421064208543, 1447.5078473319122, 1450.0067453794184, 23354.0, 28448.715512845436, 28477.145685629464, 28721.0, 29391.85304073466, 46477.838054048916, 46829.2975605373, 46951.82620434516, 47019.52980470152, 47025.2946205814, 513157.0, 515275.5905511811, 516677.0, 517179.0, 517256.0, 36908.63091369052, 37159.442608360354, 37367.0, 37631.81184094062, 37646.0, 44022.77988610036, 44310.11379772451, 44769.328460073775, 45117.32324015077, 45299.77350113228, 35851.64148358483, 36312.9931406369, 36314.63685363218, 36938.630613693516, 37176.81411592925, 36210.0, 36242.8187859059, 37276.44085338668, 37451.625483745906, 37566.0, 35425.82287088548, 36076.45885311775, 36284.81857590695, 36402.0, 36729.44905826468, 31567.21081972969, 33062.66937330596, 33141.0, 33147.50278745773, 33171.83414082914, 18451.354202603383, 23314.717690527184, 24151.275461736175, 24315.175735524175, 24369.26892193237], "value": 19620.475254068042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.47010808517007, 370.85721997031135, 391.6162161082138, 397.7673061259163, 425.308873081243, 15083.472078477256, 15352.385904563818, 17122.486325410242, 20658.89670551645, 21267.214876652746, 20258.493537661565, 20867.478313042182, 22128.33614991549, 22168.667469987922, 22373.32880013598, 5191.247269145972, 5251.842444726664, 5376.38171610264, 5419.5393391561565, 5440.401555828856, 5319.069162896497, 5360.731963401834, 5394.217838413428, 5402.702851343174, 5423.322084739408, 3814.389697648377, 4038.97980510097, 5717.828465146053, 5954.732037058343, 5985.221921150266, 6051.939480605181, 6052.243469566304, 6062.1209924561135, 6070.392960703938, 7399.334059934577, 7510.549367037996, 7588.886166707503, 7678.270564296383, 7678.731244406419, 7688.154303026663, 29278.853605731834, 30071.548926766118, 30139.547906781198, 30381.0, 30385.392292154254, 2264.52444986553, 2611.2427396055123, 2876.7842411819197, 2880.0927707771984, 2951.896683616085, 16361.59096022597, 16839.242234099373, 17068.487945361536, 17204.967701937923, 17626.647467050716, 1947.8246957773868, 1973.4770285874256, 1978.3273686946507, 1981.7423734914512, 2005.2780998840406, 122035.0, 123617.38191308986, 126960.0, 163332.0, 167699.1615041917, 23005.539889202457, 23355.0, 23403.414914627272, 23664.0, 23686.157661080782, 40205.79897100496, 41587.37618935719, 41732.37401438981, 41880.37179442311, 41909.58090419057, 11053.0, 11277.097832173406, 11303.660890173307, 11358.829617555743, 11496.42517874103, 9038.593263303168, 9070.591823367833, 9073.77315567116, 9224.769380765534, 9243.39917905334, 9319.301052421095, 10454.006869347551, 10659.89340106589, 11120.110391168688, 11133.443327833576, 3577.5528058992627, 3985.80070996449, 4001.419794129835, 4074.2055299216368, 4085.0, 929.5398777605129, 1009.399407352624, 1010.3483253301727, 1020.9846852297221, 1059.06802014227, 14394.496192633207, 21016.789832101484, 21603.243886463897, 21668.241611543835, 21724.45688857791, 1035.9015893490107, 1047.5862034496483, 1060.125396547851, 1063.1813503602339, 1065.6003998500562, 10567.788644227227, 11280.210385272952, 11283.548658053585, 11340.886591134147, 11353.262037967506, 613991.0, 640548.0, 663081.684591574, 702072.0, 710367.0, 150645.24677376763, 151005.24497377663, 152517.47482525033, 152677.23661381623, 152699.236503819, 987.0524296675129, 997.5858422617283, 1013.7364285285879, 1023.7287118913493, 1026.594495174402, 18371.724424133383, 18817.717734233724, 18906.0, 18930.864148150606, 19035.61928761445, 59960.0, 60332.39667603268, 60855.0, 60961.0, 62938.68530657318, 86653.0, 86901.56549217213, 87523.0, 87885.0, 89449.65825512493, 5916.0, 5940.079287710412, 8119.4722343047515, 8332.583370831313, 8584.74245772628, 12468.438920248793, 12560.623181304576, 13429.932850335686, 13577.660558486117, 13837.377318020915, 10792.268553424676, 11496.712582185512, 11539.249948753304, 11679.474423650787, 11846.99300559462, 10821.56713731442, 10838.349699018085, 10946.507407166855, 11150.498227579616, 11298.265612735146, 11425.31448113116, 11564.0, 11625.59310424131, 11907.0, 12085.516579336729, 8421.452605580618, 8502.0, 8513.787155321166, 8585.828283434172, 8601.784955375915, 7760.92239077602, 11709.414529273672, 11797.410129493663, 12011.939940300243, 12059.276443413422], "value": 11186.96635655153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.743928653556, 1464.7436698577746, 1470.2575199524244, 1494.8878834087445, 1498.5504348695392, 8013.198680131991, 8366.498010119398, 8418.200270974263, 8432.999999999985, 8435.66257349706, 7266.96366518168, 7616.771496855104, 7622.1996690347405, 7870.960645196766, 8255.669773209065, 2265.252466685998, 2320.7447180810095, 2324.697789287399, 2325.6976593042964, 2329.3943574670625, 2300.5973954557967, 2323.2449453927456, 2327.1505900346338, 2330.021391015769, 2333.6499525071204, 2272.715910511186, 2297.0811675329833, 2304.7349554801162, 2306.5848147333472, 2306.9077236910503, 2254.8308876834303, 2276.4536511237347, 2280.9885950570306, 2281.2471884278148, 2283.0183021300836, 2225.5771403433296, 2310.0066971202546, 2310.122153581645, 2318.0959425823944, 2318.5247024360133, 8154.959225203836, 8244.876326855101, 8245.0, 8248.793780155484, 8255.42212045157, 4952.133376659071, 5111.769970351306, 5113.335266415379, 5114.897702045975, 5119.38567371914, 3197.232664160608, 3289.407906576815, 3404.165979335054, 3429.3484237994703, 3464.359093567698, 1185.9169858109935, 1195.8758766759217, 1220.8046712525954, 1225.5649244518156, 1234.7592219517198, 10539.209559283085, 10598.258121931467, 10605.0, 10615.416152111631, 10618.999999999924, 3806.0, 4335.544767799399, 4599.379083823641, 4624.237000894882, 4633.443986721615, 9220.677276295432, 9226.53867306632, 9228.492432916253, 9231.861522077174, 9242.260619150451, 5142.460041695643, 5146.812604643012, 5155.407128180307, 5157.922631160535, 5160.148575485003, 4185.832566697298, 4376.934345984812, 4637.373954516164, 4697.953020469751, 4735.644826638016, 3732.8133593320226, 3756.1736417988, 3797.6392242736897, 3845.288621605012, 3853.6917046636204, 1266.4111188297486, 1272.955446559366, 1272.968175795594, 1281.6283277849507, 1286.6847622332589, 848.3298194426458, 874.903760586335, 879.270205729256, 907.6596276396351, 912.9178373946244, 5529.723513824292, 5557.666540007613, 5581.10702287632, 5673.375928647845, 5840.941590584125, 873.8208667223204, 980.4313498171043, 1003.4982508745627, 1006.7634105985088, 1031.875255970995, 3302.455094909361, 3365.360581489509, 3365.3774051800497, 3427.211741299515, 3660.6705396513908, 8313.293370063613, 9571.28215383835, 9788.657396991071, 9883.654072107442, 9924.305298629026, 9754.414735115774, 9868.161206297546, 9872.753181170385, 9873.80252394948, 9892.505374731234, 7200.279972002862, 7617.428692847948, 7751.263629955145, 7764.3788496920115, 7789.5715735635085, 4791.425028996543, 5110.974445127899, 5243.58051355883, 5624.409437009219, 5658.830235092953, 8647.827043459221, 8817.647294108421, 8957.417767845069, 9228.077192280718, 9229.861552076858, 9156.084391560791, 9243.806390508787, 9270.0, 9298.302627303116, 9309.208717258838, 6634.701438435185, 6698.464122870061, 6897.862042759217, 7611.809704757204, 7778.261065198797, 7762.805929851799, 7866.567338796421, 7931.325837303663, 7932.127465978853, 7943.642536086006, 6979.965100174467, 7084.645767711697, 7086.149662040588, 7162.355388015104, 7219.2780721929485, 6921.204061532988, 6925.520437926926, 6932.549384290005, 6938.23679395256, 7041.647917604202, 6274.749010039547, 6274.74901003973, 6314.747410103728, 6345.841353966188, 6357.713902874474, 4182.790860457026, 4707.505711900338, 4749.810007599657, 4760.476347601831, 4809.350737650372, 4860.270959356125, 4873.926891096708, 4940.802367905388, 4996.425411077773, 5122.026814905156], "value": 4361.091760039424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.37753844157527, 362.84579053902104, 366.8697612347617, 380.0, 382.2488809489356, 4760.881192919661, 4793.544613261739, 5070.898582028357, 5151.922721159186, 5421.620486565942, 4374.825006999724, 4590.816367345302, 5017.899642007158, 5048.29323894655, 5402.216678581603, 3244.853981570835, 4155.293600087993, 4157.833686652545, 4182.560831112727, 4211.663066954637, 3547.3969425197647, 3633.2370202257557, 3986.1429792594586, 4134.8966275843195, 4160.271952408331, 3231.4021905947357, 3449.810260435675, 3478.8956331309973, 4097.89755256118, 4133.6693064554765, 3642.836072376736, 3727.2172843702856, 3730.8434385340634, 3989.404238304672, 4224.4508213931995, 2881.8414987175697, 3349.7320214383035, 3380.2056516718553, 3643.0, 3644.8700902720243, 4076.5923407659293, 4507.827964729194, 4842.7723247306285, 5209.020572182584, 5223.190405487156, 3668.669819716212, 3975.3700982597284, 4524.986381060429, 4717.914879577716, 4797.71213727174, 4728.564789133599, 5007.723030627203, 5375.989775234911, 5517.36550296717, 5661.5187709044785, 3771.4531392948143, 4088.5707000764787, 4094.1811637672286, 4106.260873042851, 4112.91774164518, 4952.257161425743, 5585.0, 5745.339285982082, 5951.0, 5972.939335929141, 3300.6369299377047, 3728.179800443898, 3860.092878173627, 3882.5729169791302, 3908.5895980922164, 3434.6221915589267, 3658.048907284125, 3948.565657777642, 3965.6034396560112, 3965.861194858166, 4212.789360531961, 4319.9416143045155, 4385.688804952304, 4398.399148315332, 4603.838865639686, 5110.320569190177, 5216.713080780593, 5265.420803711589, 5647.745851436695, 5722.399148089474, 1107.734143805481, 1130.8303754436736, 1189.7923607538355, 1191.9940400297944, 1205.354690847005, 757.6893473675766, 819.9344052475788, 836.2223132486724, 836.7824814894315, 857.5540718826176, 4344.956550434518, 4581.885452863705, 4812.51874812516, 5017.222330538772, 5053.393592768891, 4956.553910148104, 5112.590992720573, 5252.109240673354, 5538.224648549206, 5552.639078459887, 4627.514111018295, 4778.856634300976, 4920.81900343922, 4980.302757613937, 4998.200647766801, 2878.596372029337, 2899.405621847516, 2907.7819163562394, 2913.7814663900294, 2918.6789453160136, 5336.879255356341, 5566.524870909212, 5708.686022268815, 5736.971315143481, 5755.769769209185, 4556.270996640522, 4810.95189048105, 5028.34631497903, 5057.229969510642, 5246.213068039825, 5257.947420525822, 5651.208830763697, 5657.349404818417, 5679.716014199274, 5710.5146062585145, 4554.157480866051, 5113.7187454688865, 5121.8719532012, 5178.508041736029, 5480.369088120532, 4908.9754551227015, 4985.202367621163, 5362.812301569426, 5458.344998600034, 5494.313210848644, 5182.818601349086, 5351.705656188947, 5599.356074051536, 5663.2071509989455, 5676.68778217202, 3167.0498850345266, 3248.5289633003554, 3321.4021476134526, 3667.5965643778627, 3687.0229389211345, 4556.309389394601, 5368.382635996754, 5467.343918729778, 5468.535174510212, 5500.1124409685235, 4496.582597226197, 5104.498795590208, 5111.309973153725, 5313.688545482727, 5336.012837625051, 5066.240063990431, 5298.947010529845, 5307.310049693515, 5325.707086110301, 5358.598105142052, 5161.948380516147, 5163.5610973066205, 5202.271681964604, 5210.270562121382, 5219.608529360389, 5338.4394638563945, 5509.787846673726, 5516.91724624139, 5523.6409633373705, 5554.777808887599, 4809.326694262736, 5025.748712564284, 5389.487998640123, 5390.541803946709, 5501.0], "value": 3953.6853806306003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.3029231353271, 726.2954933714295, 762.0664685759941, 808.1958451340914, 813.9593020348981, 14609.926950365247, 15541.300641471133, 15542.145182014985, 15547.689046219082, 15557.922210388931, 14206.076605020666, 14375.64060898478, 14419.206943618123, 14422.35099420526, 14477.2761361932, 670.2727540618434, 690.2407351912881, 694.3507820188115, 856.3106699107216, 860.1097863711045, 867.2195024477958, 868.6438560190323, 875.4222213339198, 877.4910551879926, 884.4914174349742, 912.0924679943432, 925.7546750111226, 949.8290307744603, 949.8670186173941, 952.1620973543306, 713.4613366908003, 942.9198518125968, 943.8489841625376, 943.9716808495756, 945.3854994253721, 547.5947798629026, 674.5244602555186, 689.0422312984955, 692.2800287700785, 698.9965050174717, 14785.556433307018, 14814.851851481455, 14827.036242644193, 14828.70342593142, 14868.553943381716, 13315.600531984055, 13316.267605281706, 13385.397657105454, 13405.262710550916, 13413.865861341359, 12258.20321679088, 12369.62891113268, 12579.496820127184, 12681.0, 12826.486940522462, 4244.108737165199, 4398.868033958986, 4412.536683648203, 4476.977615111936, 4559.110973360196, 91993.54003230008, 102773.9722602772, 105281.47359263155, 105676.0, 105689.47155264251, 10664.146868250522, 10875.728106797393, 10875.945620271848, 10888.782224355627, 11079.50142243601, 20575.279865204648, 20758.896205519177, 20999.79000210009, 21158.682619760715, 21159.8942005289, 7607.239276072459, 7625.961870190614, 7637.312641862259, 7724.188960159102, 7788.532688038736, 4133.731307465066, 4216.810243539048, 4241.851535196315, 4245.957540424618, 4294.205571969195, 3360.5799275090612, 3367.51171080192, 3406.5571475707998, 3463.4977928200774, 3466.9479957800654, 630.5901164243279, 639.6481934935766, 643.1446176585131, 648.8961766117399, 653.0139489371084, 621.3506885304868, 628.7422156915643, 638.3648269971408, 639.5682914033009, 644.4135836388864, 8616.48301101936, 9337.533123343806, 9355.532223388804, 9565.0, 9749.903770689194, 617.200725061047, 647.7020570537511, 653.8692261547709, 654.2476152424655, 667.5393978155057, 4389.934150987738, 4410.2282100632265, 4696.342512048316, 4698.3187437821325, 4791.161546729309, 102944.0, 105544.41683374756, 105585.47207264068, 107381.0, 107850.46074769576, 58496.70751646214, 70714.64642676753, 75219.62390188014, 75796.0, 76953.30663426865, 70606.9408958866, 75435.85727326754, 76352.0, 78061.60969195118, 79150.6042469784, 10166.491675416348, 10451.790964180826, 10759.30064545802, 11001.834972475259, 11124.332540047622, 48767.512324877716, 49706.751466243884, 50087.24869127039, 52034.0, 52675.0, 65585.01622475762, 65885.68228635304, 67060.32939670736, 67276.0, 67941.0, 12722.61832145037, 12770.978321734425, 12872.970162387173, 12888.0, 13252.933735331262, 14361.497347592784, 14460.638484037983, 14504.347304371118, 14728.189949552878, 14897.851021489647, 13540.458381664623, 13581.660458488617, 13622.727545449234, 13668.726625467236, 14098.859011410164, 12636.684082897633, 13080.934595327342, 13364.131331463812, 13476.393562289524, 13561.796573051215, 13084.934575327063, 13249.205047697169, 13433.454323958422, 13664.795028074786, 13816.24010679382, 11078.778424431628, 11177.72055698614, 11200.607978720705, 11297.661070167907, 11448.656540303804, 10681.788864743561, 10795.892041079489, 10922.617708380169, 10952.835707464554, 11068.889311106786], "value": 7436.616840720435, "unit": "score"}], "name": "dromaeo_css", "value": 7362.863919818866, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0, 113.0, 111.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 110.0, 145.0, 112.0, 109.0, 107.0, 114.0, 157.0, 140.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 183.0, 183.0, 184.0, 185.0, 182.0, 184.0, 185.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 59.0, 87.0, 60.0, 60.0, 59.0, 60.0, 88.0, 82.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 85.0, 70.0, 68.0, 70.0, 81.0, 68.0, 69.0, 85.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 91.0, 86.0, 83.0, 92.0, 84.0, 91.0, 130.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 99.0, 133.0, 132.0, 86.0, 86.0, 89.0, 85.0, 86.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 55.0, 56.0, 57.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 82.0, 75.0, 74.0, 69.0, 71.0, 69.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 90.0, 87.0, 86.0, 86.0, 90.0, 92.0, 91.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 152.0, 141.0, 130.0, 150.0, 141.0, 139.0, 179.0, 150.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 173.0, 172.0, 172.0, 171.0, 173.0, 196.0, 228.0, 191.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 64.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1463.1000000000001, "alertThreshold": 2.0}]} 04:52:59 INFO - Return code: 0 04:52:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:59 ERROR - # TBPL SUCCESS # 04:52:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:59 INFO - 2017-01-17 04:52:59.184 screenresolution[1659:9856] starting screenresolution argv=screenresolution get 04:52:59 INFO - 2017-01-17 04:52:59.187 screenresolution[1659:9856] Display 0: 1600x1200x32@60 04:52:59 INFO - 2017-01-17 04:52:59.193 screenresolution[1660:9859] starting screenresolution argv=screenresolution list 04:52:59 INFO - Available Modes on Display 0 04:52:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:59 INFO - Intel Iris: 04:52:59 INFO - Chipset Model: Intel Iris 04:52:59 INFO - Type: GPU 04:52:59 INFO - Bus: Built-In 04:52:59 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:59 INFO - Vendor: Intel (0x8086) 04:52:59 INFO - Device ID: 0x0a2e 04:52:59 INFO - Revision ID: 0x0009 04:52:59 INFO - Displays: 04:52:59 INFO - Display: 04:52:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:59 INFO - Display Serial Number: 1600x1200 60 04:52:59 INFO - Main Display: Yes 04:52:59 INFO - Mirror: Off 04:52:59 INFO - Online: Yes 04:52:59 INFO - Rotation: Supported 04:52:59 INFO - Return code: 0 04:52:59 INFO - Running post-action listener: _resource_record_post_action 04:52:59 INFO - [mozharness: 2017-01-17 12:52:59.432800Z] Finished run-tests step (success) 04:52:59 INFO - Running post-run listener: _resource_record_post_run 04:52:59 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 31513600; Write bytes: 553956864; Read time: 320; Write time: 1722 04:52:59 INFO - TinderboxPrint: CPU usage
53.8% 04:52:59 INFO - TinderboxPrint: I/O read bytes / time
31,513,600 / 320 04:52:59 INFO - TinderboxPrint: I/O write bytes / time
553,956,864 / 1,722 04:52:59 INFO - TinderboxPrint: CPU idle
2,220.8 (46.2%) 04:52:59 INFO - TinderboxPrint: CPU system
954.3 (19.9%) 04:52:59 INFO - TinderboxPrint: CPU user
1,630.5 (33.9%) 04:52:59 INFO - TinderboxPrint: Swap in / out
278,953,984 / 0 04:52:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249887232; Write bytes: 244585984; Read time: 18165; Write time: 568 04:52:59 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29428736; Write bytes: 297820160; Read time: 292; Write time: 1118 04:52:59 INFO - Running post-run listener: _upload_blobber_files 04:52:59 INFO - Blob upload gear active. 04:52:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:59 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 04:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:53:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:01 INFO - (blobuploader) - INFO - Done attempting. 04:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:02 INFO - (blobuploader) - INFO - Done attempting. 04:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:02 INFO - (blobuploader) - INFO - Done attempting. 04:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:05 INFO - (blobuploader) - INFO - Done attempting. 04:53:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:05 INFO - Return code: 0 04:53:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef411b000e055aca6a380446e7186e353c41e679b13b1354c1fbe3ff6df13333f4dff706c14aab0823e8c8a15f84e1270f03351dfc98b12f9086924b9f39aea9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c564188053c57e536ed0ab7efbb6839952f6852998041ab59e790d26ede786f1247886f8d8eefcc9b158a263f1038ec4c41f9cb6ee83fadd459a4cee5c936a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e58847d60a50f2352c023d0d1d7e5abe09604f7dd1753adf6b45afd776922212e005b1937753d0334c1d61af8f926c3baf46e8eb689805fae06362966154f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/564998aa05c4970c614005d23825c137c1711c1237858bb3a762e055b6fc6fdbb4f36def61b0a9dcbc3da1eb811bf697e3740a4cb295d6982caac15131e968cf"} 04:53:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:05 INFO - Contents: 04:53:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef411b000e055aca6a380446e7186e353c41e679b13b1354c1fbe3ff6df13333f4dff706c14aab0823e8c8a15f84e1270f03351dfc98b12f9086924b9f39aea9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c564188053c57e536ed0ab7efbb6839952f6852998041ab59e790d26ede786f1247886f8d8eefcc9b158a263f1038ec4c41f9cb6ee83fadd459a4cee5c936a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e58847d60a50f2352c023d0d1d7e5abe09604f7dd1753adf6b45afd776922212e005b1937753d0334c1d61af8f926c3baf46e8eb689805fae06362966154f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/564998aa05c4970c614005d23825c137c1711c1237858bb3a762e055b6fc6fdbb4f36def61b0a9dcbc3da1eb811bf697e3740a4cb295d6982caac15131e968cf"} 04:53:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:05 INFO - Copying logs to upload dir... 04:53:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.571743 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-17 04:53:05.353595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:05.356859) ========= 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.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef411b000e055aca6a380446e7186e353c41e679b13b1354c1fbe3ff6df13333f4dff706c14aab0823e8c8a15f84e1270f03351dfc98b12f9086924b9f39aea9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c564188053c57e536ed0ab7efbb6839952f6852998041ab59e790d26ede786f1247886f8d8eefcc9b158a263f1038ec4c41f9cb6ee83fadd459a4cee5c936a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e58847d60a50f2352c023d0d1d7e5abe09604f7dd1753adf6b45afd776922212e005b1937753d0334c1d61af8f926c3baf46e8eb689805fae06362966154f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/564998aa05c4970c614005d23825c137c1711c1237858bb3a762e055b6fc6fdbb4f36def61b0a9dcbc3da1eb811bf697e3740a4cb295d6982caac15131e968cf"} build_url:https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef411b000e055aca6a380446e7186e353c41e679b13b1354c1fbe3ff6df13333f4dff706c14aab0823e8c8a15f84e1270f03351dfc98b12f9086924b9f39aea9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c564188053c57e536ed0ab7efbb6839952f6852998041ab59e790d26ede786f1247886f8d8eefcc9b158a263f1038ec4c41f9cb6ee83fadd459a4cee5c936a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24e58847d60a50f2352c023d0d1d7e5abe09604f7dd1753adf6b45afd776922212e005b1937753d0334c1d61af8f926c3baf46e8eb689805fae06362966154f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/564998aa05c4970c614005d23825c137c1711c1237858bb3a762e055b6fc6fdbb4f36def61b0a9dcbc3da1eb811bf697e3740a4cb295d6982caac15131e968cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:05.390993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:05.391306) ========= 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.wl89r0TkbZ/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.sP3oAdavgu/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:05.440326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 04:53:05.440655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 04:53:05.440994) ========= ========= Total master_lag: 0.19 =========