builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0165 starttime: 1484217058.35 results: success (0) buildid: 20170112011317 builduid: 0192be41b43b4ea99780dfd6d69b904c revision: a2425e6d32feebaa6a0ae749be2d888fc3d11e92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.354253) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.355298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.355812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.399356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.399866) ========= 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.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-12 02:30:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2017-01-12 02:30:58 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130101 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.555766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.556144) ========= 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.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.027154 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.605411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:58.605787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a2425e6d32feebaa6a0ae749be2d888fc3d11e92 --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 a2425e6d32feebaa6a0ae749be2d888fc3d11e92 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-12 02:30:58,699 truncating revision to first 12 chars 2017-01-12 02:30:58,699 Setting DEBUG logging. 2017-01-12 02:30:58,699 attempt 1/10 2017-01-12 02:30:58,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a2425e6d32fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 02:30:59,382 unpacking tar archive at: mozilla-central-a2425e6d32fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.960516 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:59.602336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:59.602677) ========= script_repo_revision: a2425e6d32feebaa6a0ae749be2d888fc3d11e92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:59.603060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:59.603333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 02:30:59.624052) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 02:30:59.624627) ========= /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.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:30:59 INFO - MultiFileLogger online at 20170112 02:30:59 in /builds/slave/test 02:30:59 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 02:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:59 INFO - {'append_to_log': False, 02:30:59 INFO - 'base_work_dir': '/builds/slave/test', 02:30:59 INFO - 'blob_upload_branch': 'Firefox', 02:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:59 INFO - 'branch': 'Firefox', 02:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:59 INFO - 'config_files': ('talos/mac_config.py',), 02:30:59 INFO - 'default_actions': ('clobber', 02:30:59 INFO - 'read-buildbot-config', 02:30:59 INFO - 'download-and-extract', 02:30:59 INFO - 'populate-webroot', 02:30:59 INFO - 'create-virtualenv', 02:30:59 INFO - 'install', 02:30:59 INFO - 'run-tests'), 02:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:59 INFO - 'download_minidump_stackwalk': True, 02:30:59 INFO - 'download_symbols': 'ondemand', 02:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:59 INFO - 'installer_path': 'installer.exe', 02:30:59 INFO - 'log_level': 'info', 02:30:59 INFO - 'log_name': 'talos', 02:30:59 INFO - 'log_to_console': True, 02:30:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:30:59 INFO - 'opt_config_files': (), 02:30:59 INFO - 'pip_index': False, 02:30:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:59 INFO - 'cmd': ('bash', 02:30:59 INFO - '-c', 02:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:59 INFO - 'enabled': True, 02:30:59 INFO - 'halt_on_failure': False, 02:30:59 INFO - 'name': 'check_screen_resolution'},), 02:30:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:59 INFO - 'cmd': ('bash', 02:30:59 INFO - '-c', 02:30:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:59 INFO - 'enabled': True, 02:30:59 INFO - 'halt_on_failure': False, 02:30:59 INFO - 'name': 'check_screen_resolution'},), 02:30:59 INFO - 'run_cmd_checks_enabled': True, 02:30:59 INFO - 'sps_profile': False, 02:30:59 INFO - 'sps_profile_interval': 0, 02:30:59 INFO - 'suite': 'dromaeojs', 02:30:59 INFO - 'system_bits': '32', 02:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:59 INFO - 'title': 't-yosemite-r7-0165', 02:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:59 INFO - 'use_talos_json': True, 02:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:59 INFO - 'work_dir': 'build'} 02:30:59 INFO - [mozharness: 2017-01-12 10:30:59.832753Z] Running clobber step. 02:30:59 INFO - Running pre-action listener: _resource_record_pre_action 02:30:59 INFO - Running main action method: clobber 02:30:59 INFO - rmtree: /builds/slave/test/build 02:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:02 INFO - Running post-action listener: _resource_record_post_action 02:31:02 INFO - [mozharness: 2017-01-12 10:31:02.161789Z] Finished clobber step (success) 02:31:02 INFO - [mozharness: 2017-01-12 10:31:02.161926Z] Running read-buildbot-config step. 02:31:02 INFO - Running pre-action listener: _resource_record_pre_action 02:31:02 INFO - Running main action method: read_buildbot_config 02:31:02 INFO - Using buildbot properties: 02:31:02 INFO - { 02:31:02 INFO - "project": "", 02:31:02 INFO - "product": "firefox", 02:31:02 INFO - "script_repo_revision": "production", 02:31:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:31:02 INFO - "repository": "", 02:31:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:31:02 INFO - "buildid": "20170112011317", 02:31:02 INFO - "pgo_build": "False", 02:31:02 INFO - "basedir": "/builds/slave/test", 02:31:02 INFO - "buildnumber": 21, 02:31:02 INFO - "slavename": "t-yosemite-r7-0165", 02:31:02 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:31:02 INFO - "platform": "yosemite_r7", 02:31:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:31:02 INFO - "branch": "mozilla-central", 02:31:02 INFO - "repo_path": "mozilla-central", 02:31:02 INFO - "revision": "a2425e6d32feebaa6a0ae749be2d888fc3d11e92", 02:31:02 INFO - "stage_platform": "macosx64", 02:31:02 INFO - "builduid": "0192be41b43b4ea99780dfd6d69b904c", 02:31:02 INFO - "slavebuilddir": "test" 02:31:02 INFO - } 02:31:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 02:31:02 INFO - Running post-action listener: _resource_record_post_action 02:31:02 INFO - [mozharness: 2017-01-12 10:31:02.165275Z] Finished read-buildbot-config step (success) 02:31:02 INFO - [mozharness: 2017-01-12 10:31:02.165407Z] Running download-and-extract step. 02:31:02 INFO - Running pre-action listener: _resource_record_pre_action 02:31:02 INFO - Running main action method: download_and_extract 02:31:02 INFO - mkdir: /builds/slave/test/build/tests 02:31:02 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')]} 02:31:02 INFO - trying https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 02:31:02 INFO - Downloading https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/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 02:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/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 02:31:03 INFO - Downloaded 1199 bytes. 02:31:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:31:03 INFO - Using the following test package requirements: 02:31:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:31:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 02:31:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 02:31:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'jsshell-mac.zip'], 02:31:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 02:31:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:31:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 02:31:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 02:31:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 02:31:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:31:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 02:31:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:31:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:31:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:31:03 INFO - Fetch https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:31:04 INFO - Expected file size: 16314306 02:31:04 INFO - Obtained file size: 16314306 02:31:10 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 02:31:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:31:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:31:10 INFO - Fetch https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:31:11 INFO - Expected file size: 16314306 02:31:11 INFO - Obtained file size: 16314306 02:31:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 02:31:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:31:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 02:31:19 INFO - Expected file size: 14403529 02:31:19 INFO - Obtained file size: 14403529 02:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:20 INFO - trying https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:31:20 INFO - Downloading https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 02:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/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 02:31:22 INFO - Downloaded 69874224 bytes. 02:31:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:31:22 INFO - mkdir: /builds/slave/test/properties 02:31:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:22 INFO - Contents: 02:31:22 INFO - build_url:https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:31:22 INFO - Running post-action listener: _resource_record_post_action 02:31:22 INFO - Running post-action listener: set_extra_try_arguments 02:31:22 INFO - [mozharness: 2017-01-12 10:31:22.736008Z] Finished download-and-extract step (success) 02:31:22 INFO - [mozharness: 2017-01-12 10:31:22.736138Z] Running populate-webroot step. 02:31:22 INFO - Running pre-action listener: _resource_record_pre_action 02:31:22 INFO - Running main action method: populate_webroot 02:31:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:31:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:31:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:31:22 INFO - '--tppagecycles', 02:31:22 INFO - '7'], 02:31:22 INFO - 'tests': ['tsvgm']}}, 02:31:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:31:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:31:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['damp', 'tps']}, 02:31:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'tests': ['damp', 'tps']}, 02:31:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['dromaeo_dom']}, 02:31:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['basic_compositor_video']}, 02:31:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:31:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['a11yr', 02:31:22 INFO - 'ts_paint', 02:31:22 INFO - 'tpaint', 02:31:22 INFO - 'sessionrestore', 02:31:22 INFO - 'sessionrestore_no_auto_restore', 02:31:22 INFO - 'tabpaint']}, 02:31:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['tsvgx', 02:31:22 INFO - 'tsvgr_opacity', 02:31:22 INFO - 'tart', 02:31:22 INFO - 'tscrollx', 02:31:22 INFO - 'cart', 02:31:22 INFO - 'tsvg_static']}, 02:31:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:22 INFO - 'tsvgr_opacity', 02:31:22 INFO - 'tart', 02:31:22 INFO - 'tscrollx', 02:31:22 INFO - 'cart', 02:31:22 INFO - 'tsvg_static']}, 02:31:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'talos_options': ['--disable-e10s'], 02:31:22 INFO - 'tests': ['tp5o']}, 02:31:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:31:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'talos_options': ['--disable-e10s', 02:31:22 INFO - '--xperf_path', 02:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:22 INFO - 'tests': ['tp5n']}, 02:31:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:31:22 INFO - 'talos_options': ['--xperf_path', 02:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:22 INFO - 'tests': ['tp5n']}}, 02:31:22 INFO - 'talos.zip': {'path': '', 02:31:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:31:22 INFO - Running post-action listener: _resource_record_post_action 02:31:22 INFO - [mozharness: 2017-01-12 10:31:22.754712Z] Finished populate-webroot step (success) 02:31:22 INFO - [mozharness: 2017-01-12 10:31:22.754843Z] Running create-virtualenv step. 02:31:22 INFO - Running pre-action listener: _resource_record_pre_action 02:31:22 INFO - Running main action method: create_virtualenv 02:31:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:22 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 02:31:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:31:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:22 INFO - Using real prefix '/tools/python27' 02:31:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:31:26 INFO - Installing pip.................done. 02:31:26 INFO - Return code: 0 02:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:31:26 INFO - Reading from file tmpfile_stdout 02:31:26 INFO - Output received: 02:31:26 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) 02:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:26 INFO - 'HOME': '/Users/cltbld', 02:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:26 INFO - 'LOGNAME': 'cltbld', 02:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:26 INFO - 'MOZ_NO_REMOTE': '1', 02:31:26 INFO - 'NO_EM_RESTART': '1', 02:31:26 INFO - 'PAGER': '/bin/cat', 02:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:26 INFO - 'PWD': '/builds/slave/test', 02:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:26 INFO - 'SHELL': '/bin/bash', 02:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:26 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:26 INFO - 'USER': 'cltbld', 02:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:26 INFO - 'XPC_FLAGS': '0x0', 02:31:26 INFO - 'XPC_SERVICE_NAME': '0', 02:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:26 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 02:31:26 INFO - Cleaning up... 02:31:26 INFO - Return code: 0 02:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:26 INFO - 'HOME': '/Users/cltbld', 02:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:26 INFO - 'LOGNAME': 'cltbld', 02:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:26 INFO - 'MOZ_NO_REMOTE': '1', 02:31:26 INFO - 'NO_EM_RESTART': '1', 02:31:26 INFO - 'PAGER': '/bin/cat', 02:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:26 INFO - 'PWD': '/builds/slave/test', 02:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:26 INFO - 'SHELL': '/bin/bash', 02:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:26 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:26 INFO - 'USER': 'cltbld', 02:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:26 INFO - 'XPC_FLAGS': '0x0', 02:31:26 INFO - 'XPC_SERVICE_NAME': '0', 02:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:27 INFO - Downloading/unpacking psutil>=3.1.1 02:31:27 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 02:31:27 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 02:31:27 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 02:31:27 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 02:31:27 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 02:31:27 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 02:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:30 INFO - Installing collected packages: psutil 02:31:30 INFO - Running setup.py install for psutil 02:31:30 INFO - building 'psutil._psutil_osx' extension 02:31:30 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 02:31:31 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 02:31:31 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 02:31:31 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 02:31:31 INFO - building 'psutil._psutil_posix' extension 02:31:31 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 02:31:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:31:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:31:31 INFO - ^ 02:31:31 INFO - 1 warning generated. 02:31:31 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 02:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:31 INFO - Successfully installed psutil 02:31:31 INFO - Cleaning up... 02:31:31 INFO - Return code: 0 02:31:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:31 INFO - 'HOME': '/Users/cltbld', 02:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:31 INFO - 'LOGNAME': 'cltbld', 02:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:31 INFO - 'MOZ_NO_REMOTE': '1', 02:31:31 INFO - 'NO_EM_RESTART': '1', 02:31:31 INFO - 'PAGER': '/bin/cat', 02:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:31 INFO - 'PWD': '/builds/slave/test', 02:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:31 INFO - 'SHELL': '/bin/bash', 02:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:31 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:31 INFO - 'USER': 'cltbld', 02:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:31 INFO - 'XPC_FLAGS': '0x0', 02:31:31 INFO - 'XPC_SERVICE_NAME': '0', 02:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:31:34 INFO - Installing collected packages: mozsystemmonitor 02:31:34 INFO - Running setup.py install for mozsystemmonitor 02:31:34 INFO - Successfully installed mozsystemmonitor 02:31:34 INFO - Cleaning up... 02:31:35 INFO - Return code: 0 02:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:35 INFO - 'HOME': '/Users/cltbld', 02:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:35 INFO - 'LOGNAME': 'cltbld', 02:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:35 INFO - 'MOZ_NO_REMOTE': '1', 02:31:35 INFO - 'NO_EM_RESTART': '1', 02:31:35 INFO - 'PAGER': '/bin/cat', 02:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:35 INFO - 'PWD': '/builds/slave/test', 02:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:35 INFO - 'SHELL': '/bin/bash', 02:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:35 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:35 INFO - 'USER': 'cltbld', 02:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:35 INFO - 'XPC_FLAGS': '0x0', 02:31:35 INFO - 'XPC_SERVICE_NAME': '0', 02:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:37 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 02:31:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:31:38 INFO - warning: no files found matching '*.txt' 02:31:38 INFO - no previously-included directories found matching 'build' 02:31:38 INFO - no previously-included directories found matching 'dist' 02:31:38 INFO - no previously-included directories found matching '.git*' 02:31:38 INFO - Installing collected packages: jsonschema, functools32 02:31:38 INFO - Running setup.py install for functools32 02:31:38 INFO - warning: no files found matching '*.txt' 02:31:38 INFO - no previously-included directories found matching 'build' 02:31:38 INFO - no previously-included directories found matching 'dist' 02:31:38 INFO - no previously-included directories found matching '.git*' 02:31:38 INFO - Successfully installed jsonschema functools32 02:31:38 INFO - Cleaning up... 02:31:38 INFO - Return code: 0 02:31:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:31:38 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')]} 02:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:38 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')]} 02:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:38 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:38 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 02:31:38 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 02:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:38 INFO - 'HOME': '/Users/cltbld', 02:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:38 INFO - 'LOGNAME': 'cltbld', 02:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:38 INFO - 'MOZ_NO_REMOTE': '1', 02:31:38 INFO - 'NO_EM_RESTART': '1', 02:31:38 INFO - 'PAGER': '/bin/cat', 02:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:38 INFO - 'PWD': '/builds/slave/test', 02:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:38 INFO - 'SHELL': '/bin/bash', 02:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:38 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:38 INFO - 'USER': 'cltbld', 02:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:38 INFO - 'XPC_FLAGS': '0x0', 02:31:38 INFO - 'XPC_SERVICE_NAME': '0', 02:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:31:38 INFO - Cleaning up... 02:31:38 INFO - Return code: 0 02:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31:38 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')]} 02:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:38 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')]} 02:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:38 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:38 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 02:31:38 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 02:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:38 INFO - 'HOME': '/Users/cltbld', 02:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:38 INFO - 'LOGNAME': 'cltbld', 02:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:38 INFO - 'MOZ_NO_REMOTE': '1', 02:31:38 INFO - 'NO_EM_RESTART': '1', 02:31:38 INFO - 'PAGER': '/bin/cat', 02:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:38 INFO - 'PWD': '/builds/slave/test', 02:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:38 INFO - 'SHELL': '/bin/bash', 02:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:38 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:38 INFO - 'USER': 'cltbld', 02:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:38 INFO - 'XPC_FLAGS': '0x0', 02:31:38 INFO - 'XPC_SERVICE_NAME': '0', 02:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:41 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 02:31:41 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 02:31:41 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 02:31:41 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 02:31:41 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 02:31:41 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 02:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31: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 02:31: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 02:31: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 02:31: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 02:31: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 02:31: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 02:31:43 INFO - Downloading docopt-0.6.1.tar.gz 02:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:31:43 INFO - Running setup.py install for blobuploader 02:31:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:31:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:31:43 INFO - Running setup.py install for requests 02:31:43 INFO - Running setup.py install for docopt 02:31:43 INFO - Successfully installed blobuploader requests docopt 02:31:43 INFO - Cleaning up... 02:31:44 INFO - Return code: 0 02:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:44 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:44 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 02:31:44 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 02:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:44 INFO - 'HOME': '/Users/cltbld', 02:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:44 INFO - 'LOGNAME': 'cltbld', 02:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:44 INFO - 'MOZ_NO_REMOTE': '1', 02:31:44 INFO - 'NO_EM_RESTART': '1', 02:31:44 INFO - 'PAGER': '/bin/cat', 02:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:44 INFO - 'PWD': '/builds/slave/test', 02:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:44 INFO - 'SHELL': '/bin/bash', 02:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:44 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:44 INFO - 'USER': 'cltbld', 02:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:44 INFO - 'XPC_FLAGS': '0x0', 02:31:44 INFO - 'XPC_SERVICE_NAME': '0', 02:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-q0dmGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Ju7WGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-sPu9tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JtSGuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ukl7w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Eay3fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-pfda34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Eo4bIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-wLHohu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-bM60ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-R1LL2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7ZsGqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-CvDtfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-1GWV30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-_cdTmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-cm5Q_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:45 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-2p11yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:31:46 INFO - Running setup.py install for manifestparser 02:31:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:31:46 INFO - Running setup.py install for mozcrash 02:31:46 INFO - Running setup.py install for mozdebug 02:31:46 INFO - Running setup.py install for mozdevice 02:31:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:31:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:31:46 INFO - Running setup.py install for mozfile 02:31:46 INFO - Running setup.py install for mozhttpd 02:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:31:46 INFO - Running setup.py install for mozinfo 02:31:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Running setup.py install for mozInstall 02:31:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Running setup.py install for mozleak 02:31:47 INFO - Running setup.py install for mozlog 02:31:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Running setup.py install for moznetwork 02:31:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Running setup.py install for mozprocess 02:31:47 INFO - Running setup.py install for mozprofile 02:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:31:48 INFO - Running setup.py install for mozrunner 02:31:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:31:48 INFO - Running setup.py install for mozscreenshot 02:31:48 INFO - Running setup.py install for moztest 02:31:48 INFO - Running setup.py install for mozversion 02:31:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:31:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:31:48 INFO - Cleaning up... 02:31:48 INFO - Return code: 0 02:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:48 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')]} 02:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 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')]} 02:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:48 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 02:31:48 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 02:31:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:48 INFO - 'HOME': '/Users/cltbld', 02:31:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:48 INFO - 'LOGNAME': 'cltbld', 02:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:48 INFO - 'MOZ_NO_REMOTE': '1', 02:31:48 INFO - 'NO_EM_RESTART': '1', 02:31:48 INFO - 'PAGER': '/bin/cat', 02:31:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:48 INFO - 'PWD': '/builds/slave/test', 02:31:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:48 INFO - 'SHELL': '/bin/bash', 02:31:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:48 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:48 INFO - 'USER': 'cltbld', 02:31:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:48 INFO - 'XPC_FLAGS': '0x0', 02:31:48 INFO - 'XPC_SERVICE_NAME': '0', 02:31:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:48 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-pkDxjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-GcZFk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-YwKc00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rdvjdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-K66Ddf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-9OErWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-gXEVlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WmV4uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-VBweaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-243Mfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:49 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)) 02:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:49 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rl0QtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-KTvQnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-6Fnodl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-cii3El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-LXN4Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-2jlLsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:50 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)) 02:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:50 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-qeAWYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:50 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)) 02:31:50 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)) 02:31:50 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)) 02:31:50 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)) 02:31:50 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)) 02:31:50 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)) 02:31:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:31:50 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 02:31:50 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 02:31:50 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 02:31:50 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 02:31:50 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 02:31:50 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 02:31:53 INFO - Downloading blessings-1.6.tar.gz 02:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:31:53 INFO - Installing collected packages: blessings 02:31:53 INFO - Running setup.py install for blessings 02:31:53 INFO - Successfully installed blessings 02:31:53 INFO - Cleaning up... 02:31:53 INFO - Return code: 0 02:31:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:54 INFO - Reading from file tmpfile_stdout 02:31:54 INFO - Current package versions: 02:31:54 INFO - blessings == 1.6 02:31:54 INFO - blobuploader == 1.2.4 02:31:54 INFO - docopt == 0.6.1 02:31:54 INFO - functools32 == 3.2.3-2 02:31:54 INFO - jsonschema == 2.5.1 02:31:54 INFO - manifestparser == 1.1 02:31:54 INFO - mozInstall == 1.12 02:31:54 INFO - mozcrash == 1.0 02:31:54 INFO - mozdebug == 0.1 02:31:54 INFO - mozdevice == 0.49 02:31:54 INFO - mozfile == 1.2 02:31:54 INFO - mozhttpd == 0.7 02:31:54 INFO - mozinfo == 0.9 02:31:54 INFO - mozleak == 0.1 02:31:54 INFO - mozlog == 3.4 02:31:54 INFO - moznetwork == 0.27 02:31:54 INFO - mozprocess == 0.24 02:31:54 INFO - mozprofile == 0.28 02:31:54 INFO - mozrunner == 6.13 02:31:54 INFO - mozscreenshot == 0.1 02:31:54 INFO - mozsystemmonitor == 0.3 02:31:54 INFO - moztest == 0.8 02:31:54 INFO - mozversion == 1.4 02:31:54 INFO - psutil == 3.1.1 02:31:54 INFO - requests == 1.2.3 02:31:54 INFO - wsgiref == 0.1.2 02:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:54 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')]} 02:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 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')]} 02:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:54 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 02:31:54 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 02:31:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:54 INFO - 'HOME': '/Users/cltbld', 02:31:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:54 INFO - 'LOGNAME': 'cltbld', 02:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:54 INFO - 'MOZ_NO_REMOTE': '1', 02:31:54 INFO - 'NO_EM_RESTART': '1', 02:31:54 INFO - 'PAGER': '/bin/cat', 02:31:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:54 INFO - 'PWD': '/builds/slave/test', 02:31:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:54 INFO - 'SHELL': '/bin/bash', 02:31:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:54 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:54 INFO - 'USER': 'cltbld', 02:31:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:54 INFO - 'XPC_FLAGS': '0x0', 02:31:54 INFO - 'XPC_SERVICE_NAME': '0', 02:31:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 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)) 02:31:54 INFO - Cleaning up... 02:31:54 INFO - Return code: 0 02:31:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:31:54 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')]} 02:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 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')]} 02:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 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 0x10fe12b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe15768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc529cecd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, '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.RpiUNFjFj2/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.sDewczFlom/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 02:31:54 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 02:31:54 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 02:31:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:31:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:54 INFO - 'HOME': '/Users/cltbld', 02:31:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:54 INFO - 'LOGNAME': 'cltbld', 02:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:54 INFO - 'MOZ_NO_REMOTE': '1', 02:31:54 INFO - 'NO_EM_RESTART': '1', 02:31:54 INFO - 'PAGER': '/bin/cat', 02:31:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:54 INFO - 'PWD': '/builds/slave/test', 02:31:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:54 INFO - 'SHELL': '/bin/bash', 02:31:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:31:54 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:31:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:54 INFO - 'USER': 'cltbld', 02:31:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:54 INFO - 'XPC_FLAGS': '0x0', 02:31:54 INFO - 'XPC_SERVICE_NAME': '0', 02:31:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:31:54 INFO - Cleaning up... 02:31:54 INFO - Return code: 0 02:31:54 INFO - Running post-action listener: _resource_record_post_action 02:31:54 INFO - Running post-action listener: _start_resource_monitoring 02:31:55 INFO - Starting resource monitoring. 02:31:55 INFO - [mozharness: 2017-01-12 10:31:55.028944Z] Finished create-virtualenv step (success) 02:31:55 INFO - [mozharness: 2017-01-12 10:31:55.029870Z] Running install step. 02:31:55 INFO - Running pre-action listener: _resource_record_pre_action 02:31:55 INFO - Running main action method: install 02:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:55 INFO - Reading from file tmpfile_stdout 02:31:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:31:55 INFO - Reading from file tmpfile_stdout 02:31:55 INFO - Output received: 02:31:55 INFO - Usage: mozinstall [options] installer 02:31:55 INFO - Options: 02:31:55 INFO - -h, --help show this help message and exit 02:31:55 INFO - -d DEST, --destination=DEST 02:31:55 INFO - Directory to install application into. [default: 02:31:55 INFO - "/builds/slave/test"] 02:31:55 INFO - --app=APP Application being installed. [default: firefox] 02:31:55 INFO - mkdir: /builds/slave/test/build/application 02:31:55 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'] 02:31:55 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 02:32:17 INFO - Reading from file tmpfile_stdout 02:32:17 INFO - Output received: 02:32:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:32:17 INFO - Running post-action listener: _resource_record_post_action 02:32:17 INFO - [mozharness: 2017-01-12 10:32:17.198168Z] Finished install step (success) 02:32:17 INFO - [mozharness: 2017-01-12 10:32:17.198298Z] Running run-tests step. 02:32:17 INFO - Running pre-action listener: _resource_record_pre_action 02:32:17 INFO - Running main action method: run_tests 02:32:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:32:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:32:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:32:17 INFO - 2017-01-12 02:32:17.213 screenresolution[1619:7533] starting screenresolution argv=screenresolution get 02:32:17 INFO - 2017-01-12 02:32:17.215 screenresolution[1619:7533] Display 0: 1600x1200x32@60 02:32:17 INFO - 2017-01-12 02:32:17.221 screenresolution[1620:7535] starting screenresolution argv=screenresolution list 02:32:17 INFO - Available Modes on Display 0 02:32:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:32:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:32:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:32:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:32:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:32:17 INFO - Intel Iris: 02:32:17 INFO - Chipset Model: Intel Iris 02:32:17 INFO - Type: GPU 02:32:17 INFO - Bus: Built-In 02:32:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:32:17 INFO - Vendor: Intel (0x8086) 02:32:17 INFO - Device ID: 0x0a2e 02:32:17 INFO - Revision ID: 0x0009 02:32:17 INFO - Displays: 02:32:17 INFO - Display: 02:32:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:32:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:32:17 INFO - Display Serial Number: 1600x1200 60 02:32:17 INFO - Main Display: Yes 02:32:17 INFO - Mirror: Off 02:32:17 INFO - Online: Yes 02:32:17 INFO - Rotation: Supported 02:32:17 INFO - Return code: 0 02:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:17 INFO - Python 2.7.3 02:32:17 INFO - Return code: 0 02:32:17 INFO - grabbing minidump binary from tooltool 02:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf0d30>, '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 0x10fb17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:32:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:32:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:32:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:17 INFO - Return code: 0 02:32:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:32:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 02:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --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 02:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RpiUNFjFj2/Render', 02:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:17 INFO - 'HOME': '/Users/cltbld', 02:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:17 INFO - 'LOGNAME': 'cltbld', 02:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:17 INFO - 'MOZ_NO_REMOTE': '1', 02:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:17 INFO - 'NO_EM_RESTART': '1', 02:32:17 INFO - 'PAGER': '/bin/cat', 02:32:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:17 INFO - 'PWD': '/builds/slave/test', 02:32:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:17 INFO - 'SHELL': '/bin/bash', 02:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDewczFlom/Listeners', 02:32:17 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 02:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:17 INFO - 'USER': 'cltbld', 02:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:17 INFO - 'XPC_FLAGS': '0x0', 02:32:17 INFO - 'XPC_SERVICE_NAME': '0', 02:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 02:32:17 INFO - mozversion application_buildid: 20170112011317 02:32:17 INFO - mozversion application_changeset: a2425e6d32feebaa6a0ae749be2d888fc3d11e92 02:32:17 INFO - mozversion application_display_name: Nightly 02:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:17 INFO - mozversion application_name: Firefox 02:32:17 INFO - mozversion application_remotingname: firefox 02:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:32:17 INFO - mozversion application_vendor: Mozilla 02:32:17 INFO - mozversion application_version: 53.0a1 02:32:17 INFO - mozversion platform_buildid: 20170112011317 02:32:17 INFO - mozversion platform_changeset: a2425e6d32feebaa6a0ae749be2d888fc3d11e92 02:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:32:17 INFO - mozversion platform_version: 53.0a1 02:32:17 INFO - using testdate: 1484217137 02:32:17 INFO - actual date: 1484217137 02:32:17 INFO - starting webserver on 'localhost:49244' 02:32:17 INFO - SUITE-START | Running 2 tests 02:32:17 INFO - TEST-START | dromaeo_css 02:32:17 INFO - operating with platform_type : mac_ 02:32:17 INFO - Initialising browser for dromaeo_css test... 02:32:17 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpM5swFZ/profile http://localhost:49244/getInfo.html) 02:32:20 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 02:32:20 INFO - PROCESS | 1630 | colorDepth:24 02:32:20 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 02:32:20 INFO - PROCESS | 1630 | __metrics 02:32:20 INFO - PROCESS | 1630 | 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" 02:32:20 INFO - PROCESS | 1630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:21 INFO - TEST-INFO | 1630: exit 0 02:32:21 INFO - Browser initialized. 02:32:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:21 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpM5swFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:33 INFO - PROCESS | 1632 | RSS: Main: 233676800 02:32:33 INFO - PROCESS | 1632 | 02:35:38 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 02:35:40 INFO - PROCESS | 1632 | RSS: Main: 323764224 02:35:40 INFO - PROCESS | 1632 | 02:37:22 INFO - PROCESS | 1632 | ************************* 02:37:22 INFO - PROCESS | 1632 | A coding exception was thrown and uncaught in a Task. 02:37:22 INFO - PROCESS | 1632 | 02:37:22 INFO - PROCESS | 1632 | Full message: ReferenceError: fetch is not defined 02:37:22 INFO - PROCESS | 1632 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:37:22 INFO - PROCESS | 1632 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:37:22 INFO - PROCESS | 1632 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:37:22 INFO - PROCESS | 1632 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:37:22 INFO - PROCESS | 1632 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:37:22 INFO - PROCESS | 1632 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:37:22 INFO - PROCESS | 1632 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:37:22 INFO - PROCESS | 1632 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:37:22 INFO - PROCESS | 1632 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:37:22 INFO - PROCESS | 1632 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:37:22 INFO - PROCESS | 1632 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:37:22 INFO - PROCESS | 1632 | 02:37:22 INFO - PROCESS | 1632 | ************************* 02:38:43 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 02:38:43 INFO - PROCESS | 1632 | RSS: Main: 367939584 02:38:43 INFO - PROCESS | 1632 | 02:41:46 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 02:41:46 INFO - PROCESS | 1632 | RSS: Main: 345333760 02:41:46 INFO - PROCESS | 1632 | 02:44:48 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 02:44:49 INFO - PROCESS | 1632 | RSS: Main: 350879744 02:44:49 INFO - PROCESS | 1632 | 02:47:53 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 02:47:53 INFO - PROCESS | 1632 | RSS: Main: 324104192 02:47:53 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 02:50:57 INFO - PROCESS | 1632 | RSS: Main: 409321472 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | __start_tp_report 02:50:57 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 02:50:57 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 02:50:57 INFO - PROCESS | 1632 | |i|pagename|runs| 02:50:57 INFO - PROCESS | 1632 | |0;dojo.html;3317.436035873902;3333.300006998531;3334.116459138329;3361.1429085583172;3400.5409269748575;5563.443655634444;5612.270404847374;5655.971720141399;5709.029464990951;5745.511631511321;5657.9717101414435;5708.914366284509;5789.986752318338;5816.185733997244;5817.447342502455;5107;5118.692878427288;5163.967206558685;5220.3996540397775;5276.1030624793875;5279.815206467774;5349.625526213166;5357.169638705987;5372.328458942632;5404.054290499147;5151.716655583941;5277.261183434322;5284.709340986245;5298.549623282026;5329.440408757083;5186.222066689989;5197.194434862602;5219.530242278213;5236.895262094737;5246.554042906358;4330.696851220416;5226.712530810804;5243.344581927259;5253.816116435944;5281.15501519755;5717.714114294268;5733.512651424592;5753.510951569122;5768.826935191951;5777.768889244425;6137.1444550974375;6178.691065446755;6180.443760061616;6232.376762323776;6319.304876463585;6301.180846489973;6308.968455157741;6319.0837328587095;6336.683165841736;6362.395572420659;5867.589268751147;5935.970320148372;5938.287405511323;5941.643501389931;5988.580799344091;6253.824075133413;6289.905651415233;6317.052442133625;6332.525060620472;6351.301356850743;6141.775567826927;6142.78500252489;6191.9690401547705;6202.937970620326;6264.310925798159;5954.166416701665;5998.340182579913;6316.431521163117;6355.523335749837;6358.141650877073;4968.72672003036;5904.851906194771;5929.911051334234;5974.701264936736;6000.729967151488;5991.370906054802;6005.309389420186;6009;6015.699215039231;6027.7287522061615;4882.902341953141;4895.143349913751;4898.53463920927;4906.803727850846;4911.091448082117;4336.934945975813;4337.869863904088;4406.9559304407185;4410.845620403271;4422.911541769146;5631.549476041907;5804.912926306109;5819.301683797887;5827.650340979555;5833.241678581757;6204.162438070893;6229.595076320024;6232.0963460298;6263.686815659199;6286.654234017173;5766.913496297559;5816.185733997244;5841.649501029867;5853.414658534198;5870.530357571384;4700.318453824177;5518.751656175482;5542.057850165482;5546.972265138648;5552.888942221214;6281.371862813682;6320.178376810985;6336.366363363627;6361.332060133805;6402.231732192166;6274.654893980693;6331.651759153291;6341.175647165839;6357.110004599267;6364.490840732823;6385.904211436925;6404.199475065617;6411.4870810336;6429.485641148791;6432.292447830829;6041.486473649789;6083.513318934386;6225.28409232944;6266.310705822447;6302.621842689453;6256.092866534418;6269.185005949197;6339.302676705651;6348.682565871781;6360.904586431115;6015;6132.816015519542;6203.472704820141;6216.595921265103;6232.501399887908;4794.8492361833605;5697.829065128053;6195.81412557624;6199.783007594712;6261.78083767066;5931.258592675916;5982.940170598413;5987.161797348462;6002.369751176064;6120.479759220516;6195.876082478415;6228.56400051992;6248.68756562161;6262.279837818709;6270.059491076375;5875.823725288248;5895.380984996514;5900.085486749561;5936.317323507852;5940.1683764272175 02:50:57 INFO - PROCESS | 1632 | |1;ext.html;460.88477880529865;491.73446338976953;494.6438564233755;519.475329916784;534.313407271656;41487;43533.34699979499;43542.34686479705;45470.31794523077;45676.77161614196;37026.629733702655;44378.77810610951;44926.32610510837;45008.54991450084;45060;8343.874841877378;9209.58556864941;9409;9423.246140308793;9425.19885809707;8298.792530186733;11103.55585776572;11373.033292170176;11374.943125284362;11577.247478913885;11345.659630211065;11407.315561066322;11417.143714221425;11418.657440276764;11452.255603385795;7030.894536581955;11291.717707057307;11317.547298108066;11334.206605537616;11354.545818167264;8348.457350272274;11030.944845275802;11263.831042534286;11289.548418063268;11511.827322590168;35125.82437087824;42165.367519487234;42580.57419425797;42606.360904586145;42624.14751704949;3575.7496975211748;4040.8181631826637;4080.2451546463703;4091.590840915914;4098.83259212198;25739.227823165336;30616.8469157655;31348.843255783577;31832.429324868055;31878;3022.9546556801665;3070.155707180521;3230.4023755605053;3297.7361811055057;3345.1971526833386;474316.99999999657;478626;478763;484238;486927;64286.71426571442;64490.35509644937;66518;66719.66640166768;67083.66458167679;70341.64829175924;70463;70479.2952070483;70500.64749676219;70690.2930970694;16534.007959522467;16757.24592393321;16761.664766704598;16763.99416035042;16793;10679.252452328417;10855.348679079123;12692.365381730877;12803.231806091664;12821.551245706356;15405.691886162214;17063.31746730142;17642.318514350027;19521.804781952;19859;6422.068800023971;6625.204975402886;7028.332308430691;7085.964570177116;7113.679884405215;863.8488264553678;887.5207388010402;893.7497500699815;916.6150216908915;927.9907200928039;30226.24434389158;30688.396646412617;30962.380752385277;31085.844570777455;31418.842905785325;997.2221667099674;1070.7430216747925;1093.4642025407493;1100.801855665988;1101.493313075978;13862.185476998617;15281.847181528265;15715.214239288218;16284.348626055062;16300.10349430769;613609;619856;620496;620676;621412;63772;63793;63925.36074639287;64050;64115.35884641187;1426.3795249066688;1462.6050966239056;1468.9972108904442;1483.8887083468999;1486.947956821506;27600.033998809944;29531;30037.849810750806;30524;31345.529817052306;54638.72680636571;54979.725101374235;55022;55067;55071;462880;502812;530088;530987;531232.3438382783;25347.493050139263;25919.74080259249;26053.869730651226;42795.786021069696;43136.35295470633;37432;38103;39833.80083099682;44890.85763996489;45109.32336014897;31279.374412511166;34075;35248.47127293144;35264.64735352614;38724;36755.81622091872;36869.63130368662;37167.8141609301;38378.42432363573;38403;36162.638373615926;36513.81743091268;36795.44806827846;36931.44602830906;37297.440538391405;31030.379392412477;33017.606141515695;33574.66425335813;33763.987080387626;33923.15192120217;21111.15555377829;24837;24871;24928;25463.618045729698 02:50:57 INFO - PROCESS | 1632 | |2;jquery.html;347.1910448654635;387.6511139974023;392.85071672764343;400.37741312259436;422.5584264443656;19411.70882436763;21452.89273553634;21757.564848703016;21882;22221.222257221;20244.190232390723;20815.687764683542;20983.16067357304;22208.222712205035;22543.774562254373;5323.893522129555;6087.634741915477;6121.449069583737;6139.6009259398;6139.846503837418;4831;5883.793822266446;6003.729832157542;6112.572119951606;6121.510279177655;6072.514198864103;6098.908516372258;6106.786262480814;6107.328193898667;6110.633361998272;5437.151368534717;5521.309836270466;5585.441455854402;6080.087986801993;6094.756209751627;5390.568754499631;5395.217693434469;5395.811146609889;5396.217548455491;5403.918941215846;13569.1858488491;14416.63958401038;20227.494312642153;23944.88027559851;25370.619440708404;2585;2671.412289296352;2685.717999610032;2745.958810617842;2790.9441811163665;9692.41845489273;10424.583016679324;10469.528871200815;10514.053735163796;10568.418736969463;1701.978812712375;1748.7464317673994;1789.8478629316523;1823.0337920901943;1825.6622524832815;108494;132920.7017403512;137490.31254843663;139673;139695;11359.545618175345;11499;11612.767744645229;11770.058395328524;12026.218295810744;15807.762883556756;15821.208939553206;15822.920885395499;15863.206839658202;15872.44446444369;7073.646317684095;8471.407001509835;8632.136786321318;8666.176713212235;8676.91323086761;8377.539235342114;8389.20302571267;8566.828663426697;8569.52867592276;8594.828103437896;4680.595821253611;4795.345605766005;4828.348172996671;4833.275008748716;4952.678075925053;1987.8210961013579;2018.5256464730776;2019.7071424643639;2020.222214447419;2026.4832467720637;1025.190099821133;1040.9895901041043;1045.25124706208;1049.2235745548392;1051.8790339110947;17483.475495735147;21738;22266.888665556893;23255.06979720792;24544.631830522558;882.4308321132834;894.2979760887672;918.6417297254076;943.528235882059;951.191487235844;6175.320714721377;6469.417752402306;7012.298770122947;7085.92914070863;7234.855302894018;657367;669686;676837;683890;684331;139964;143807;145027;147384.26307868393;148535;1045.3518818332682;1056.2553399853084;1078.3260462211117;1083.7561548651647;1084.2410312781085;10304.690859274233;12200.511979521074;12455.501779928702;12682.619521414372;12699;44189;59162.81674366402;61483.462913427524;62970.166342515615;63080;68511.3148868505;82565.17434825575;85496.57251713701;86704.56647716722;93681.5315923416;8282.461639993382;8435.283000944743;8455.281301089477;8458.619362128597;8671.4363566368;10618.787624247627;12983.610491685264;13036.283004434847;13309.600711978655;13492.392842321922;11125.499352529318;11212.383318917538;11392.316461012366;11517.769644607228;11524.539018439504;11278.154138439486;11374.374409407563;11523.250988685708;11725.120615954009;11974.461149248478;11276.661700149009;11808.82286765682;11830.585929492427;11961.162718609614;12130.696732581757;8223.835523289621;8243.340532757486;8606.354523410895;8704.78238044054;8717.041125476318;10033.749156271151;10846.45767711627;11052;11118.944405277922;11597.884021160018 02:50:57 INFO - PROCESS | 1632 | |3;mootools.html;1320.1287150480684;1435.8635929586692;1447.2835946206628;1449.9855001449985;1458.4895286649667;6652.467802575795;7415.777526674195;7778.611069446526;7790.143084260734;7791.065072191331;7611.429142814283;8015.4389192756535;8247.876281855762;8249.257566818986;8253.092159862425;2312.6993490846166;2342.0397636968846;2342.496363281894;2345.1909091363455;2349.0721165139844;2094.7276854008956;2138.561594873055;2161.5244646177894;2184.3337781976493;2352.2472808701223;2121.7241758571363;2244.236959433792;2318.524702436005;2328.1036800831635;2330.5222429402015;2283.680284760135;2299.931002069932;2312.42189452636;2313.3869524576003;2318.5131122464304;2309.56118337517;2326.674265602817;2352.2472808701223;2353.505763789606;2355.6466530020634;8223.465474744182;8293.3365330774;8298.419110662257;8302.211289927447;8302.418830681854;4958.132326842788;5156.819511317123;5157.767900444452;5157.9684063187515;5160.483951604847;3279.8360081995806;3350.27968986669;3529.082438565991;3532.5937517185594;3539.557555305587;1207.4144040140525;1224.5346768228105;1244.5519612939336;1249.2005116725304;1278.6867217531765;10781.0297073263;10794.5682172713;10807.783844323149;10822.783544329148;10834.187435942336;4120.814563344657;4382.452193475816;4592.908141837144;4692.0381321828945;4724.244120940633;9320.207782338577;9358.15776580111;9360.859587106199;9363.531823408803;9378.624855005859;5120.283160357553;5209.7916083356995;5215.843524694265;5221.947780522222;5230.450802665741;4631.160437342985;4733.431988161443;4738.289256611536;4763.476017638126;4766.904661906812;3743.9064023399633;3795.5635101963076;3829.195868867569;3879.903002424962;3896.077941543842;929.3179345384875;1271.9109662323733;1275.5344299330677;1276.9680757980939;1290.7547565962436;790.9011373578303;865.3293697384452;878.5914549734404;886.6763631274538;945.9783433891381;4715.6934799238625;5282;5395.109806881899;5446.101393270145;5451.536619387396;991.1674193677345;1004.9849252261222;1009.3237530854345;1033.7312298802215;1061.3207547169818;3526.894193174209;3539.8053107078845;3552.87564935226;3617.819109044537;3628.401313783196;9517.191038761783;9627.555866620063;9641.084097010773;9901.851472227921;9930.950345248228;9857.507124643738;9862.654807081717;9868.21054315653;9876.506174691236;9888.060634239735;7704.075510938723;7782.922170778333;7789.610519474004;7791.649375778104;7805;4375.453068366454;5082.771275292546;5228.45101264377;5387.191921211849;5537.8061767837935;8996.775080623036;9090.727278181665;9091.181793638605;9174.67888623895;9193.954030229806;9127.178553929913;9152.359334846496;9275.350725449154;9319.021502742115;9332.853443708122;6877.65611719422;6952.200496942916;7043.612601306977;7043.964780176067;7048.647567621496;6280.089387038763;7670.884936725842;7721.498102623312;7744.728934487492;7756.650950707344;6101.725422356093;7051.753188638373;7106.964465177641;7133.678984445816;7160.176579693402;6843.8973415399805;6896.310368963264;6922.342377474333;6946.826329341605;6964.965175174092;6117.296510901303;6250.3749625037135;6251;6252.030935205051;6254.8123556293385;4778.996410753781;4875.512448755097;4933.4819843915875;4936.086823937583;4940.333055037524;4836.685615434985;4863.2461968394955;4958.132326842716;5079.034983353151;5084.186530155157 02:50:57 INFO - PROCESS | 1632 | |4;prototype.html;348.32772748595215;353.7258624565962;364.5716283367044;371.11118870305603;373.5274877280241;5054.003668550925;5297.622618119288;5470.8085217017415;5493.791365899496;5502.046773395447;4780.561913424152;5224.373075230968;5396.872970677852;5443.292371991645;5446;3198.6001749781276;3897.6480227004754;4131.7934103294865;4160.771157586331;4168.916621667572;2954.4932084636775;3969.4870040014653;4092.6521245694003;4123.577365808791;4141.420201171838;3461;4081.9387709184384;4095.488063992001;4102.651274641644;4129.881939135948;3933.5476420211758;4028.0735430850777;4079.4084857695616;4089.754614723126;4131.814068366931;3136.623605167372;3545.7340699447645;3548.7870727756417;3562.340966921128;3564.376234159012;4486.528914463967;5114.590832733373;5155.814162742553;5342.252084708144;5381.192821076831;4530.79611417487;4683.976580117112;4694.201985662446;4701.835435759766;4732.171869922784;5281.445448227958;5521.923224971132;5769.769209231667;5777.653340799523;5794.855128621776;3487.808170550619;3899.961000389988;3915.843366265346;3922.235164142993;3923.1761330120707;5488.4237155098535;5742.712864356766;5755.568332375088;6045.33501314855;6099.48154406876;3909.882703518899;3942.7634341939574;3953.1303113315025;3978.5822488638855;3981.3629819228786;3890.2219556088894;3909.159530700856;4035.3455083416247;4049.230646177217;4060.725993443681;4262.4458820353775;4328.523862375199;4597.804570811613;4683.765811709401;4711.7879695413785;4566.383538222364;5810.244668193108;5819.709014549256;5905.405540504125;5927.525797936155;1227.4844565282424;1294.5145570411096;1311.7507673541998;1320.7886738121854;1330.447864136392;800.9639566219535;805.9884844520207;868.4702331577732;876.6274333408403;890.857462805961;4322.487129504711;5166.560842328444;5233.502817232356;5241.842744717665;5260.868478288074;5041.840376713377;5059;5295.6557823742105;5576.375356018621;5670.943290567124;4792.784324705397;4873.832009194052;4971.875703107451;5334.066263555107;5353.437889021675;2516.5596020696303;2790.7999560189314;2827.1518544436585;2867.777472458861;3002.609660744089;5290.497402746733;5431.8098866539485;5469.316335458067;5562.499375056183;5876;4906.975465122651;4948.931662369354;5138.76463738275;5560.249366335493;5819.505342045889;4876.951230487721;5135.974320128375;5634.816688495462;5863.589548731633;5960.970195149083;4971.726555039508;5568.331800184003;5570.498655121059;5616.680080181072;5700.380258535943;4940.209566469348;5167.302414174038;5221.738913054256;5327.9733601331745;5426.891462170814;4849.733264670477;5044.848654540369;5272.868178295574;5878;5890.204822348928;3152.590163278759;3273.738100951966;3555.911102222465;3713.8143092844707;3735.4210097434943;5146.639735218499;5478.506934375925;5681;5696.686682232517;5699.23060386859;5287.339082614673;5440.564754819684;5444.26502422168;5493;5522.282103326542;5124.948750512447;5340.787264351788;5452.745868450199;5474.781008759605;5479.53423958952;4430.446194225722;4956.653034287565;4983.700977941335;5287.118520406465;5366.436524164907;4606.677532572822;4982.501749824988;5426.511613954763;5428.064653126609;5602;4917;5102.387713474407;5445.428230035789;5603.523700485504;5620.213170156263 02:50:57 INFO - PROCESS | 1632 | |5;yui.html;719.8812195987659;720.8702433561957;778.7507997440821;823.9423240373173;832.7043899415708;14179.716405671881;14606.342714577842;14720.190389528585;14843.332050057747;15658.98216615922;14316.35576399062;14626.48807291745;14630.268486575655;14649.26753662318;15176.620584485394;846.2722059029245;877.4209022045451;878.2578720980792;878.3982971664399;879.5997820991465;682.0825989044727;705.9435245180373;710.030807947151;866.3588944181323;869.1178453869328;886.8891388576428;910.4537277633433;918.3433844800966;921.2031592672324;921.8340698674236;910;911.2163539356148;911.5260064766351;911.5260064766351;912.9908700912972;525.1938274748243;540.5513423858188;681.8908974564096;684.0423407229869;687.0484379134884;14862.851371486255;15411.22943852803;15481.5355539334;15736.134512601802;15760.290786914502;13965.371558279901;14032.087914285641;14055.297235138201;14073.15561066329;14075.36660850254;10717.588542577936;11725.530978760838;12209.755804883942;12251.877481225252;12443.066769992287;3578.284343131384;3680.4479328100733;3688.409854423306;3753.7935413552245;3777.8866634001024;103303;110686.78626427507;111586.32620510699;111793;112435.43782281117;10448.178991672206;10865.619703310345;10899.237053406185;10995;11113.944430277797;22309;22313.99587018588;22316.553668926532;22320;22372.776272237395;7575.772726818204;7591.278828511283;7609.239076092346;7769.922300777033;7776.027996500437;4313.137372525444;4338.197433474817;4350.282203436397;4381.583749543788;4503.819847206075;3445.707114895212;3493;3497.772644778132;3525.94711079334;3533.9293214135573;633.2527617411498;643.0707627478249;648.5654611410366;653.5098675993005;653.7548419342746;621.2979333353281;646.8285904235381;654.2051407539861;666.6600033982704;679.2663922963188;9463.905360946303;9552.044795520393;9676.225901927828;10125.392476451436;10422.374657520573;584.6492104737209;593.2376895689105;603.6649659439054;614.0666187395224;615.8768246350747;4618.930716039262;4995.350604421402;5001.174806157016;5002.374703162105;5008.29883816266;103574;103943;104729;105853;106048;89700.6544901827;89857;90502;90955.99999999868;91430.54284728666;67520;77624;79410.6029469849;80522.19477805147;80811.19188808037;9828.673129127475;9829.115379615869;9841.409515429097;10051.69844904654;10352.275340726379;42891.356629649956;43967.78016109899;45054.3241851366;47003;48236.27645585389;60589.394106058375;62079;62415.37584624095;67741.66129169322;68002;11839.467223974769;12556.183848049848;13141.014423918054;13154.539591114648;13182.802257965946;13981.370838312503;14441.114773748792;14483.275836208359;14786.482473113389;15533.45632902843;13550;13646.459238106854;13723.313834308045;13894.652633684238;14024.929875350557;13559.59321220365;13939.303034848419;14035.649108772363;14067.09887837095;14210.360533775798;12250.938745306217;13073.215607063607;13530.391132398869;13701.177929323874;13706.451741930212;10444.265023972763;10702.625408110678;10890.945545272223;10926.604273423396;11226.66320010401;10289.897101028893;10844.45777711127;10990.560377584807;11014.229003969645;11070.557177713123 02:50:57 INFO - PROCESS | 1632 | __end_tp_report 02:50:57 INFO - PROCESS | 1632 | __start_cc_report 02:50:57 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1944 02:50:57 INFO - PROCESS | 1632 | __end_cc_report 02:50:57 INFO - PROCESS | 1632 | __startTimestamp1484218257510__endTimestamp 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | ------- Summary: start ------- 02:50:57 INFO - PROCESS | 1632 | Number of tests: 6 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5750.56 Median:5938.29 stddev:665.55 (11.2%) stddev-sans-first:639.63 02:50:57 INFO - PROCESS | 1632 | Values: 3317.4 3333.3 3334.1 3361.1 3400.5 5563.4 5612.3 5656.0 5709.0 5745.5 5658.0 5708.9 5790.0 5816.2 5817.4 5107.0 5118.7 5164.0 5220.4 5276.1 5279.8 5349.6 5357.2 5372.3 5404.1 5151.7 5277.3 5284.7 5298.5 5329.4 5186.2 5197.2 5219.5 5236.9 5246.6 4330.7 5226.7 5243.3 5253.8 5281.2 5717.7 5733.5 5753.5 5768.8 5777.8 6137.1 6178.7 6180.4 6232.4 6319.3 6301.2 6309.0 6319.1 6336.7 6362.4 5867.6 5936.0 5938.3 5941.6 5988.6 6253.8 6289.9 6317.1 6332.5 6351.3 6141.8 6142.8 6192.0 6202.9 6264.3 5954.2 5998.3 6316.4 6355.5 6358.1 4968.7 5904.9 5929.9 5974.7 6000.7 5991.4 6005.3 6009.0 6015.7 6027.7 4882.9 4895.1 4898.5 4906.8 4911.1 4336.9 4337.9 4407.0 4410.8 4422.9 5631.5 5804.9 5819.3 5827.7 5833.2 6204.2 6229.6 6232.1 6263.7 6286.7 5766.9 5816.2 5841.6 5853.4 5870.5 4700.3 5518.8 5542.1 5547.0 5552.9 6281.4 6320.2 6336.4 6361.3 6402.2 6274.7 6331.7 6341.2 6357.1 6364.5 6385.9 6404.2 6411.5 6429.5 6432.3 6041.5 6083.5 6225.3 6266.3 6302.6 6256.1 6269.2 6339.3 6348.7 6360.9 6015.0 6132.8 6203.5 6216.6 6232.5 4794.8 5697.8 6195.8 6199.8 6261.8 5931.3 5982.9 5987.2 6002.4 6120.5 6195.9 6228.6 6248.7 6262.3 6270.1 5875.8 5895.4 5900.1 5936.3 5940.2 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:68291.93 Median:36979.04 stddev:144136.84 (389.8%) stddev-sans-first:144451.21 02:50:57 INFO - PROCESS | 1632 | Values: 460.9 491.7 494.6 519.5 534.3 41487.0 43533.3 43542.3 45470.3 45676.8 37026.6 44378.8 44926.3 45008.5 45060.0 8343.9 9209.6 9409.0 9423.2 9425.2 8298.8 11103.6 11373.0 11374.9 11577.2 11345.7 11407.3 11417.1 11418.7 11452.3 7030.9 11291.7 11317.5 11334.2 11354.5 8348.5 11030.9 11263.8 11289.5 11511.8 35125.8 42165.4 42580.6 42606.4 42624.1 3575.7 4040.8 4080.2 4091.6 4098.8 25739.2 30616.8 31348.8 31832.4 31878.0 3023.0 3070.2 3230.4 3297.7 3345.2 474317.0 478626.0 478763.0 484238.0 486927.0 64286.7 64490.4 66518.0 66719.7 67083.7 70341.6 70463.0 70479.3 70500.6 70690.3 16534.0 16757.2 16761.7 16764.0 16793.0 10679.3 10855.3 12692.4 12803.2 12821.6 15405.7 17063.3 17642.3 19521.8 19859.0 6422.1 6625.2 7028.3 7086.0 7113.7 863.8 887.5 893.7 916.6 928.0 30226.2 30688.4 30962.4 31085.8 31418.8 997.2 1070.7 1093.5 1100.8 1101.5 13862.2 15281.8 15715.2 16284.3 16300.1 613609.0 619856.0 620496.0 620676.0 621412.0 63772.0 63793.0 63925.4 64050.0 64115.4 1426.4 1462.6 1469.0 1483.9 1486.9 27600.0 29531.0 30037.8 30524.0 31345.5 54638.7 54979.7 55022.0 55067.0 55071.0 462880.0 502812.0 530088.0 530987.0 531232.3 25347.5 25919.7 26053.9 42795.8 43136.4 37432.0 38103.0 39833.8 44890.9 45109.3 31279.4 34075.0 35248.5 35264.6 38724.0 36755.8 36869.6 37167.8 38378.4 38403.0 36162.6 36513.8 36795.4 36931.4 37297.4 31030.4 33017.6 33574.7 33764.0 33923.2 21111.2 24837.0 24871.0 24928.0 25463.6 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:38032.69 Median:23599.98 stddev:112796.94 (478.0%) stddev-sans-first:113077.87 02:50:57 INFO - PROCESS | 1632 | Values: 347.2 387.7 392.9 400.4 422.6 19411.7 21452.9 21757.6 21882.0 22221.2 20244.2 20815.7 20983.2 22208.2 22543.8 5323.9 6087.6 6121.4 6139.6 6139.8 4831.0 5883.8 6003.7 6112.6 6121.5 6072.5 6098.9 6106.8 6107.3 6110.6 5437.2 5521.3 5585.4 6080.1 6094.8 5390.6 5395.2 5395.8 5396.2 5403.9 13569.2 14416.6 20227.5 23944.9 25370.6 2585.0 2671.4 2685.7 2746.0 2790.9 9692.4 10424.6 10469.5 10514.1 10568.4 1702.0 1748.7 1789.8 1823.0 1825.7 108494.0 132920.7 137490.3 139673.0 139695.0 11359.5 11499.0 11612.8 11770.1 12026.2 15807.8 15821.2 15822.9 15863.2 15872.4 7073.6 8471.4 8632.1 8666.2 8676.9 8377.5 8389.2 8566.8 8569.5 8594.8 4680.6 4795.3 4828.3 4833.3 4952.7 1987.8 2018.5 2019.7 2020.2 2026.5 1025.2 1041.0 1045.3 1049.2 1051.9 17483.5 21738.0 22266.9 23255.1 24544.6 882.4 894.3 918.6 943.5 951.2 6175.3 6469.4 7012.3 7085.9 7234.9 657367.0 669686.0 676837.0 683890.0 684331.0 139964.0 143807.0 145027.0 147384.3 148535.0 1045.4 1056.3 1078.3 1083.8 1084.2 10304.7 12200.5 12455.5 12682.6 12699.0 44189.0 59162.8 61483.5 62970.2 63080.0 68511.3 82565.2 85496.6 86704.6 93681.5 8282.5 8435.3 8455.3 8458.6 8671.4 10618.8 12983.6 13036.3 13309.6 13492.4 11125.5 11212.4 11392.3 11517.8 11524.5 11278.2 11374.4 11523.3 11725.1 11974.5 11276.7 11808.8 11830.6 11961.2 12130.7 8223.8 8243.3 8606.4 8704.8 8717.0 10033.7 10846.5 11052.0 11118.9 11597.9 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:5334.58 Median:5159.23 stddev:2899.03 (56.2%) stddev-sans-first:2891.46 02:50:57 INFO - PROCESS | 1632 | Values: 1320.1 1435.9 1447.3 1450.0 1458.5 6652.5 7415.8 7778.6 7790.1 7791.1 7611.4 8015.4 8247.9 8249.3 8253.1 2312.7 2342.0 2342.5 2345.2 2349.1 2094.7 2138.6 2161.5 2184.3 2352.2 2121.7 2244.2 2318.5 2328.1 2330.5 2283.7 2299.9 2312.4 2313.4 2318.5 2309.6 2326.7 2352.2 2353.5 2355.6 8223.5 8293.3 8298.4 8302.2 8302.4 4958.1 5156.8 5157.8 5158.0 5160.5 3279.8 3350.3 3529.1 3532.6 3539.6 1207.4 1224.5 1244.6 1249.2 1278.7 10781.0 10794.6 10807.8 10822.8 10834.2 4120.8 4382.5 4592.9 4692.0 4724.2 9320.2 9358.2 9360.9 9363.5 9378.6 5120.3 5209.8 5215.8 5221.9 5230.5 4631.2 4733.4 4738.3 4763.5 4766.9 3743.9 3795.6 3829.2 3879.9 3896.1 929.3 1271.9 1275.5 1277.0 1290.8 790.9 865.3 878.6 886.7 946.0 4715.7 5282.0 5395.1 5446.1 5451.5 991.2 1005.0 1009.3 1033.7 1061.3 3526.9 3539.8 3552.9 3617.8 3628.4 9517.2 9627.6 9641.1 9901.9 9931.0 9857.5 9862.7 9868.2 9876.5 9888.1 7704.1 7782.9 7789.6 7791.6 7805.0 4375.5 5082.8 5228.5 5387.2 5537.8 8996.8 9090.7 9091.2 9174.7 9194.0 9127.2 9152.4 9275.4 9319.0 9332.9 6877.7 6952.2 7043.6 7044.0 7048.6 6280.1 7670.9 7721.5 7744.7 7756.7 6101.7 7051.8 7107.0 7133.7 7160.2 6843.9 6896.3 6922.3 6946.8 6965.0 6117.3 6250.4 6251.0 6252.0 6254.8 4779.0 4875.5 4933.5 4936.1 4940.3 4836.7 4863.2 4958.1 5079.0 5084.2 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4486.83 Median:5049.43 stddev:1365.12 (27.0%) stddev-sans-first:1333.14 02:50:57 INFO - PROCESS | 1632 | Values: 348.3 353.7 364.6 371.1 373.5 5054.0 5297.6 5470.8 5493.8 5502.0 4780.6 5224.4 5396.9 5443.3 5446.0 3198.6 3897.6 4131.8 4160.8 4168.9 2954.5 3969.5 4092.7 4123.6 4141.4 3461.0 4081.9 4095.5 4102.7 4129.9 3933.5 4028.1 4079.4 4089.8 4131.8 3136.6 3545.7 3548.8 3562.3 3564.4 4486.5 5114.6 5155.8 5342.3 5381.2 4530.8 4684.0 4694.2 4701.8 4732.2 5281.4 5521.9 5769.8 5777.7 5794.9 3487.8 3900.0 3915.8 3922.2 3923.2 5488.4 5742.7 5755.6 6045.3 6099.5 3909.9 3942.8 3953.1 3978.6 3981.4 3890.2 3909.2 4035.3 4049.2 4060.7 4262.4 4328.5 4597.8 4683.8 4711.8 4566.4 5810.2 5819.7 5905.4 5927.5 1227.5 1294.5 1311.8 1320.8 1330.4 801.0 806.0 868.5 876.6 890.9 4322.5 5166.6 5233.5 5241.8 5260.9 5041.8 5059.0 5295.7 5576.4 5670.9 4792.8 4873.8 4971.9 5334.1 5353.4 2516.6 2790.8 2827.2 2867.8 3002.6 5290.5 5431.8 5469.3 5562.5 5876.0 4907.0 4948.9 5138.8 5560.2 5819.5 4877.0 5136.0 5634.8 5863.6 5961.0 4971.7 5568.3 5570.5 5616.7 5700.4 4940.2 5167.3 5221.7 5328.0 5426.9 4849.7 5044.8 5272.9 5878.0 5890.2 3152.6 3273.7 3555.9 3713.8 3735.4 5146.6 5478.5 5681.0 5696.7 5699.2 5287.3 5440.6 5444.3 5493.0 5522.3 5124.9 5340.8 5452.7 5474.8 5479.5 4430.4 4956.7 4983.7 5287.1 5366.4 4606.7 4982.5 5426.5 5428.1 5602.0 4917.0 5102.4 5445.4 5603.5 5620.2 02:50:57 INFO - PROCESS | 1632 | 02:50:57 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:20470.07 Median:3684.43 stddev:29665.25 (805.2%) stddev-sans-first:29711.40 02:50:57 INFO - PROCESS | 1632 | Values: 719.9 720.9 778.8 823.9 832.7 14179.7 14606.3 14720.2 14843.3 15659.0 14316.4 14626.5 14630.3 14649.3 15176.6 846.3 877.4 878.3 878.4 879.6 682.1 705.9 710.0 866.4 869.1 886.9 910.5 918.3 921.2 921.8 910.0 911.2 911.5 911.5 913.0 525.2 540.6 681.9 684.0 687.0 14862.9 15411.2 15481.5 15736.1 15760.3 13965.4 14032.1 14055.3 14073.2 14075.4 10717.6 11725.5 12209.8 12251.9 12443.1 3578.3 3680.4 3688.4 3753.8 3777.9 103303.0 110686.8 111586.3 111793.0 112435.4 10448.2 10865.6 10899.2 10995.0 11113.9 22309.0 22314.0 22316.6 22320.0 22372.8 7575.8 7591.3 7609.2 7769.9 7776.0 4313.1 4338.2 4350.3 4381.6 4503.8 3445.7 3493.0 3497.8 3525.9 3533.9 633.3 643.1 648.6 653.5 653.8 621.3 646.8 654.2 666.7 679.3 9463.9 9552.0 9676.2 10125.4 10422.4 584.6 593.2 603.7 614.1 615.9 4618.9 4995.4 5001.2 5002.4 5008.3 103574.0 103943.0 104729.0 105853.0 106048.0 89700.7 89857.0 90502.0 90956.0 91430.5 67520.0 77624.0 79410.6 80522.2 80811.2 9828.7 9829.1 9841.4 10051.7 10352.3 42891.4 43967.8 45054.3 47003.0 48236.3 60589.4 62079.0 62415.4 67741.7 68002.0 11839.5 12556.2 13141.0 13154.5 13182.8 13981.4 14441.1 14483.3 14786.5 15533.5 13550.0 13646.5 13723.3 13894.7 14024.9 13559.6 13939.3 14035.6 14067.1 14210.4 12250.9 13073.2 13530.4 13701.2 13706.5 10444.3 10702.6 10890.9 10926.6 11226.7 10289.9 10844.5 10990.6 11014.2 11070.6 02:50:57 INFO - PROCESS | 1632 | -------- Summary: end -------- 02:50:57 INFO - PROCESS | 1632 | 02:50:58 INFO - TEST-INFO | 1632: exit 0 02:50:58 INFO - TEST-OK | dromaeo_css | took 1120326ms 02:50:58 INFO - TEST-START | kraken 02:50:58 INFO - operating with platform_type : mac_ 02:50:58 INFO - Initialising browser for kraken test... 02:50:58 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpk4CX2S/profile http://localhost:49244/getInfo.html) 02:51:00 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 02:51:00 INFO - PROCESS | 1642 | colorDepth:24 02:51:00 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 02:51:00 INFO - PROCESS | 1642 | __metrics 02:51:00 INFO - PROCESS | 1642 | 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" 02:51:00 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:01 INFO - TEST-INFO | 1642: exit 0 02:51:01 INFO - Browser initialized. 02:51:01 INFO - Running cycle 1/1 for kraken test... 02:51:01 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpk4CX2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:13 INFO - PROCESS | 1643 | RSS: Main: 234123264 02:51:13 INFO - PROCESS | 1643 | 02:51:16 INFO - PROCESS | 1643 | 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) 02:51:17 INFO - PROCESS | 1643 | RSS: Main: 287137792 02:51:17 INFO - PROCESS | 1643 | 02:51:19 INFO - PROCESS | 1643 | 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) 02:51:20 INFO - PROCESS | 1643 | RSS: Main: 286343168 02:51:20 INFO - PROCESS | 1643 | 02:51:23 INFO - PROCESS | 1643 | 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) 02:51:24 INFO - PROCESS | 1643 | RSS: Main: 377798656 02:51:24 INFO - PROCESS | 1643 | 02:51:26 INFO - PROCESS | 1643 | 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) 02:51:26 INFO - PROCESS | 1643 | RSS: Main: 281763840 02:51:26 INFO - PROCESS | 1643 | 02:51:29 INFO - PROCESS | 1643 | 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) 02:51:29 INFO - PROCESS | 1643 | RSS: Main: 286765056 02:51:29 INFO - PROCESS | 1643 | 02:51:32 INFO - PROCESS | 1643 | 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) 02:51:33 INFO - PROCESS | 1643 | RSS: Main: 329244672 02:51:33 INFO - PROCESS | 1643 | 02:51:35 INFO - PROCESS | 1643 | 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) 02:51:36 INFO - PROCESS | 1643 | RSS: Main: 330809344 02:51:36 INFO - PROCESS | 1643 | 02:51:39 INFO - PROCESS | 1643 | 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) 02:51:39 INFO - PROCESS | 1643 | RSS: Main: 330252288 02:51:39 INFO - PROCESS | 1643 | 02:51:41 INFO - PROCESS | 1643 | 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) 02:51:42 INFO - PROCESS | 1643 | RSS: Main: 303947776 02:51:42 INFO - PROCESS | 1643 | 02:51:44 INFO - PROCESS | 1643 | 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) 02:51:44 INFO - PROCESS | 1643 | RSS: Main: 304955392 02:51:44 INFO - PROCESS | 1643 | 02:51:46 INFO - PROCESS | 1643 | 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) 02:51:47 INFO - PROCESS | 1643 | RSS: Main: 307474432 02:51:47 INFO - PROCESS | 1643 | 02:51:50 INFO - PROCESS | 1643 | 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) 02:51:51 INFO - PROCESS | 1643 | RSS: Main: 324116480 02:51:51 INFO - PROCESS | 1643 | 02:51:54 INFO - PROCESS | 1643 | 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) 02:51:54 INFO - PROCESS | 1643 | RSS: Main: 318595072 02:51:54 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | 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) 02:51:56 INFO - PROCESS | 1643 | RSS: Main: 362811392 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | __start_tp_report 02:51:56 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 02:51:56 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 02:51:56 INFO - PROCESS | 1643 | |i|pagename|runs| 02:51:56 INFO - PROCESS | 1643 | |0;ai-astar;115;114;112;112;113;114;116;112;113;112 02:51:56 INFO - PROCESS | 1643 | |1;audio-beat-detection;145;109;109;146;110;120;109;107;129;110 02:51:56 INFO - PROCESS | 1643 | |2;audio-dft;186;180;186;184;207;261;184;183;181;183 02:51:56 INFO - PROCESS | 1643 | |3;audio-fft;80;59;58;86;58;58;60;72;104;82 02:51:56 INFO - PROCESS | 1643 | |4;audio-oscillator;85;71;107;99;98;78;83;69;69;83 02:51:56 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;89;88;91;83;89;95;89;86;89;85 02:51:56 INFO - PROCESS | 1643 | |6;imaging-darkroom;94;95;94;94;93;94;94;94;94;94 02:51:56 INFO - PROCESS | 1643 | |7;imaging-desaturate;86;87;87;87;88;86;87;87;88;87 02:51:56 INFO - PROCESS | 1643 | |8;json-parse-financial;54;55;56;55;54;56;54;54;55;56 02:51:56 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;65;74;78;72;74;70;72;70;70;72 02:51:56 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;89;88;87;86;88;89;86;88;87;91 02:51:56 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;146;157;149;156;144;158;151;147;182;152 02:51:56 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;174;171;174;175;179;170;173;174;172;174 02:51:56 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;71;61;60;69;84;85;85;86;66;67 02:51:56 INFO - PROCESS | 1643 | __end_tp_report 02:51:56 INFO - PROCESS | 1643 | __start_cc_report 02:51:56 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1972 02:51:56 INFO - PROCESS | 1643 | __end_cc_report 02:51:56 INFO - PROCESS | 1643 | __startTimestamp1484218316832__endTimestamp 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | ------- Summary: start ------- 02:51:56 INFO - PROCESS | 1643 | Number of tests: 14 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.42 (1.2%) stddev-sans-first:1.36 02:51:56 INFO - PROCESS | 1643 | Values: 115.0 114.0 112.0 112.0 113.0 114.0 116.0 112.0 113.0 112.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:115.00 stddev:15.31 (13.3%) stddev-sans-first:13.14 02:51:56 INFO - PROCESS | 1643 | Values: 145.0 109.0 109.0 146.0 110.0 120.0 109.0 107.0 129.0 110.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:193.50 Median:185.00 stddev:24.92 (13.5%) stddev-sans-first:26.29 02:51:56 INFO - PROCESS | 1643 | Values: 186.0 180.0 186.0 184.0 207.0 261.0 184.0 183.0 181.0 183.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:71.70 Median:66.00 stddev:15.93 (24.1%) stddev-sans-first:16.61 02:51:56 INFO - PROCESS | 1643 | Values: 80.0 59.0 58.0 86.0 58.0 58.0 60.0 72.0 104.0 82.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:83.00 stddev:13.36 (16.1%) stddev-sans-first:14.17 02:51:56 INFO - PROCESS | 1643 | Values: 85.0 71.0 107.0 99.0 98.0 78.0 83.0 69.0 69.0 83.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:3.31 (3.7%) stddev-sans-first:3.50 02:51:56 INFO - PROCESS | 1643 | Values: 89.0 88.0 91.0 83.0 89.0 95.0 89.0 86.0 89.0 85.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:51:56 INFO - PROCESS | 1643 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 02:51:56 INFO - PROCESS | 1643 | Values: 86.0 87.0 87.0 87.0 88.0 86.0 87.0 87.0 88.0 87.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 02:51:56 INFO - PROCESS | 1643 | Values: 54.0 55.0 56.0 55.0 54.0 56.0 54.0 54.0 55.0 56.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:3.40 (4.7%) stddev-sans-first:2.60 02:51:56 INFO - PROCESS | 1643 | Values: 65.0 74.0 78.0 72.0 74.0 70.0 72.0 70.0 70.0 72.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.56 02:51:56 INFO - PROCESS | 1643 | Values: 89.0 88.0 87.0 86.0 88.0 89.0 86.0 88.0 87.0 91.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:154.00 stddev:10.87 (7.1%) stddev-sans-first:11.12 02:51:56 INFO - PROCESS | 1643 | Values: 146.0 157.0 149.0 156.0 144.0 158.0 151.0 147.0 182.0 152.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:2.46 (1.4%) stddev-sans-first:2.60 02:51:56 INFO - PROCESS | 1643 | Values: 174.0 171.0 174.0 175.0 179.0 170.0 173.0 174.0 172.0 174.0 02:51:56 INFO - PROCESS | 1643 | 02:51:56 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:77.50 stddev:10.51 (13.6%) stddev-sans-first:11.11 02:51:56 INFO - PROCESS | 1643 | Values: 71.0 61.0 60.0 69.0 84.0 85.0 85.0 86.0 66.0 67.0 02:51:56 INFO - PROCESS | 1643 | -------- Summary: end -------- 02:51:56 INFO - PROCESS | 1643 | 02:51:57 INFO - TEST-INFO | 1643: exit 0 02:51:57 INFO - TEST-OK | kraken | took 59630ms 02:51:57 INFO - SUITE-END | took 1179s 02:51:57 INFO - Completed test suite (00:19:40) 02:51:57 INFO - javascript benchmark 02:51:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.436035873902, 3333.300006998531, 3334.116459138329, 3361.1429085583172, 3400.5409269748575, 5563.443655634444, 5612.270404847374, 5655.971720141399, 5709.029464990951, 5745.511631511321, 5657.9717101414435, 5708.914366284509, 5789.986752318338, 5816.185733997244, 5817.447342502455, 5107.0, 5118.692878427288, 5163.967206558685, 5220.3996540397775, 5276.1030624793875, 5279.815206467774, 5349.625526213166, 5357.169638705987, 5372.328458942632, 5404.054290499147, 5151.716655583941, 5277.261183434322, 5284.709340986245, 5298.549623282026, 5329.440408757083, 5186.222066689989, 5197.194434862602, 5219.530242278213, 5236.895262094737, 5246.554042906358, 4330.696851220416, 5226.712530810804, 5243.344581927259, 5253.816116435944, 5281.15501519755, 5717.714114294268, 5733.512651424592, 5753.510951569122, 5768.826935191951, 5777.768889244425, 6137.1444550974375, 6178.691065446755, 6180.443760061616, 6232.376762323776, 6319.304876463585, 6301.180846489973, 6308.968455157741, 6319.0837328587095, 6336.683165841736, 6362.395572420659, 5867.589268751147, 5935.970320148372, 5938.287405511323, 5941.643501389931, 5988.580799344091, 6253.824075133413, 6289.905651415233, 6317.052442133625, 6332.525060620472, 6351.301356850743, 6141.775567826927, 6142.78500252489, 6191.9690401547705, 6202.937970620326, 6264.310925798159, 5954.166416701665, 5998.340182579913, 6316.431521163117, 6355.523335749837, 6358.141650877073, 4968.72672003036, 5904.851906194771, 5929.911051334234, 5974.701264936736, 6000.729967151488, 5991.370906054802, 6005.309389420186, 6009.0, 6015.699215039231, 6027.7287522061615, 4882.902341953141, 4895.143349913751, 4898.53463920927, 4906.803727850846, 4911.091448082117, 4336.934945975813, 4337.869863904088, 4406.9559304407185, 4410.845620403271, 4422.911541769146, 5631.549476041907, 5804.912926306109, 5819.301683797887, 5827.650340979555, 5833.241678581757, 6204.162438070893, 6229.595076320024, 6232.0963460298, 6263.686815659199, 6286.654234017173, 5766.913496297559, 5816.185733997244, 5841.649501029867, 5853.414658534198, 5870.530357571384, 4700.318453824177, 5518.751656175482, 5542.057850165482, 5546.972265138648, 5552.888942221214, 6281.371862813682, 6320.178376810985, 6336.366363363627, 6361.332060133805, 6402.231732192166, 6274.654893980693, 6331.651759153291, 6341.175647165839, 6357.110004599267, 6364.490840732823, 6385.904211436925, 6404.199475065617, 6411.4870810336, 6429.485641148791, 6432.292447830829, 6041.486473649789, 6083.513318934386, 6225.28409232944, 6266.310705822447, 6302.621842689453, 6256.092866534418, 6269.185005949197, 6339.302676705651, 6348.682565871781, 6360.904586431115, 6015.0, 6132.816015519542, 6203.472704820141, 6216.595921265103, 6232.501399887908, 4794.8492361833605, 5697.829065128053, 6195.81412557624, 6199.783007594712, 6261.78083767066, 5931.258592675916, 5982.940170598413, 5987.161797348462, 6002.369751176064, 6120.479759220516, 6195.876082478415, 6228.56400051992, 6248.68756562161, 6262.279837818709, 6270.059491076375, 5875.823725288248, 5895.380984996514, 5900.085486749561, 5936.317323507852, 5940.1683764272175], "value": 5707.449784553173, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.88477880529865, 491.73446338976953, 494.6438564233755, 519.475329916784, 534.313407271656, 41487.0, 43533.34699979499, 43542.34686479705, 45470.31794523077, 45676.77161614196, 37026.629733702655, 44378.77810610951, 44926.32610510837, 45008.54991450084, 45060.0, 8343.874841877378, 9209.58556864941, 9409.0, 9423.246140308793, 9425.19885809707, 8298.792530186733, 11103.55585776572, 11373.033292170176, 11374.943125284362, 11577.247478913885, 11345.659630211065, 11407.315561066322, 11417.143714221425, 11418.657440276764, 11452.255603385795, 7030.894536581955, 11291.717707057307, 11317.547298108066, 11334.206605537616, 11354.545818167264, 8348.457350272274, 11030.944845275802, 11263.831042534286, 11289.548418063268, 11511.827322590168, 35125.82437087824, 42165.367519487234, 42580.57419425797, 42606.360904586145, 42624.14751704949, 3575.7496975211748, 4040.8181631826637, 4080.2451546463703, 4091.590840915914, 4098.83259212198, 25739.227823165336, 30616.8469157655, 31348.843255783577, 31832.429324868055, 31878.0, 3022.9546556801665, 3070.155707180521, 3230.4023755605053, 3297.7361811055057, 3345.1971526833386, 474316.99999999657, 478626.0, 478763.0, 484238.0, 486927.0, 64286.71426571442, 64490.35509644937, 66518.0, 66719.66640166768, 67083.66458167679, 70341.64829175924, 70463.0, 70479.2952070483, 70500.64749676219, 70690.2930970694, 16534.007959522467, 16757.24592393321, 16761.664766704598, 16763.99416035042, 16793.0, 10679.252452328417, 10855.348679079123, 12692.365381730877, 12803.231806091664, 12821.551245706356, 15405.691886162214, 17063.31746730142, 17642.318514350027, 19521.804781952, 19859.0, 6422.068800023971, 6625.204975402886, 7028.332308430691, 7085.964570177116, 7113.679884405215, 863.8488264553678, 887.5207388010402, 893.7497500699815, 916.6150216908915, 927.9907200928039, 30226.24434389158, 30688.396646412617, 30962.380752385277, 31085.844570777455, 31418.842905785325, 997.2221667099674, 1070.7430216747925, 1093.4642025407493, 1100.801855665988, 1101.493313075978, 13862.185476998617, 15281.847181528265, 15715.214239288218, 16284.348626055062, 16300.10349430769, 613609.0, 619856.0, 620496.0, 620676.0, 621412.0, 63772.0, 63793.0, 63925.36074639287, 64050.0, 64115.35884641187, 1426.3795249066688, 1462.6050966239056, 1468.9972108904442, 1483.8887083468999, 1486.947956821506, 27600.033998809944, 29531.0, 30037.849810750806, 30524.0, 31345.529817052306, 54638.72680636571, 54979.725101374235, 55022.0, 55067.0, 55071.0, 462880.0, 502812.0, 530088.0, 530987.0, 531232.3438382783, 25347.493050139263, 25919.74080259249, 26053.869730651226, 42795.786021069696, 43136.35295470633, 37432.0, 38103.0, 39833.80083099682, 44890.85763996489, 45109.32336014897, 31279.374412511166, 34075.0, 35248.47127293144, 35264.64735352614, 38724.0, 36755.81622091872, 36869.63130368662, 37167.8141609301, 38378.42432363573, 38403.0, 36162.638373615926, 36513.81743091268, 36795.44806827846, 36931.44602830906, 37297.440538391405, 31030.379392412477, 33017.606141515695, 33574.66425335813, 33763.987080387626, 33923.15192120217, 21111.15555377829, 24837.0, 24871.0, 24928.0, 25463.618045729698], "value": 20313.358114881576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1910448654635, 387.6511139974023, 392.85071672764343, 400.37741312259436, 422.5584264443656, 19411.70882436763, 21452.89273553634, 21757.564848703016, 21882.0, 22221.222257221, 20244.190232390723, 20815.687764683542, 20983.16067357304, 22208.222712205035, 22543.774562254373, 5323.893522129555, 6087.634741915477, 6121.449069583737, 6139.6009259398, 6139.846503837418, 4831.0, 5883.793822266446, 6003.729832157542, 6112.572119951606, 6121.510279177655, 6072.514198864103, 6098.908516372258, 6106.786262480814, 6107.328193898667, 6110.633361998272, 5437.151368534717, 5521.309836270466, 5585.441455854402, 6080.087986801993, 6094.756209751627, 5390.568754499631, 5395.217693434469, 5395.811146609889, 5396.217548455491, 5403.918941215846, 13569.1858488491, 14416.63958401038, 20227.494312642153, 23944.88027559851, 25370.619440708404, 2585.0, 2671.412289296352, 2685.717999610032, 2745.958810617842, 2790.9441811163665, 9692.41845489273, 10424.583016679324, 10469.528871200815, 10514.053735163796, 10568.418736969463, 1701.978812712375, 1748.7464317673994, 1789.8478629316523, 1823.0337920901943, 1825.6622524832815, 108494.0, 132920.7017403512, 137490.31254843663, 139673.0, 139695.0, 11359.545618175345, 11499.0, 11612.767744645229, 11770.058395328524, 12026.218295810744, 15807.762883556756, 15821.208939553206, 15822.920885395499, 15863.206839658202, 15872.44446444369, 7073.646317684095, 8471.407001509835, 8632.136786321318, 8666.176713212235, 8676.91323086761, 8377.539235342114, 8389.20302571267, 8566.828663426697, 8569.52867592276, 8594.828103437896, 4680.595821253611, 4795.345605766005, 4828.348172996671, 4833.275008748716, 4952.678075925053, 1987.8210961013579, 2018.5256464730776, 2019.7071424643639, 2020.222214447419, 2026.4832467720637, 1025.190099821133, 1040.9895901041043, 1045.25124706208, 1049.2235745548392, 1051.8790339110947, 17483.475495735147, 21738.0, 22266.888665556893, 23255.06979720792, 24544.631830522558, 882.4308321132834, 894.2979760887672, 918.6417297254076, 943.528235882059, 951.191487235844, 6175.320714721377, 6469.417752402306, 7012.298770122947, 7085.92914070863, 7234.855302894018, 657367.0, 669686.0, 676837.0, 683890.0, 684331.0, 139964.0, 143807.0, 145027.0, 147384.26307868393, 148535.0, 1045.3518818332682, 1056.2553399853084, 1078.3260462211117, 1083.7561548651647, 1084.2410312781085, 10304.690859274233, 12200.511979521074, 12455.501779928702, 12682.619521414372, 12699.0, 44189.0, 59162.81674366402, 61483.462913427524, 62970.166342515615, 63080.0, 68511.3148868505, 82565.17434825575, 85496.57251713701, 86704.56647716722, 93681.5315923416, 8282.461639993382, 8435.283000944743, 8455.281301089477, 8458.619362128597, 8671.4363566368, 10618.787624247627, 12983.610491685264, 13036.283004434847, 13309.600711978655, 13492.392842321922, 11125.499352529318, 11212.383318917538, 11392.316461012366, 11517.769644607228, 11524.539018439504, 11278.154138439486, 11374.374409407563, 11523.250988685708, 11725.120615954009, 11974.461149248478, 11276.661700149009, 11808.82286765682, 11830.585929492427, 11961.162718609614, 12130.696732581757, 8223.835523289621, 8243.340532757486, 8606.354523410895, 8704.78238044054, 8717.041125476318, 10033.749156271151, 10846.45767711627, 11052.0, 11118.944405277922, 11597.884021160018], "value": 9625.194438770062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.1287150480684, 1435.8635929586692, 1447.2835946206628, 1449.9855001449985, 1458.4895286649667, 6652.467802575795, 7415.777526674195, 7778.611069446526, 7790.143084260734, 7791.065072191331, 7611.429142814283, 8015.4389192756535, 8247.876281855762, 8249.257566818986, 8253.092159862425, 2312.6993490846166, 2342.0397636968846, 2342.496363281894, 2345.1909091363455, 2349.0721165139844, 2094.7276854008956, 2138.561594873055, 2161.5244646177894, 2184.3337781976493, 2352.2472808701223, 2121.7241758571363, 2244.236959433792, 2318.524702436005, 2328.1036800831635, 2330.5222429402015, 2283.680284760135, 2299.931002069932, 2312.42189452636, 2313.3869524576003, 2318.5131122464304, 2309.56118337517, 2326.674265602817, 2352.2472808701223, 2353.505763789606, 2355.6466530020634, 8223.465474744182, 8293.3365330774, 8298.419110662257, 8302.211289927447, 8302.418830681854, 4958.132326842788, 5156.819511317123, 5157.767900444452, 5157.9684063187515, 5160.483951604847, 3279.8360081995806, 3350.27968986669, 3529.082438565991, 3532.5937517185594, 3539.557555305587, 1207.4144040140525, 1224.5346768228105, 1244.5519612939336, 1249.2005116725304, 1278.6867217531765, 10781.0297073263, 10794.5682172713, 10807.783844323149, 10822.783544329148, 10834.187435942336, 4120.814563344657, 4382.452193475816, 4592.908141837144, 4692.0381321828945, 4724.244120940633, 9320.207782338577, 9358.15776580111, 9360.859587106199, 9363.531823408803, 9378.624855005859, 5120.283160357553, 5209.7916083356995, 5215.843524694265, 5221.947780522222, 5230.450802665741, 4631.160437342985, 4733.431988161443, 4738.289256611536, 4763.476017638126, 4766.904661906812, 3743.9064023399633, 3795.5635101963076, 3829.195868867569, 3879.903002424962, 3896.077941543842, 929.3179345384875, 1271.9109662323733, 1275.5344299330677, 1276.9680757980939, 1290.7547565962436, 790.9011373578303, 865.3293697384452, 878.5914549734404, 886.6763631274538, 945.9783433891381, 4715.6934799238625, 5282.0, 5395.109806881899, 5446.101393270145, 5451.536619387396, 991.1674193677345, 1004.9849252261222, 1009.3237530854345, 1033.7312298802215, 1061.3207547169818, 3526.894193174209, 3539.8053107078845, 3552.87564935226, 3617.819109044537, 3628.401313783196, 9517.191038761783, 9627.555866620063, 9641.084097010773, 9901.851472227921, 9930.950345248228, 9857.507124643738, 9862.654807081717, 9868.21054315653, 9876.506174691236, 9888.060634239735, 7704.075510938723, 7782.922170778333, 7789.610519474004, 7791.649375778104, 7805.0, 4375.453068366454, 5082.771275292546, 5228.45101264377, 5387.191921211849, 5537.8061767837935, 8996.775080623036, 9090.727278181665, 9091.181793638605, 9174.67888623895, 9193.954030229806, 9127.178553929913, 9152.359334846496, 9275.350725449154, 9319.021502742115, 9332.853443708122, 6877.65611719422, 6952.200496942916, 7043.612601306977, 7043.964780176067, 7048.647567621496, 6280.089387038763, 7670.884936725842, 7721.498102623312, 7744.728934487492, 7756.650950707344, 6101.725422356093, 7051.753188638373, 7106.964465177641, 7133.678984445816, 7160.176579693402, 6843.8973415399805, 6896.310368963264, 6922.342377474333, 6946.826329341605, 6964.965175174092, 6117.296510901303, 6250.3749625037135, 6251.0, 6252.030935205051, 6254.8123556293385, 4778.996410753781, 4875.512448755097, 4933.4819843915875, 4936.086823937583, 4940.333055037524, 4836.685615434985, 4863.2461968394955, 4958.132326842716, 5079.034983353151, 5084.186530155157], "value": 4356.997580956678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.32772748595215, 353.7258624565962, 364.5716283367044, 371.11118870305603, 373.5274877280241, 5054.003668550925, 5297.622618119288, 5470.8085217017415, 5493.791365899496, 5502.046773395447, 4780.561913424152, 5224.373075230968, 5396.872970677852, 5443.292371991645, 5446.0, 3198.6001749781276, 3897.6480227004754, 4131.7934103294865, 4160.771157586331, 4168.916621667572, 2954.4932084636775, 3969.4870040014653, 4092.6521245694003, 4123.577365808791, 4141.420201171838, 3461.0, 4081.9387709184384, 4095.488063992001, 4102.651274641644, 4129.881939135948, 3933.5476420211758, 4028.0735430850777, 4079.4084857695616, 4089.754614723126, 4131.814068366931, 3136.623605167372, 3545.7340699447645, 3548.7870727756417, 3562.340966921128, 3564.376234159012, 4486.528914463967, 5114.590832733373, 5155.814162742553, 5342.252084708144, 5381.192821076831, 4530.79611417487, 4683.976580117112, 4694.201985662446, 4701.835435759766, 4732.171869922784, 5281.445448227958, 5521.923224971132, 5769.769209231667, 5777.653340799523, 5794.855128621776, 3487.808170550619, 3899.961000389988, 3915.843366265346, 3922.235164142993, 3923.1761330120707, 5488.4237155098535, 5742.712864356766, 5755.568332375088, 6045.33501314855, 6099.48154406876, 3909.882703518899, 3942.7634341939574, 3953.1303113315025, 3978.5822488638855, 3981.3629819228786, 3890.2219556088894, 3909.159530700856, 4035.3455083416247, 4049.230646177217, 4060.725993443681, 4262.4458820353775, 4328.523862375199, 4597.804570811613, 4683.765811709401, 4711.7879695413785, 4566.383538222364, 5810.244668193108, 5819.709014549256, 5905.405540504125, 5927.525797936155, 1227.4844565282424, 1294.5145570411096, 1311.7507673541998, 1320.7886738121854, 1330.447864136392, 800.9639566219535, 805.9884844520207, 868.4702331577732, 876.6274333408403, 890.857462805961, 4322.487129504711, 5166.560842328444, 5233.502817232356, 5241.842744717665, 5260.868478288074, 5041.840376713377, 5059.0, 5295.6557823742105, 5576.375356018621, 5670.943290567124, 4792.784324705397, 4873.832009194052, 4971.875703107451, 5334.066263555107, 5353.437889021675, 2516.5596020696303, 2790.7999560189314, 2827.1518544436585, 2867.777472458861, 3002.609660744089, 5290.497402746733, 5431.8098866539485, 5469.316335458067, 5562.499375056183, 5876.0, 4906.975465122651, 4948.931662369354, 5138.76463738275, 5560.249366335493, 5819.505342045889, 4876.951230487721, 5135.974320128375, 5634.816688495462, 5863.589548731633, 5960.970195149083, 4971.726555039508, 5568.331800184003, 5570.498655121059, 5616.680080181072, 5700.380258535943, 4940.209566469348, 5167.302414174038, 5221.738913054256, 5327.9733601331745, 5426.891462170814, 4849.733264670477, 5044.848654540369, 5272.868178295574, 5878.0, 5890.204822348928, 3152.590163278759, 3273.738100951966, 3555.911102222465, 3713.8143092844707, 3735.4210097434943, 5146.639735218499, 5478.506934375925, 5681.0, 5696.686682232517, 5699.23060386859, 5287.339082614673, 5440.564754819684, 5444.26502422168, 5493.0, 5522.282103326542, 5124.948750512447, 5340.787264351788, 5452.745868450199, 5474.781008759605, 5479.53423958952, 4430.446194225722, 4956.653034287565, 4983.700977941335, 5287.118520406465, 5366.436524164907, 4606.677532572822, 4982.501749824988, 5426.511613954763, 5428.064653126609, 5602.0, 4917.0, 5102.387713474407, 5445.428230035789, 5603.523700485504, 5620.213170156263], "value": 4064.4436299441372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8812195987659, 720.8702433561957, 778.7507997440821, 823.9423240373173, 832.7043899415708, 14179.716405671881, 14606.342714577842, 14720.190389528585, 14843.332050057747, 15658.98216615922, 14316.35576399062, 14626.48807291745, 14630.268486575655, 14649.26753662318, 15176.620584485394, 846.2722059029245, 877.4209022045451, 878.2578720980792, 878.3982971664399, 879.5997820991465, 682.0825989044727, 705.9435245180373, 710.030807947151, 866.3588944181323, 869.1178453869328, 886.8891388576428, 910.4537277633433, 918.3433844800966, 921.2031592672324, 921.8340698674236, 910.0, 911.2163539356148, 911.5260064766351, 911.5260064766351, 912.9908700912972, 525.1938274748243, 540.5513423858188, 681.8908974564096, 684.0423407229869, 687.0484379134884, 14862.851371486255, 15411.22943852803, 15481.5355539334, 15736.134512601802, 15760.290786914502, 13965.371558279901, 14032.087914285641, 14055.297235138201, 14073.15561066329, 14075.36660850254, 10717.588542577936, 11725.530978760838, 12209.755804883942, 12251.877481225252, 12443.066769992287, 3578.284343131384, 3680.4479328100733, 3688.409854423306, 3753.7935413552245, 3777.8866634001024, 103303.0, 110686.78626427507, 111586.32620510699, 111793.0, 112435.43782281117, 10448.178991672206, 10865.619703310345, 10899.237053406185, 10995.0, 11113.944430277797, 22309.0, 22313.99587018588, 22316.553668926532, 22320.0, 22372.776272237395, 7575.772726818204, 7591.278828511283, 7609.239076092346, 7769.922300777033, 7776.027996500437, 4313.137372525444, 4338.197433474817, 4350.282203436397, 4381.583749543788, 4503.819847206075, 3445.707114895212, 3493.0, 3497.772644778132, 3525.94711079334, 3533.9293214135573, 633.2527617411498, 643.0707627478249, 648.5654611410366, 653.5098675993005, 653.7548419342746, 621.2979333353281, 646.8285904235381, 654.2051407539861, 666.6600033982704, 679.2663922963188, 9463.905360946303, 9552.044795520393, 9676.225901927828, 10125.392476451436, 10422.374657520573, 584.6492104737209, 593.2376895689105, 603.6649659439054, 614.0666187395224, 615.8768246350747, 4618.930716039262, 4995.350604421402, 5001.174806157016, 5002.374703162105, 5008.29883816266, 103574.0, 103943.0, 104729.0, 105853.0, 106048.0, 89700.6544901827, 89857.0, 90502.0, 90955.99999999868, 91430.54284728666, 67520.0, 77624.0, 79410.6029469849, 80522.19477805147, 80811.19188808037, 9828.673129127475, 9829.115379615869, 9841.409515429097, 10051.69844904654, 10352.275340726379, 42891.356629649956, 43967.78016109899, 45054.3241851366, 47003.0, 48236.27645585389, 60589.394106058375, 62079.0, 62415.37584624095, 67741.66129169322, 68002.0, 11839.467223974769, 12556.183848049848, 13141.014423918054, 13154.539591114648, 13182.802257965946, 13981.370838312503, 14441.114773748792, 14483.275836208359, 14786.482473113389, 15533.45632902843, 13550.0, 13646.459238106854, 13723.313834308045, 13894.652633684238, 14024.929875350557, 13559.59321220365, 13939.303034848419, 14035.649108772363, 14067.09887837095, 14210.360533775798, 12250.938745306217, 13073.215607063607, 13530.391132398869, 13701.177929323874, 13706.451741930212, 10444.265023972763, 10702.625408110678, 10890.945545272223, 10926.604273423396, 11226.66320010401, 10289.897101028893, 10844.45777711127, 10990.560377584807, 11014.229003969645, 11070.557177713123], "value": 7457.220379953021, "unit": "score"}], "name": "dromaeo_css", "value": 7267.882967795556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 112.0, 112.0, 113.0, 114.0, 116.0, 112.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 109.0, 146.0, 110.0, 120.0, 109.0, 107.0, 129.0, 110.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 180.0, 186.0, 184.0, 207.0, 261.0, 184.0, 183.0, 181.0, 183.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 86.0, 58.0, 58.0, 60.0, 72.0, 104.0, 82.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 107.0, 99.0, 98.0, 78.0, 83.0, 69.0, 69.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 91.0, 83.0, 89.0, 95.0, 89.0, 86.0, 89.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 87.0, 88.0, 86.0, 87.0, 87.0, 88.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 54.0, 56.0, 54.0, 54.0, 55.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 78.0, 72.0, 74.0, 70.0, 72.0, 70.0, 70.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 86.0, 88.0, 89.0, 86.0, 88.0, 87.0, 91.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 157.0, 149.0, 156.0, 144.0, 158.0, 151.0, 147.0, 182.0, 152.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 174.0, 175.0, 179.0, 170.0, 173.0, 174.0, 172.0, 174.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 61.0, 60.0, 69.0, 84.0, 85.0, 85.0, 86.0, 66.0, 67.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1467.2, "alertThreshold": 2.0}]} 02:51:58 INFO - Return code: 0 02:51:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:51:58 INFO - # TBPL SUCCESS # 02:51:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:51:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:51:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:51:58 INFO - 2017-01-12 02:51:58.153 screenresolution[1647:10044] starting screenresolution argv=screenresolution get 02:51:58 INFO - 2017-01-12 02:51:58.156 screenresolution[1647:10044] Display 0: 1600x1200x32@60 02:51:58 INFO - 2017-01-12 02:51:58.162 screenresolution[1648:10047] starting screenresolution argv=screenresolution list 02:51:58 INFO - Available Modes on Display 0 02:51:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:51:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:51:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:51:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:51:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:51:58 INFO - Intel Iris: 02:51:58 INFO - Chipset Model: Intel Iris 02:51:58 INFO - Type: GPU 02:51:58 INFO - Bus: Built-In 02:51:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:51:58 INFO - Vendor: Intel (0x8086) 02:51:58 INFO - Device ID: 0x0a2e 02:51:58 INFO - Revision ID: 0x0009 02:51:58 INFO - Displays: 02:51:58 INFO - Display: 02:51:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:51:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:51:58 INFO - Display Serial Number: 1600x1200 60 02:51:58 INFO - Main Display: Yes 02:51:58 INFO - Mirror: Off 02:51:58 INFO - Online: Yes 02:51:58 INFO - Rotation: Supported 02:51:58 INFO - Return code: 0 02:51:58 INFO - Running post-action listener: _resource_record_post_action 02:51:58 INFO - [mozharness: 2017-01-12 10:51:58.397480Z] Finished run-tests step (success) 02:51:58 INFO - Running post-run listener: _resource_record_post_run 02:51:58 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38654976; Write bytes: 550681088; Read time: 379; Write time: 3147 02:51:58 INFO - TinderboxPrint: CPU usage
53.8% 02:51:58 INFO - TinderboxPrint: I/O read bytes / time
38,654,976 / 379 02:51:58 INFO - TinderboxPrint: I/O write bytes / time
550,681,088 / 3,147 02:51:58 INFO - TinderboxPrint: CPU idle
2,221.2 (46.2%) 02:51:58 INFO - TinderboxPrint: CPU system
962.4 (20.0%) 02:51:58 INFO - TinderboxPrint: CPU user
1,626.1 (33.8%) 02:51:58 INFO - TinderboxPrint: Swap in / out
288,473,088 / 0 02:51:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250731008; Write bytes: 245467136; Read time: 18168; Write time: 496 02:51:58 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34534400; Write bytes: 295846400; Read time: 344; Write time: 2613 02:51:58 INFO - Running post-run listener: _upload_blobber_files 02:51:58 INFO - Blob upload gear active. 02:51:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:58 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 02:51:58 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'] 02:51:58 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 02:51:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:00 INFO - (blobuploader) - INFO - Done attempting. 02:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:01 INFO - (blobuploader) - INFO - Done attempting. 02:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:02 INFO - (blobuploader) - INFO - Done attempting. 02:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:05 INFO - (blobuploader) - INFO - Done attempting. 02:52:05 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:05 INFO - Return code: 0 02:52:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b37c5096b02611bdbb9fdb5206ee0142698b19592013e7bfabf5b0d3db2b0182c6f9f192404ca18d865549faa6fce4e65a797e94358d6aed7e65d373ad8f17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a07f4040132e269f517032b473be81962bfa605db45796757f94c85dcaa4271a5147dfb2f808f1ab797bae5b4b435156a4315582dfb7cad2d14ea2d09a09f82e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e6ee9fd0844dc811d86cfcf7cbea207906357d7ff2d70caaa613525f825c9050dfb1240b099c99a6589bea8da7f0c44298f8f3226d6ef243cf3fddae9cfa39d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a50d9d2510aea99c0b9abf60d7273da2b04adea21133b78440c126061ecde084a69cc9beb581ca8439b9baf974b442d3afc709c21a7df48cd84752275af57a6"} 02:52:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:05 INFO - Contents: 02:52:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2b37c5096b02611bdbb9fdb5206ee0142698b19592013e7bfabf5b0d3db2b0182c6f9f192404ca18d865549faa6fce4e65a797e94358d6aed7e65d373ad8f17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a07f4040132e269f517032b473be81962bfa605db45796757f94c85dcaa4271a5147dfb2f808f1ab797bae5b4b435156a4315582dfb7cad2d14ea2d09a09f82e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e6ee9fd0844dc811d86cfcf7cbea207906357d7ff2d70caaa613525f825c9050dfb1240b099c99a6589bea8da7f0c44298f8f3226d6ef243cf3fddae9cfa39d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a50d9d2510aea99c0b9abf60d7273da2b04adea21133b78440c126061ecde084a69cc9beb581ca8439b9baf974b442d3afc709c21a7df48cd84752275af57a6"} 02:52:05 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:05 INFO - Copying logs to upload dir... 02:52:05 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.442052 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 02:52:05.104599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:52:05.107783) ========= 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.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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/b2b37c5096b02611bdbb9fdb5206ee0142698b19592013e7bfabf5b0d3db2b0182c6f9f192404ca18d865549faa6fce4e65a797e94358d6aed7e65d373ad8f17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a07f4040132e269f517032b473be81962bfa605db45796757f94c85dcaa4271a5147dfb2f808f1ab797bae5b4b435156a4315582dfb7cad2d14ea2d09a09f82e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e6ee9fd0844dc811d86cfcf7cbea207906357d7ff2d70caaa613525f825c9050dfb1240b099c99a6589bea8da7f0c44298f8f3226d6ef243cf3fddae9cfa39d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a50d9d2510aea99c0b9abf60d7273da2b04adea21133b78440c126061ecde084a69cc9beb581ca8439b9baf974b442d3afc709c21a7df48cd84752275af57a6"} build_url:https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011101 build_url: 'https://queue.taskcluster.net/v1/task/MPCsSl3IRLCWDjPs1QfhlA/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/b2b37c5096b02611bdbb9fdb5206ee0142698b19592013e7bfabf5b0d3db2b0182c6f9f192404ca18d865549faa6fce4e65a797e94358d6aed7e65d373ad8f17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a07f4040132e269f517032b473be81962bfa605db45796757f94c85dcaa4271a5147dfb2f808f1ab797bae5b4b435156a4315582dfb7cad2d14ea2d09a09f82e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e6ee9fd0844dc811d86cfcf7cbea207906357d7ff2d70caaa613525f825c9050dfb1240b099c99a6589bea8da7f0c44298f8f3226d6ef243cf3fddae9cfa39d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a50d9d2510aea99c0b9abf60d7273da2b04adea21133b78440c126061ecde084a69cc9beb581ca8439b9baf974b442d3afc709c21a7df48cd84752275af57a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:52:05.142371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:52:05.142720) ========= 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.RpiUNFjFj2/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.sDewczFlom/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.004999 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:52:05.191293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:52:05.191627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:52:05.192010) ========= ========= Total master_lag: 0.19 =========