builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1490806534.29 results: success (0) buildid: 20170329081422 builduid: ac3f998ae9e0442c951fab7d3caf995b revision: ce2c39b33751ec2394a4810892089c4764da9e60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.288465) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.311706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.312123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.340241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.340639) ========= 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.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-29 09:55:34-- 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% 171M=0s 2017-03-29 09:55:34 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.490153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.490468) ========= 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.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.025918 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:34.538514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 09:55:34.538888) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce2c39b33751ec2394a4810892089c4764da9e60 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce2c39b33751ec2394a4810892089c4764da9e60 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-29 09:55:34,659 truncating revision to first 12 chars 2017-03-29 09:55:34,659 Setting DEBUG logging. 2017-03-29 09:55:34,659 attempt 1/10 2017-03-29 09:55:34,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce2c39b33751?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 09:55:36,454 unpacking tar archive at: mozilla-aurora-ce2c39b33751/testing/mozharness/ program finished with exit code 0 elapsedTime=2.373515 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 09:55:36.944488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:36.944824) ========= script_repo_revision: ce2c39b33751ec2394a4810892089c4764da9e60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:36.945244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:36.945511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 09:55:36.965168) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-29 09:55:36.965505) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:55:37 INFO - MultiFileLogger online at 20170329 09:55:37 in /builds/slave/test 09:55:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:55:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:37 INFO - {'append_to_log': False, 09:55:37 INFO - 'base_work_dir': '/builds/slave/test', 09:55:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:55:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:37 INFO - 'branch': 'Mozilla-Aurora', 09:55:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:37 INFO - 'config_files': ('talos/mac_config.py',), 09:55:37 INFO - 'default_actions': ('clobber', 09:55:37 INFO - 'read-buildbot-config', 09:55:37 INFO - 'download-and-extract', 09:55:37 INFO - 'populate-webroot', 09:55:37 INFO - 'create-virtualenv', 09:55:37 INFO - 'install', 09:55:37 INFO - 'run-tests'), 09:55:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:37 INFO - 'download_minidump_stackwalk': True, 09:55:37 INFO - 'download_symbols': 'ondemand', 09:55:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:37 INFO - 'gecko_profile': False, 09:55:37 INFO - 'gecko_profile_interval': 0, 09:55:37 INFO - 'installer_path': 'installer.exe', 09:55:37 INFO - 'log_level': 'info', 09:55:37 INFO - 'log_name': 'talos', 09:55:37 INFO - 'log_to_console': True, 09:55:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:55:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:55:37 INFO - 'opt_config_files': (), 09:55:37 INFO - 'pip_index': False, 09:55:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:37 INFO - 'cmd': ('bash', 09:55:37 INFO - '-c', 09:55:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:37 INFO - 'enabled': True, 09:55:37 INFO - 'halt_on_failure': False, 09:55:37 INFO - 'name': 'check_screen_resolution'},), 09:55:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:37 INFO - 'cmd': ('bash', 09:55:37 INFO - '-c', 09:55:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:37 INFO - 'enabled': True, 09:55:37 INFO - 'halt_on_failure': False, 09:55:37 INFO - 'name': 'check_screen_resolution'},), 09:55:37 INFO - 'run_cmd_checks_enabled': True, 09:55:37 INFO - 'suite': 'dromaeojs', 09:55:37 INFO - 'system_bits': '32', 09:55:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:37 INFO - 'title': 't-yosemite-r7-0375', 09:55:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:37 INFO - 'use_talos_json': True, 09:55:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:37 INFO - 'work_dir': 'build'} 09:55:37 INFO - [mozharness: 2017-03-29 16:55:37.186333Z] Running clobber step. 09:55:37 INFO - Running pre-action listener: _resource_record_pre_action 09:55:37 INFO - Running main action method: clobber 09:55:37 INFO - rmtree: /builds/slave/test/build 09:55:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:39 INFO - Running post-action listener: _resource_record_post_action 09:55:39 INFO - [mozharness: 2017-03-29 16:55:39.657020Z] Finished clobber step (success) 09:55:39 INFO - [mozharness: 2017-03-29 16:55:39.657101Z] Running read-buildbot-config step. 09:55:39 INFO - Running pre-action listener: _resource_record_pre_action 09:55:39 INFO - Running main action method: read_buildbot_config 09:55:39 INFO - Using buildbot properties: 09:55:39 INFO - { 09:55:39 INFO - "project": "", 09:55:39 INFO - "product": "firefox", 09:55:39 INFO - "script_repo_revision": "production", 09:55:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:55:39 INFO - "repository": "", 09:55:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:55:39 INFO - "buildid": "20170329081422", 09:55:39 INFO - "pgo_build": "False", 09:55:39 INFO - "basedir": "/builds/slave/test", 09:55:39 INFO - "buildnumber": 12, 09:55:39 INFO - "slavename": "t-yosemite-r7-0375", 09:55:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:55:39 INFO - "platform": "yosemite_r7", 09:55:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:55:39 INFO - "branch": "mozilla-aurora", 09:55:39 INFO - "repo_path": "releases/mozilla-aurora", 09:55:39 INFO - "revision": "ce2c39b33751ec2394a4810892089c4764da9e60", 09:55:39 INFO - "stage_platform": "macosx64", 09:55:39 INFO - "builduid": "ac3f998ae9e0442c951fab7d3caf995b", 09:55:39 INFO - "slavebuilddir": "test" 09:55:39 INFO - } 09:55:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:55:39 INFO - Running post-action listener: _resource_record_post_action 09:55:39 INFO - [mozharness: 2017-03-29 16:55:39.662688Z] Finished read-buildbot-config step (success) 09:55:39 INFO - [mozharness: 2017-03-29 16:55:39.662904Z] Running download-and-extract step. 09:55:39 INFO - Running pre-action listener: _resource_record_pre_action 09:55:39 INFO - Running main action method: download_and_extract 09:55:39 INFO - mkdir: /builds/slave/test/build/tests 09:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:39 INFO - trying https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:39 INFO - Downloading https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:55:41 INFO - Downloaded 1199 bytes. 09:55:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:41 INFO - Using the following test package requirements: 09:55:41 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:41 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:55:41 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:55:41 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'jsshell-mac.zip'], 09:55:41 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:55:41 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:41 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:55:41 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:55:41 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:55:41 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:41 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:55:41 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:55:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:42 INFO - Expected file size: 51791591 09:55:42 INFO - Obtained file size: 51791591 09:55:58 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:58 INFO - Fetch https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:59 INFO - Expected file size: 51791591 09:55:59 INFO - Obtained file size: 51791591 09:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:56:14 INFO - Fetch https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:56:15 INFO - Expected file size: 14404438 09:56:15 INFO - Obtained file size: 14404438 09:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:15 INFO - trying https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:56:17 INFO - Downloaded 74688152 bytes. 09:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:17 INFO - mkdir: /builds/slave/test/properties 09:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:17 INFO - Contents: 09:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:56:18 INFO - Running post-action listener: _resource_record_post_action 09:56:18 INFO - Running post-action listener: set_extra_try_arguments 09:56:18 INFO - [mozharness: 2017-03-29 16:56:18.511508Z] Finished download-and-extract step (success) 09:56:18 INFO - [mozharness: 2017-03-29 16:56:18.511659Z] Running populate-webroot step. 09:56:18 INFO - Running pre-action listener: _resource_record_pre_action 09:56:18 INFO - Running main action method: populate_webroot 09:56:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:18 INFO - '--tppagecycles', 09:56:18 INFO - '7'], 09:56:18 INFO - 'tests': ['tsvgm']}}, 09:56:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['damp', 'tps']}, 09:56:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'tests': ['damp', 'tps']}, 09:56:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['dromaeo_dom']}, 09:56:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['basic_compositor_video']}, 09:56:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:56:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['a11yr', 09:56:18 INFO - 'ts_paint', 09:56:18 INFO - 'tpaint', 09:56:18 INFO - 'sessionrestore', 09:56:18 INFO - 'sessionrestore_no_auto_restore', 09:56:18 INFO - 'tabpaint']}, 09:56:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['tsvgx', 09:56:18 INFO - 'tsvgr_opacity', 09:56:18 INFO - 'tart', 09:56:18 INFO - 'tscrollx', 09:56:18 INFO - 'cart', 09:56:18 INFO - 'tsvg_static']}, 09:56:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:18 INFO - 'tsvgr_opacity', 09:56:18 INFO - 'tart', 09:56:18 INFO - 'tscrollx', 09:56:18 INFO - 'cart', 09:56:18 INFO - 'tsvg_static']}, 09:56:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'talos_options': ['--disable-e10s'], 09:56:18 INFO - 'tests': ['tp5o']}, 09:56:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:56:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'talos_options': ['--disable-e10s', 09:56:18 INFO - '--xperf_path', 09:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:18 INFO - 'tests': ['tp5n']}, 09:56:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:56:18 INFO - 'talos_options': ['--xperf_path', 09:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:18 INFO - 'tests': ['tp5n']}}, 09:56:18 INFO - 'talos.zip': {'path': '', 09:56:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:18 INFO - Running post-action listener: _resource_record_post_action 09:56:18 INFO - [mozharness: 2017-03-29 16:56:18.530425Z] Finished populate-webroot step (success) 09:56:18 INFO - [mozharness: 2017-03-29 16:56:18.530553Z] Running create-virtualenv step. 09:56:18 INFO - Running pre-action listener: _resource_record_pre_action 09:56:18 INFO - Running main action method: create_virtualenv 09:56:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:56:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:18 INFO - Using real prefix '/tools/python27' 09:56:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:22 INFO - Installing pip.................done. 09:56:22 INFO - Return code: 0 09:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:56:22 INFO - Reading from file tmpfile_stdout 09:56:22 INFO - Output received: 09:56:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:22 INFO - 'HOME': '/Users/cltbld', 09:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:22 INFO - 'LOGNAME': 'cltbld', 09:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:22 INFO - 'MOZ_NO_REMOTE': '1', 09:56:22 INFO - 'NO_EM_RESTART': '1', 09:56:22 INFO - 'PAGER': '/bin/cat', 09:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:22 INFO - 'PWD': '/builds/slave/test', 09:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:22 INFO - 'SHELL': '/bin/bash', 09:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:22 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:22 INFO - 'USER': 'cltbld', 09:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:22 INFO - 'XPC_FLAGS': '0x0', 09:56:22 INFO - 'XPC_SERVICE_NAME': '0', 09:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:56:22 INFO - Cleaning up... 09:56:22 INFO - Return code: 0 09:56:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:22 INFO - 'HOME': '/Users/cltbld', 09:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:22 INFO - 'LOGNAME': 'cltbld', 09:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:22 INFO - 'MOZ_NO_REMOTE': '1', 09:56:22 INFO - 'NO_EM_RESTART': '1', 09:56:22 INFO - 'PAGER': '/bin/cat', 09:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:22 INFO - 'PWD': '/builds/slave/test', 09:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:22 INFO - 'SHELL': '/bin/bash', 09:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:22 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:22 INFO - 'USER': 'cltbld', 09:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:22 INFO - 'XPC_FLAGS': '0x0', 09:56:22 INFO - 'XPC_SERVICE_NAME': '0', 09:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:23 INFO - Downloading/unpacking psutil>=3.1.1 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:26 INFO - Installing collected packages: psutil 09:56:26 INFO - Running setup.py install for psutil 09:56:26 INFO - building 'psutil._psutil_osx' extension 09:56:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:56:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:56:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:56:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:56:27 INFO - building 'psutil._psutil_posix' extension 09:56:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:56:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:56:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:56:27 INFO - ^ 09:56:27 INFO - 1 warning generated. 09:56:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:56:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:27 INFO - Successfully installed psutil 09:56:27 INFO - Cleaning up... 09:56:27 INFO - Return code: 0 09:56:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:56:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:28 INFO - 'HOME': '/Users/cltbld', 09:56:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:28 INFO - 'LOGNAME': 'cltbld', 09:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:28 INFO - 'MOZ_NO_REMOTE': '1', 09:56:28 INFO - 'NO_EM_RESTART': '1', 09:56:28 INFO - 'PAGER': '/bin/cat', 09:56:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:28 INFO - 'PWD': '/builds/slave/test', 09:56:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:28 INFO - 'SHELL': '/bin/bash', 09:56:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:28 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:28 INFO - 'USER': 'cltbld', 09:56:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:28 INFO - 'XPC_FLAGS': '0x0', 09:56:28 INFO - 'XPC_SERVICE_NAME': '0', 09:56:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:31 INFO - Installing collected packages: mozsystemmonitor 09:56:31 INFO - Running setup.py install for mozsystemmonitor 09:56:32 INFO - Successfully installed mozsystemmonitor 09:56:32 INFO - Cleaning up... 09:56:32 INFO - Return code: 0 09:56:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:32 INFO - 'HOME': '/Users/cltbld', 09:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:32 INFO - 'LOGNAME': 'cltbld', 09:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:32 INFO - 'MOZ_NO_REMOTE': '1', 09:56:32 INFO - 'NO_EM_RESTART': '1', 09:56:32 INFO - 'PAGER': '/bin/cat', 09:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:32 INFO - 'PWD': '/builds/slave/test', 09:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:32 INFO - 'SHELL': '/bin/bash', 09:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:32 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:32 INFO - 'USER': 'cltbld', 09:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:32 INFO - 'XPC_FLAGS': '0x0', 09:56:32 INFO - 'XPC_SERVICE_NAME': '0', 09:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:32 INFO - Downloading/unpacking jsonschema==2.5.1 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:35 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:35 INFO - warning: no files found matching '*.txt' 09:56:35 INFO - no previously-included directories found matching 'build' 09:56:35 INFO - no previously-included directories found matching 'dist' 09:56:35 INFO - no previously-included directories found matching '.git*' 09:56:35 INFO - Installing collected packages: jsonschema, functools32 09:56:35 INFO - Running setup.py install for functools32 09:56:35 INFO - warning: no files found matching '*.txt' 09:56:35 INFO - no previously-included directories found matching 'build' 09:56:35 INFO - no previously-included directories found matching 'dist' 09:56:35 INFO - no previously-included directories found matching '.git*' 09:56:35 INFO - Successfully installed jsonschema functools32 09:56:35 INFO - Cleaning up... 09:56:35 INFO - Return code: 0 09:56:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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', '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 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:56: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 functools32==3.2.3-2 09:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:35 INFO - 'HOME': '/Users/cltbld', 09:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:35 INFO - 'LOGNAME': 'cltbld', 09:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:35 INFO - 'MOZ_NO_REMOTE': '1', 09:56:35 INFO - 'NO_EM_RESTART': '1', 09:56:35 INFO - 'PAGER': '/bin/cat', 09:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:35 INFO - 'PWD': '/builds/slave/test', 09:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:35 INFO - 'SHELL': '/bin/bash', 09:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:35 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:35 INFO - 'USER': 'cltbld', 09:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:35 INFO - 'XPC_FLAGS': '0x0', 09:56:35 INFO - 'XPC_SERVICE_NAME': '0', 09:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:56:36 INFO - Cleaning up... 09:56:36 INFO - Return code: 0 09:56:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:36 INFO - 'HOME': '/Users/cltbld', 09:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PAGER': '/bin/cat', 09:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:36 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - 'XPC_FLAGS': '0x0', 09:56:36 INFO - 'XPC_SERVICE_NAME': '0', 09:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:40 INFO - Downloading docopt-0.6.1.tar.gz 09:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:40 INFO - Running setup.py install for blobuploader 09:56:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:40 INFO - Running setup.py install for requests 09:56:41 INFO - Running setup.py install for docopt 09:56:41 INFO - Successfully installed blobuploader requests docopt 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:41 INFO - 'HOME': '/Users/cltbld', 09:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PAGER': '/bin/cat', 09:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test', 09:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:41 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - 'XPC_FLAGS': '0x0', 09:56:41 INFO - 'XPC_SERVICE_NAME': '0', 09:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:41 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-iKMo0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:41 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ZqpZco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:41 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-heZcOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:41 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xHZryW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1SqaQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-KqzCUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-GiVUaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-uEqptc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dEf25g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zN3Lf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-op4fsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-r5qMoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-mc6TRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-31t7ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6CiMth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YRTfnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Ie37Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:43 INFO - Running setup.py install for manifestparser 09:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:43 INFO - Running setup.py install for mozcrash 09:56:43 INFO - Running setup.py install for mozdebug 09:56:43 INFO - Running setup.py install for mozdevice 09:56:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozfile 09:56:44 INFO - Running setup.py install for mozhttpd 09:56:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozinfo 09:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozInstall 09:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for mozleak 09:56:44 INFO - Running setup.py install for mozlog 09:56:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:44 INFO - Running setup.py install for moznetwork 09:56:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozprocess 09:56:45 INFO - Running setup.py install for mozprofile 09:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozrunner 09:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Running setup.py install for mozscreenshot 09:56:45 INFO - Running setup.py install for moztest 09:56:45 INFO - Running setup.py install for mozversion 09:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:45 INFO - Cleaning up... 09:56:45 INFO - Return code: 0 09:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 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 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:45 INFO - 'HOME': '/Users/cltbld', 09:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:45 INFO - 'LOGNAME': 'cltbld', 09:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:45 INFO - 'MOZ_NO_REMOTE': '1', 09:56:45 INFO - 'NO_EM_RESTART': '1', 09:56:45 INFO - 'PAGER': '/bin/cat', 09:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:45 INFO - 'PWD': '/builds/slave/test', 09:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:45 INFO - 'SHELL': '/bin/bash', 09:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:45 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:45 INFO - 'USER': 'cltbld', 09:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:45 INFO - 'XPC_FLAGS': '0x0', 09:56:45 INFO - 'XPC_SERVICE_NAME': '0', 09:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-k1o5Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-_Nm6Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-WSsB5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-esvqMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-uK661l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-NA1O5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:46 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SpieR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-FVoGjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SUqmI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1Xw7_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OcRW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-mNWQ_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-X01SWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tkQXFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-_cHVVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-3LaNnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ufhrBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:50 INFO - Downloading blessings-1.6.tar.gz 09:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:50 INFO - Installing collected packages: blessings 09:56:50 INFO - Running setup.py install for blessings 09:56:50 INFO - Successfully installed blessings 09:56:50 INFO - Cleaning up... 09:56:51 INFO - Return code: 0 09:56:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:51 INFO - Reading from file tmpfile_stdout 09:56:51 INFO - Current package versions: 09:56:51 INFO - blessings == 1.6 09:56:51 INFO - blobuploader == 1.2.4 09:56:51 INFO - docopt == 0.6.1 09:56:51 INFO - functools32 == 3.2.3-2 09:56:51 INFO - jsonschema == 2.5.1 09:56:51 INFO - manifestparser == 1.1 09:56:51 INFO - mozInstall == 1.12 09:56:51 INFO - mozcrash == 1.0 09:56:51 INFO - mozdebug == 0.1 09:56:51 INFO - mozdevice == 0.49 09:56:51 INFO - mozfile == 1.2 09:56:51 INFO - mozhttpd == 0.7 09:56:51 INFO - mozinfo == 0.9 09:56:51 INFO - mozleak == 0.1 09:56:51 INFO - mozlog == 3.4 09:56:51 INFO - moznetwork == 0.27 09:56:51 INFO - mozprocess == 0.25 09:56:51 INFO - mozprofile == 0.28 09:56:51 INFO - mozrunner == 6.13 09:56:51 INFO - mozscreenshot == 0.1 09:56:51 INFO - mozsystemmonitor == 0.3 09:56:51 INFO - moztest == 0.8 09:56:51 INFO - mozversion == 1.4 09:56:51 INFO - psutil == 3.1.1 09:56:51 INFO - requests == 1.2.3 09:56:51 INFO - wsgiref == 0.1.2 09:56:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:51 INFO - 'HOME': '/Users/cltbld', 09:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:51 INFO - 'LOGNAME': 'cltbld', 09:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:51 INFO - 'MOZ_NO_REMOTE': '1', 09:56:51 INFO - 'NO_EM_RESTART': '1', 09:56:51 INFO - 'PAGER': '/bin/cat', 09:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:51 INFO - 'PWD': '/builds/slave/test', 09:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:51 INFO - 'SHELL': '/bin/bash', 09:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:51 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:51 INFO - 'USER': 'cltbld', 09:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:51 INFO - 'XPC_FLAGS': '0x0', 09:56:51 INFO - 'XPC_SERVICE_NAME': '0', 09:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:56:51 INFO - Cleaning up... 09:56:51 INFO - Return code: 0 09:56:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011d3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd512ce7ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, '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.ERH2LbGeHV/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.2rTm3qsk22/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:51 INFO - 'HOME': '/Users/cltbld', 09:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:51 INFO - 'LOGNAME': 'cltbld', 09:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:51 INFO - 'MOZ_NO_REMOTE': '1', 09:56:51 INFO - 'NO_EM_RESTART': '1', 09:56:51 INFO - 'PAGER': '/bin/cat', 09:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:51 INFO - 'PWD': '/builds/slave/test', 09:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:51 INFO - 'SHELL': '/bin/bash', 09:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:56:51 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:51 INFO - 'USER': 'cltbld', 09:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:51 INFO - 'XPC_FLAGS': '0x0', 09:56:51 INFO - 'XPC_SERVICE_NAME': '0', 09:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:51 INFO - Cleaning up... 09:56:51 INFO - Return code: 0 09:56:51 INFO - Running post-action listener: _resource_record_post_action 09:56:51 INFO - Running post-action listener: _start_resource_monitoring 09:56:51 INFO - Starting resource monitoring. 09:56:51 INFO - [mozharness: 2017-03-29 16:56:51.888896Z] Finished create-virtualenv step (success) 09:56:51 INFO - [mozharness: 2017-03-29 16:56:51.889870Z] Running install step. 09:56:51 INFO - Running pre-action listener: _resource_record_pre_action 09:56:51 INFO - Running main action method: install 09:56:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:52 INFO - Reading from file tmpfile_stdout 09:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:52 INFO - Reading from file tmpfile_stdout 09:56:52 INFO - Output received: 09:56:52 INFO - Usage: mozinstall [options] installer 09:56:52 INFO - Options: 09:56:52 INFO - -h, --help show this help message and exit 09:56:52 INFO - -d DEST, --destination=DEST 09:56:52 INFO - Directory to install application into. [default: 09:56:52 INFO - "/builds/slave/test"] 09:56:52 INFO - --app=APP Application being installed. [default: firefox] 09:56:52 INFO - mkdir: /builds/slave/test/build/application 09:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:57:12 INFO - Reading from file tmpfile_stdout 09:57:12 INFO - Output received: 09:57:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:57:12 INFO - Running post-action listener: _resource_record_post_action 09:57:12 INFO - [mozharness: 2017-03-29 16:57:12.212752Z] Finished install step (success) 09:57:12 INFO - [mozharness: 2017-03-29 16:57:12.212895Z] Running run-tests step. 09:57:12 INFO - Running pre-action listener: _resource_record_pre_action 09:57:12 INFO - Running main action method: run_tests 09:57:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:12 INFO - 2017-03-29 09:57:12.227 screenresolution[1624:7310] starting screenresolution argv=screenresolution get 09:57:12 INFO - 2017-03-29 09:57:12.229 screenresolution[1624:7310] Display 0: 1600x1200x32@60 09:57:12 INFO - 2017-03-29 09:57:12.235 screenresolution[1625:7313] starting screenresolution argv=screenresolution list 09:57:12 INFO - Available Modes on Display 0 09:57:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:12 INFO - Intel Iris: 09:57:12 INFO - Chipset Model: Intel Iris 09:57:12 INFO - Type: GPU 09:57:12 INFO - Bus: Built-In 09:57:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:12 INFO - Vendor: Intel (0x8086) 09:57:12 INFO - Device ID: 0x0a2e 09:57:12 INFO - Revision ID: 0x0009 09:57:12 INFO - Displays: 09:57:12 INFO - Display: 09:57:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:12 INFO - Display Serial Number: 1600x1200 60 09:57:12 INFO - Main Display: Yes 09:57:12 INFO - Mirror: Off 09:57:12 INFO - Online: Yes 09:57:12 INFO - Rotation: Supported 09:57:12 INFO - Return code: 0 09:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:12 INFO - Python 2.7.3 09:57:12 INFO - Return code: 0 09:57:12 INFO - grabbing minidump binary from tooltool 09:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fb1d30>, '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 0x100ed8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fa6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:57:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:57:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:12 INFO - Return code: 0 09:57:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - ENV: RUST_BACKTRACE is now 1 09:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ERH2LbGeHV/Render', 09:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:12 INFO - 'HOME': '/Users/cltbld', 09:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:12 INFO - 'LOGNAME': 'cltbld', 09:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:12 INFO - 'MOZ_NO_REMOTE': '1', 09:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:12 INFO - 'NO_EM_RESTART': '1', 09:57:12 INFO - 'PAGER': '/bin/cat', 09:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:12 INFO - 'PWD': '/builds/slave/test', 09:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:12 INFO - 'RUST_BACKTRACE': '1', 09:57:12 INFO - 'SHELL': '/bin/bash', 09:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2rTm3qsk22/Listeners', 09:57:12 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:12 INFO - 'USER': 'cltbld', 09:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:12 INFO - 'XPC_FLAGS': '0x0', 09:57:12 INFO - 'XPC_SERVICE_NAME': '0', 09:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:57:12 INFO - mozversion application_buildid: 20170329081422 09:57:12 INFO - mozversion application_changeset: ce2c39b33751ec2394a4810892089c4764da9e60 09:57:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:57:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:12 INFO - mozversion application_name: Firefox 09:57:12 INFO - mozversion application_remotingname: firefox-dev 09:57:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:12 INFO - mozversion application_vendor: Mozilla 09:57:12 INFO - mozversion application_version: 54.0a2 09:57:12 INFO - mozversion platform_buildid: 20170329081422 09:57:12 INFO - mozversion platform_changeset: ce2c39b33751ec2394a4810892089c4764da9e60 09:57:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:12 INFO - mozversion platform_version: 54.0a2 09:57:12 INFO - using testdate: 1490806632 09:57:12 INFO - actual date: 1490806632 09:57:12 INFO - starting webserver on 'localhost:49236' 09:57:12 INFO - SUITE-START | Running 2 tests 09:57:12 INFO - TEST-START | dromaeo_css 09:57:12 INFO - operating with platform_type : mac_ 09:57:12 INFO - Initialising browser for dromaeo_css test... 09:57:12 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpFGCO5l/profile http://localhost:49236/getInfo.html) 09:57:15 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:57:15 INFO - PROCESS | 1635 | colorDepth:24 09:57:15 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:57:15 INFO - PROCESS | 1635 | __metrics 09:57:15 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:15 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:16 INFO - TEST-INFO | 1635: exit 0 09:57:16 INFO - Browser initialized. 09:57:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:16 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpFGCO5l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:28 INFO - PROCESS | 1637 | RSS: Main: 215527424 09:57:28 INFO - PROCESS | 1637 | 10:00:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:00:35 INFO - PROCESS | 1637 | RSS: Main: 366006272 10:00:35 INFO - PROCESS | 1637 | 10:02:17 INFO - PROCESS | 1637 | ************************* 10:02:17 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 10:02:17 INFO - PROCESS | 1637 | 10:02:17 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:02:17 INFO - PROCESS | 1637 | Full stack: 10:02:17 INFO - PROCESS | 1637 | ************************* 10:03:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:03:38 INFO - PROCESS | 1637 | RSS: Main: 354467840 10:03:38 INFO - PROCESS | 1637 | 10:06:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:06:41 INFO - PROCESS | 1637 | RSS: Main: 333520896 10:06:41 INFO - PROCESS | 1637 | 10:09:43 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:09:44 INFO - PROCESS | 1637 | RSS: Main: 334843904 10:09:44 INFO - PROCESS | 1637 | 10:12:48 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:12:49 INFO - PROCESS | 1637 | RSS: Main: 322781184 10:12:49 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:15:52 INFO - PROCESS | 1637 | RSS: Main: 511840256 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | __start_tp_report 10:15:52 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 10:15:52 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 10:15:52 INFO - PROCESS | 1637 | |i|pagename|runs| 10:15:52 INFO - PROCESS | 1637 | |0;dojo.html;2953.2469220348808;3407.7784943978622;3427.091820667523;3437.793732376056;3450.706689931356;5917.556183286255;5920.733566989485;5939.049752039675;5958.285005799299;5995.640261584303;6001.459868611824;6038.0942858571125;6061.424164704346;6062.484688801446;6065.787697430591;5373.81191658292;5406;5416.377116631598;5456.263404440389;5505.504504594585;5352.625316227865;5371.355437347524;5491.258680078178;5492.917606235909;5562.3047119110115;5391.541718953894;5449.073657478239;5461.617686761928;5465.890682186354;5482.013237617227;5442.619016668835;5452.809151679712;5458.61789674721;5462.535684466785;5464;5358.33020872391;5387.515123638891;5405.054115529767;5415.025295446818;5433.565314774809;6103.328633850273;6111.327753947062;6116.174316467264;6117.847053823645;6126.724297406583;6238.781642642486;6249.968750156266;6258.123862659231;6264.436200741955;6272;6358.459530939829;6368.29948705642;6448.613083214976;6492.545521813475;6565.606063636197;5141.331626888518;6070.726817293233;6111.2666480022235;6131.754729810802;6133.84665383369;6666.733330666768;6672.833179170511;6695.564788288843;6697.062411262427;6703.865922681616;6170.136180934673;6204.162438070803;6239.688015599202;6244.906326405107;6276.215473065867;6469;6487.18910136233;6489.837754056186;6497.15536980199;6497.902531462032;6232.470240029648;6390.584612000205;6390.840228994312;6396.264429590564;6400.7119679614525;4968.826091086867;6118.923762351576;6297.748090076438;6393.136926514954;6413.3266007069515;5155.381354237516;5159.690418574897;5167.844964651066;5177.611679124081;5177.896442071137;4599.862004139881;4615.515370886076;4617.653675974316;4620.19146649335;4633.513481084437;6010.909836352458;6027.9095813562835;6034.9396506035255;6089.025755879038;6126.050462178369;6208.2239720034995;6499.025146228104;6514.088027676129;6520.217573891164;6529.020646902907;6030.216071910711;6034.09488576717;6109.526129009804;6124.969375153096;6156.6921653917125;5743.023685973395;5743.770249189985;5745.3105627324985;5759.85600359986;5760.251167348301;6421.133147025092;6476.546641735222;6571.868562628625;6630.90053649186;6773.288804675635;6453.354664533509;6498.415142637185;6499.155109835691;6513.218413790375;6525.706343214471;6722.226943901514;6727.764528241488;6737.056812046416;6746.8650626988165;6753.1220941277315;5334.626576139633;6106.035994416466;6262.405071518198;6262.843428914313;6352.110704501281;5260.736963151904;6387.616742995435;6411.5832470889245;6421.197350331208;6434.742610295723;6119.632822030692;6221.47117495018;6232.594881332699;6262.2172228471445;6269.247690277196;6137.232845894263;6138.2044803098925;6212.596181248205;6286.685665716787;6295.716692748746;5185.792568297225;6163.19878415803;6204.937950620617;6237.750489980532;6270.811875643738;6264.561480696308;6272;6274.466670333073;6274.6548939808745;6284.685765711788;6034.366391528826;6169.6915154241215;6209.658468784261;6221.47117495018;6242.063690446288 10:15:52 INFO - PROCESS | 1637 | |1;ext.html;762.4319881688143;796.1083586383252;816.2408959667508;883.4743327720005;897.2373482539846;28185;39978.2004359913;40337.59662403375;40552.391714124315;40574.56552606846;40764.18471630573;41081.79459102708;41084.178316433725;41101.794491027504;41149.58850411495;7336.449766267525;9170.770730731734;9325.300602454809;9332.39339442934;9332.626694932194;7393.482456228066;11003.954624310678;11200.943995280053;11294.20940534163;11324.433778311093;11132.888671113265;11181.49683264251;11187.160962927772;11203.943980280128;11241.718957026058;7425.22035186303;9548.665796697116;11097.667069987872;11157.442127893573;11181.552737890475;7379.3358597726465;7391.408687305003;7396.038514993016;7399.260073992611;10686.877877822872;39377.60622393768;39629.60370396317;39649.80175099106;39655;39693.603063969276;3700.278445703089;3749.925001499982;3751.0452753554055;3754.9436758448646;3761.680257178143;27779;27947.161585152273;28238.011669591466;28269.85865070682;29199.854000730073;3075.154332558542;3085.2749603843304;3106.332138590214;3116.143060658337;3140.8272545010013;357886;359697;360350;360519;360642;52236.738816305675;52304.73847630737;52338.21492677613;52356.47643523516;52462.213066804026;55428.72285638546;55445;55491;55528.88942221214;55583;14596.562103136923;15049.021813582081;15059;15067.397304107932;15072.849271507144;11014.834777478345;11157.497912593954;12792.61622151337;12808.295543745184;12821.551245706542;9036.186743193144;10849.186311026704;10918.50866711;10919.945400272947;10944.890551094546;4849.854504364875;4943.332650092263;4985.750712464363;5194.805194805141;5639.859003524863;926.5691453474033;956.1299217711849;966.5891995901713;995.7261753017833;1027.984580231297;21328.253511127037;21455;26572.601410978852;26628.334291642863;26734.46531069368;1039.9636012739518;1059.4067322299384;1062.293574772783;1063.4523220541428;1082.6535508637319;13331.133476324201;13539.45842166322;13743.862561374459;13804.93097534506;13926.51257205993;461356;461523;462222.68888656015;462371;465244;54577.72711136419;54874.451255486936;54894.72552637291;55006.44993550093;55129.173062404094;1269.4985480735243;1444.4872070414851;1484.3617244584932;1485.034727427181;1486.799282096903;25306.493870122864;26122;26148;26357.472850543265;26380.8680956594;47746.76126619345;47755;47874.521254787;47891.52108478871;47915.5208447925;424087;425560;425642;425884;426354;33774.66225337715;34331.79838705733;34373.79691710778;34432.48351274783;34442.655573443946;39083.80458097805;39093.41359879661;42245.788771055944;42530.57469425266;42633.36049959191;29380.853095734383;29646.851765741896;29879;29910;30690.07929762111;28987.7101228985;29837.254068648457;29960.70039299579;30030.099097027123;30159.396812063198;35926.10184745298;36633.45049824201;36764.080897976695;36794.632053680194;36916.446253306756;29752;30228.24429389283;30371.088867334016;30715.846420767753;31448.52827207548;19831.60336793285;23127;23702.866741993304;24081;24302 10:15:52 INFO - PROCESS | 1637 | |2;jquery.html;352.78303843136473;376.68546763452514;387.4401489847172;409.79715041054703;455.2692927850799;13514.932425337873;19774.933253487034;20661.896690516543;21663.891680541616;21872.125114995422;19180.904095479502;21183.788162118373;22192.556148877055;22512.437189070282;22768.658470122962;5498.9826882026955;6293.999999999988;6767.323267673218;6808.5914845109455;6808.6936087876165;6608.834779130512;6701.195856497227;6753.831154221135;6769.458443324522;6819;6470.74117035318;6658.600483970953;6710.127683401151;6745.426638735713;6782.050512928194;6516.2731876052885;6577.704003319862;6623.7350505980185;6723.125993620823;6732.417881797749;6393.168888044571;6508.642024688687;6509.4466970307585;6514.674266286715;6515.446187074057;26880.924763009458;27183.86408067967;27212.183634490997;27229;27464.725352746416;2970.910872673823;2999.355138645202;3000.699930007004;3006.2634654509566;3051.633803943541;16020.460562067214;16437.26032328548;16718.08050557219;16999.40502082421;17332.480025599252;1988.9701654475195;2008.1365013044385;2027.4120505053518;2047.7440319960006;2065.648839697255;100328;106902;114196.4290178552;114399.28401073991;116298;20643.07781521506;20716.689249661267;20763.27328543524;20993.68509472359;21615.45961350979;33719;33946.49080263798;34521.82739086288;34524.82737586346;34585;10282.742931426774;10446.268761186797;10643.148548116133;10689.091427228617;10794.298370605886;8341.791455213668;8682.479051256945;8735.825283494294;8895.421797583136;8976.730698079067;9956.303058785961;10027.899721002697;10105.5452504636;10144.087032167141;10149.904279194769;4025.7785821780085;4058.208240178864;4078.5921407858978;4108.219438306712;4118.208579268028;889.586342350797;896.4262871762078;909.6179604566098;927.3601215161652;950.353759443585;21697.457563561038;22393.55212895733;22438.775612243997;22624.547509049728;22660.773392265866;938.6620816506053;941.8022215334856;966.7873067925045;967.5645959318335;969.9030096990244;10711.94644026775;11261.493232804543;11304.604338848101;11438.656840294805;12002;776486;790239;797018;806513;815460;102884;158057.209713953;160657;165409.17295413447;175129;1326.7678156322604;1339.370495866941;1397.6645605054714;1398.5384823008383;1406.8452470228267;18769.249230030648;19062.856228626326;19443;19485;19549.609007820047;54769.26153692379;60206.09690854728;66518;66531;66962.66518667375;94808.52595736977;96243.51878240563;96711.51644242015;98382;98535;10412.68761937143;10845.240833141605;11326.207165498336;11482.598109066143;11686.415679215836;11955.402229888297;12684.936575317064;12852.678683032998;13202.405891735087;13224.867751322749;10110.69667909964;10485.056344928993;10852.67441976742;11139.275947063416;11399.487023083815;10324.845127323246;10382.844257336297;10386.272960892666;10509.684709458728;10600.787984240118;11053;11196.83204751913;11273.154513411691;11332.206745527734;11482.425878705864;11299;11308.660740177807;11316.94341528287;11342.262752921033;11641.59254426125;10727.302725322828;11286.097112231166;11303.547858085585;11305.886941130813;11317.886821131684 10:15:52 INFO - PROCESS | 1637 | |3;mootools.html;1516.9393224271023;1551.2631500037483;1555.9844401555981;1580.8656264217536;1582.9762553561698;10794.460276986149;11441.370724610144;11447.885521144806;11450.942745286273;11454.48454819533;10671.946640266808;10996.175286853479;11111.666650000512;11176.832347514794;11194.160437967144;2384.4754154086118;2395.461021270209;2419.9153029643967;2421.5278020785954;2435.2207293665947;2304.8847557622053;2364.645303204516;2389.2593296078185;2390.8326417150806;2394.9042038318535;2026.493376655836;2321.767823217682;2349.776771206741;2387.1764241336796;2399.064364897691;2313.097891822191;2344.800691941187;2362.9645555316597;2367.195153647751;2368.83418160728;2359.7050368703913;2375.3705268103968;2380.4762952150672;2380.940476488084;2384.237044145874;10828.675139745741;11050.944745276222;11064;11065.50205240766;11071.114310855111;5702.144678298247;5805;5853.5902486825935;5888.205092312526;5891.911621325684;3524.436090225577;3613.6205698401554;3631.1285291529844;3644.3075815594952;3709.5733990591157;1177.2112684501406;1195.2171327780318;1205.933673647949;1232.48235740989;1256.7298030923305;13675.863241367559;14036.789448158286;14256.28718564078;15530.068195908281;15754.291056902352;4161.708680392343;4214.789260536961;4321.265384884514;4326.6754993375625;4756.953470236543;11670.474828632732;11768.588099416651;11776.88223117775;11782;11815.054795616503;4879.853604391874;5085.74571271435;5785.971070144707;5787.305523337142;5791.623544469596;5073.467285934998;5236.711980841091;5262.97368513155;5283.207518872123;5290.761915713802;3838.0788610733225;3845.3462911305146;3861.092643228839;3865.43951127085;3884.1260716338597;1024.2778840917135;1026.3585259212991;1034.9016843399866;1047.9738006549744;1048;796.3828033274143;904.5884122724144;926.4719110107309;938.5729493080632;944.5041353289578;6472.967635161888;6536.150300460909;6615.239247486505;6649.503861631094;6649.867002660017;969.7187815533416;982.729749318943;994.5474808961905;1000.7948370584013;1051.8264486359817;4086;4217.135487225111;4227.450431443893;4344.261475549164;4369.9126017479475;13895.305234738222;14389.928050359682;14407.207603581903;14407.78388324176;14426.927865360605;14275.357608907623;14292.642683932776;14310.57068287953;14318.856811431753;14330.641733956734;9847.50762461874;10183.490825458697;10399.32404393712;10404.375737455777;10410.427426491615;6532.869342613216;6606.405423511907;6619.735210591715;6670.39966403026;6705.195376554844;12224.205426647239;12505.874941250471;12558.372081395712;12565.308908009782;12586.87413125857;12404.19372740805;12550.87449125497;12556.497740090294;12762.553310634083;12847.743045139232;8298.668053277801;8500.14998500145;8508.489490630582;8509.659613615386;8517.574121294034;10184.490775461345;10278.897211027794;10307.072363487323;10409.323393979366;10421.583136674448;8721.956390218009;8783.516906569945;8875.467471951704;8925.73222803317;9055.18503334703;8609.741707748777;8623.56882155877;8657.177568131017;8781.385303028726;8900.777480563038;6111.266648002268;7762.534247945141;7898.249666281694;8010.158933311918;8230.971128608924;5727.8568035799435;5866.090755932837;5866.530677545701;6059.969700151471;6100.847478813065;5419.810306639249;5838.620489668158;5930.584859059824;5946.702664866826;6080.331163571915 10:15:52 INFO - PROCESS | 1637 | |4;prototype.html;318.6616211909979;369.4015694574789;378.52684144818977;387.72084099448386;389.06041908790274;4236.555161708023;4688.906221875561;4849.77489969171;4886.31591577179;5119.692818430897;4333.371661109145;4521.123733650539;4599.757171194308;4911.75441227939;4929.334539837121;4275.904806644738;4289.914201715964;4325.653947684178;4335.3063509838275;4409;3851.844446666003;4215.49414070312;4289.785510724451;4308.418363520916;4435.4233949586505;3867.105118491933;4275.209086319041;4318.862163229206;4364.934525982097;4375.518692943773;3780.584135745066;4156.542780294165;4195.895102622429;4300.65594752419;4301.462317210348;4022.859199928018;4089.3661482470266;4089.5501494835844;4111.280525907954;4126.834926602963;4370.934435983463;4986.67586606873;4997.400311962588;5003.298878381332;5018.573421259197;4358.259095953696;4699.412573428322;5007.246014691941;5081.65336185911;5106.617003724736;4398.6700997425005;4828.975855120702;5386.064594795806;5432.348118225838;5433.755481003364;3881.4474210315816;4132.33882578786;4261.531231564525;4738.8341408050555;4741.976290118562;4548.772561371951;5344.91982620261;5477.945220547784;5706.429357064343;5771.219850997603;4254.851190178634;4717.268823332389;4737.8341758038305;4759.95281038171;4827.710337379768;4346.760928148982;4799.704079898408;4815.951840481621;4817.78319975602;4910.116179087727;4184.560621134737;4638.953610463852;4642.86071417858;4750.5249475052215;4927.733242708394;4321.870343889688;5139.717315547606;5228.581713462914;5246.501582349671;5265.842024739264;1317;1371.8902487800951;1374.9725005499834;1414.8868090552937;1470.0738534723057;1222.3460448659923;1237.5421094195206;1242.6147894152841;1283.6084994076896;1389.4372779024511;4768.594669453136;4865.318855360252;4892.651527266932;4920.852374428773;4960.305557221992;4824.614030877521;5077.822276220315;5394.62237643369;5462.262594549765;5465.2562994349;4297.78511074445;4449.421575195204;4449.933251001237;4840.29815676732;4869.659123861366;2375.2541881716925;2516.9370765731005;2580.509703156394;2771.9029833955715;2855.528837741749;4908.705477671351;5480.654050350253;5555.277863862216;5573.5819813514145;5602.4957753802355;4475.328700694922;5249.2126181073145;5521;5534.667919924817;5557.972210138923;4868.95131048692;5187;5406.405295417422;5633.380328163817;5677.870798450581;4858.44127925279;4904.852854414374;5443.856790074129;5477.02826982294;5538.670719027324;5171.482851714798;5341.7062061586985;5366.087765080024;5367.302250707383;5435.646682965595;4759.714417134983;5000.249962505508;5049.57078648319;5682.954136510935;5735.218419066833;3748.8875333738943;4027.35562310029;4052.2705912935953;4102.569230230903;4292.506361768436;5008.9248661269385;5436.755346009518;5490.258815060076;5669.291338582677;5698.487136157766;4836.975815120902;4952.876178095432;5249.317588713443;5326.414094449685;5431.782728690808;4478.820847166076;4542.432195975503;4756.693003893179;5262.552683021986;5299.4700529946695;4440.111977604557;4547.386102876202;4884.951150488591;5111.779578865291;5152.604039121827;4556.498785133699;5094.490550944876;5127.564157046543;5131.948680513147;5249.162793022411;5046.899062018666;5084.339035925306;5260.342457192851;5331.3739309510975;5333.466653334635 10:15:52 INFO - PROCESS | 1637 | |5;yui.html;711.6050591921481;730.674849691887;765.2500549461528;817.7628487738555;829.767665053785;15361.769573456393;16137.112458814761;16161.434349797759;16163.757543636855;16199;14470.493532726357;14517.419303227858;14541.345639446225;14598.635034124125;15137.394504219845;751.9661615227328;762.9580373079492;784.6076961519241;812.975610731676;832.7293629570383;943.6084025129563;943.8537026760863;944.6929747831948;945.012461977232;946.1768261612407;993.1310103659298;994.6717583197527;995.2187532786763;995.7809281957958;997.5909876950452;991.7520619845038;991.8462638291004;992.4491906991617;994.820932232198;995.7659949911765;733.0982891044046;734.2657342657343;734.6143274780729;735.7277807211366;736.977890663281;15886.76169857453;16064.357425702958;16086.597835054217;16407.83592164075;16606.66786664272;13999;14092.154470731686;14149.929250353785;14248.002639815217;14297.213653249068;11723.237989530653;11776.175667703264;11830.526778928832;11846.46690898903;12262.327504832048;3528.59421166564;3616.367135751233;3632.963670363289;3644.5626524816926;3713.442983552489;104694;107697.46151269272;108121.37817932737;108278;108465;10300.175985921258;10401.167906567456;10671.092957098579;10949.616763413242;11307.49116289769;21205.045772940255;21501.78498215029;21596;21621.891890540446;21934.670979935312;7514.211007844207;7598.354139898171;7627.733029343946;7714;7727.729529466554;4155.771432571238;4205.222033923734;4215.093754842724;4225.830966761357;4253.383259427365;3423.1955490459723;3478.2174010847357;3483.860645574199;3515.7890526567976;3517.909448071106;611.6574718157846;617.5707883021257;618.3785295777715;631.1857703562445;635.3233805996599;610.3957082488394;616.6566357187263;644.44899610833;647.2879832184653;657.0833687006599;9678.56446459911;9684.32209745311;9888.307818452638;9964.20286377088;10116.54475548602;577.3302968556454;628.644815679149;640.177372076879;644.2397970394885;648.5557393185683;3862.8454861805776;4179.895502612459;4775.42694876617;4780.904381912343;4784.497627749106;102677;105625.47187264015;106329.46835265774;110110;111356;52392.21411678828;76804.2319576797;88229;89948.5502572483;98191.50904245433;67170;68181.65909170422;69585.95621065688;70259;70309.64845175741;8828;10878.456077196266;10954;11118.666440006813;11202.38386888729;37329.81335093307;49670.751646242985;49672.50327496679;50823.745881270355;51066;63440;64094.67952660207;65745.67127164334;65825.67087164725;66908.3309166902;12293.07801914878;12347.444365003417;12446.564370246997;12627.810582841448;12659.493620255087;13704.794428083387;13901.374438150106;14361.569152925429;14384.136951782926;14568.41726330935;12776.6805829855;13107.475700971854;13433.932830335785;13530.79703804424;13698.109622874481;13512.59462216135;13640.249786261851;13774;13816.792748108988;13944.930275348559;12808.551700690432;12984.15602985803;13364.866351336752;13555.951899202119;13827.170369777845;9246.907530924605;9748;9843.064908833649;9886.406815591088;10301.587936482456;8583.828323433372;9341.953290233505;9909.405435673883;10962.945185274022;11347.262427942487 10:15:52 INFO - PROCESS | 1637 | __end_tp_report 10:15:52 INFO - PROCESS | 1637 | __start_cc_report 10:15:52 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1448 10:15:52 INFO - PROCESS | 1637 | __end_cc_report 10:15:52 INFO - PROCESS | 1637 | __startTimestamp1490807752680__endTimestamp 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | ------- Summary: start ------- 10:15:52 INFO - PROCESS | 1637 | Number of tests: 6 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5943.97 Median:6137.23 stddev:678.24 (11.1%) stddev-sans-first:638.45 10:15:52 INFO - PROCESS | 1637 | Values: 2953.2 3407.8 3427.1 3437.8 3450.7 5917.6 5920.7 5939.0 5958.3 5995.6 6001.5 6038.1 6061.4 6062.5 6065.8 5373.8 5406.0 5416.4 5456.3 5505.5 5352.6 5371.4 5491.3 5492.9 5562.3 5391.5 5449.1 5461.6 5465.9 5482.0 5442.6 5452.8 5458.6 5462.5 5464.0 5358.3 5387.5 5405.1 5415.0 5433.6 6103.3 6111.3 6116.2 6117.8 6126.7 6238.8 6250.0 6258.1 6264.4 6272.0 6358.5 6368.3 6448.6 6492.5 6565.6 5141.3 6070.7 6111.3 6131.8 6133.8 6666.7 6672.8 6695.6 6697.1 6703.9 6170.1 6204.2 6239.7 6244.9 6276.2 6469.0 6487.2 6489.8 6497.2 6497.9 6232.5 6390.6 6390.8 6396.3 6400.7 4968.8 6118.9 6297.7 6393.1 6413.3 5155.4 5159.7 5167.8 5177.6 5177.9 4599.9 4615.5 4617.7 4620.2 4633.5 6010.9 6027.9 6034.9 6089.0 6126.1 6208.2 6499.0 6514.1 6520.2 6529.0 6030.2 6034.1 6109.5 6125.0 6156.7 5743.0 5743.8 5745.3 5759.9 5760.3 6421.1 6476.5 6571.9 6630.9 6773.3 6453.4 6498.4 6499.2 6513.2 6525.7 6722.2 6727.8 6737.1 6746.9 6753.1 5334.6 6106.0 6262.4 6262.8 6352.1 5260.7 6387.6 6411.6 6421.2 6434.7 6119.6 6221.5 6232.6 6262.2 6269.2 6137.2 6138.2 6212.6 6286.7 6295.7 5185.8 6163.2 6204.9 6237.8 6270.8 6264.6 6272.0 6274.5 6274.7 6284.7 6034.4 6169.7 6209.7 6221.5 6242.1 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:55481.23 Median:197811.55 stddev:110893.99 (56.1%) stddev-sans-first:111128.97 10:15:52 INFO - PROCESS | 1637 | Values: 762.4 796.1 816.2 883.5 897.2 28185.0 39978.2 40337.6 40552.4 40574.6 40764.2 41081.8 41084.2 41101.8 41149.6 7336.4 9170.8 9325.3 9332.4 9332.6 7393.5 11004.0 11200.9 11294.2 11324.4 11132.9 11181.5 11187.2 11203.9 11241.7 7425.2 9548.7 11097.7 11157.4 11181.6 7379.3 7391.4 7396.0 7399.3 10686.9 39377.6 39629.6 39649.8 39655.0 39693.6 3700.3 3749.9 3751.0 3754.9 3761.7 27779.0 27947.2 28238.0 28269.9 29199.9 3075.2 3085.3 3106.3 3116.1 3140.8 357886.0 359697.0 360350.0 360519.0 360642.0 52236.7 52304.7 52338.2 52356.5 52462.2 55428.7 55445.0 55491.0 55528.9 55583.0 14596.6 15049.0 15059.0 15067.4 15072.8 11014.8 11157.5 12792.6 12808.3 12821.6 9036.2 10849.2 10918.5 10919.9 10944.9 4849.9 4943.3 4985.8 5194.8 5639.9 926.6 956.1 966.6 995.7 1028.0 21328.3 21455.0 26572.6 26628.3 26734.5 1040.0 1059.4 1062.3 1063.5 1082.7 13331.1 13539.5 13743.9 13804.9 13926.5 461356.0 461523.0 462222.7 462371.0 465244.0 54577.7 54874.5 54894.7 55006.4 55129.2 1269.5 1444.5 1484.4 1485.0 1486.8 25306.5 26122.0 26148.0 26357.5 26380.9 47746.8 47755.0 47874.5 47891.5 47915.5 424087.0 425560.0 425642.0 425884.0 426354.0 33774.7 34331.8 34373.8 34432.5 34442.7 39083.8 39093.4 42245.8 42530.6 42633.4 29380.9 29646.9 29879.0 29910.0 30690.1 28987.7 29837.3 29960.7 30030.1 30159.4 35926.1 36633.5 36764.1 36794.6 36916.4 29752.0 30228.2 30371.1 30715.8 31448.5 19831.6 23127.0 23702.9 24081.0 24302.0 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:43532.34 Median:21784.79 stddev:131898.54 (605.5%) stddev-sans-first:132228.70 10:15:52 INFO - PROCESS | 1637 | Values: 352.8 376.7 387.4 409.8 455.3 13514.9 19774.9 20661.9 21663.9 21872.1 19180.9 21183.8 22192.6 22512.4 22768.7 5499.0 6294.0 6767.3 6808.6 6808.7 6608.8 6701.2 6753.8 6769.5 6819.0 6470.7 6658.6 6710.1 6745.4 6782.1 6516.3 6577.7 6623.7 6723.1 6732.4 6393.2 6508.6 6509.4 6514.7 6515.4 26880.9 27183.9 27212.2 27229.0 27464.7 2970.9 2999.4 3000.7 3006.3 3051.6 16020.5 16437.3 16718.1 16999.4 17332.5 1989.0 2008.1 2027.4 2047.7 2065.6 100328.0 106902.0 114196.4 114399.3 116298.0 20643.1 20716.7 20763.3 20993.7 21615.5 33719.0 33946.5 34521.8 34524.8 34585.0 10282.7 10446.3 10643.1 10689.1 10794.3 8341.8 8682.5 8735.8 8895.4 8976.7 9956.3 10027.9 10105.5 10144.1 10149.9 4025.8 4058.2 4078.6 4108.2 4118.2 889.6 896.4 909.6 927.4 950.4 21697.5 22393.6 22438.8 22624.5 22660.8 938.7 941.8 966.8 967.6 969.9 10711.9 11261.5 11304.6 11438.7 12002.0 776486.0 790239.0 797018.0 806513.0 815460.0 102884.0 158057.2 160657.0 165409.2 175129.0 1326.8 1339.4 1397.7 1398.5 1406.8 18769.2 19062.9 19443.0 19485.0 19549.6 54769.3 60206.1 66518.0 66531.0 66962.7 94808.5 96243.5 96711.5 98382.0 98535.0 10412.7 10845.2 11326.2 11482.6 11686.4 11955.4 12684.9 12852.7 13202.4 13224.9 10110.7 10485.1 10852.7 11139.3 11399.5 10324.8 10382.8 10386.3 10509.7 10600.8 11053.0 11196.8 11273.2 11332.2 11482.4 11299.0 11308.7 11316.9 11342.3 11641.6 10727.3 11286.1 11303.5 11305.9 11317.9 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6745.34 Median:2395.18 stddev:4279.94 (178.7%) stddev-sans-first:4273.92 10:15:52 INFO - PROCESS | 1637 | Values: 1516.9 1551.3 1556.0 1580.9 1583.0 10794.5 11441.4 11447.9 11450.9 11454.5 10671.9 10996.2 11111.7 11176.8 11194.2 2384.5 2395.5 2419.9 2421.5 2435.2 2304.9 2364.6 2389.3 2390.8 2394.9 2026.5 2321.8 2349.8 2387.2 2399.1 2313.1 2344.8 2363.0 2367.2 2368.8 2359.7 2375.4 2380.5 2380.9 2384.2 10828.7 11050.9 11064.0 11065.5 11071.1 5702.1 5805.0 5853.6 5888.2 5891.9 3524.4 3613.6 3631.1 3644.3 3709.6 1177.2 1195.2 1205.9 1232.5 1256.7 13675.9 14036.8 14256.3 15530.1 15754.3 4161.7 4214.8 4321.3 4326.7 4757.0 11670.5 11768.6 11776.9 11782.0 11815.1 4879.9 5085.7 5786.0 5787.3 5791.6 5073.5 5236.7 5263.0 5283.2 5290.8 3838.1 3845.3 3861.1 3865.4 3884.1 1024.3 1026.4 1034.9 1048.0 1048.0 796.4 904.6 926.5 938.6 944.5 6473.0 6536.2 6615.2 6649.5 6649.9 969.7 982.7 994.5 1000.8 1051.8 4086.0 4217.1 4227.5 4344.3 4369.9 13895.3 14389.9 14407.2 14407.8 14426.9 14275.4 14292.6 14310.6 14318.9 14330.6 9847.5 10183.5 10399.3 10404.4 10410.4 6532.9 6606.4 6619.7 6670.4 6705.2 12224.2 12505.9 12558.4 12565.3 12586.9 12404.2 12550.9 12556.5 12762.6 12847.7 8298.7 8500.1 8508.5 8509.7 8517.6 10184.5 10278.9 10307.1 10409.3 10421.6 8722.0 8783.5 8875.5 8925.7 9055.2 8609.7 8623.6 8657.2 8781.4 8900.8 6111.3 7762.5 7898.2 8010.2 8231.0 5727.9 5866.1 5866.5 6060.0 6100.8 5419.8 5838.6 5930.6 5946.7 6080.3 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4469.06 Median:4826.16 stddev:1212.06 (25.1%) stddev-sans-first:1174.74 10:15:52 INFO - PROCESS | 1637 | Values: 318.7 369.4 378.5 387.7 389.1 4236.6 4688.9 4849.8 4886.3 5119.7 4333.4 4521.1 4599.8 4911.8 4929.3 4275.9 4289.9 4325.7 4335.3 4409.0 3851.8 4215.5 4289.8 4308.4 4435.4 3867.1 4275.2 4318.9 4364.9 4375.5 3780.6 4156.5 4195.9 4300.7 4301.5 4022.9 4089.4 4089.6 4111.3 4126.8 4370.9 4986.7 4997.4 5003.3 5018.6 4358.3 4699.4 5007.2 5081.7 5106.6 4398.7 4829.0 5386.1 5432.3 5433.8 3881.4 4132.3 4261.5 4738.8 4742.0 4548.8 5344.9 5477.9 5706.4 5771.2 4254.9 4717.3 4737.8 4760.0 4827.7 4346.8 4799.7 4816.0 4817.8 4910.1 4184.6 4639.0 4642.9 4750.5 4927.7 4321.9 5139.7 5228.6 5246.5 5265.8 1317.0 1371.9 1375.0 1414.9 1470.1 1222.3 1237.5 1242.6 1283.6 1389.4 4768.6 4865.3 4892.7 4920.9 4960.3 4824.6 5077.8 5394.6 5462.3 5465.3 4297.8 4449.4 4449.9 4840.3 4869.7 2375.3 2516.9 2580.5 2771.9 2855.5 4908.7 5480.7 5555.3 5573.6 5602.5 4475.3 5249.2 5521.0 5534.7 5558.0 4869.0 5187.0 5406.4 5633.4 5677.9 4858.4 4904.9 5443.9 5477.0 5538.7 5171.5 5341.7 5366.1 5367.3 5435.6 4759.7 5000.2 5049.6 5683.0 5735.2 3748.9 4027.4 4052.3 4102.6 4292.5 5008.9 5436.8 5490.3 5669.3 5698.5 4837.0 4952.9 5249.3 5326.4 5431.8 4478.8 4542.4 4756.7 5262.6 5299.5 4440.1 4547.4 4885.0 5111.8 5152.6 4556.5 5094.5 5127.6 5131.9 5249.2 5046.9 5084.3 5260.3 5331.4 5333.5 10:15:52 INFO - PROCESS | 1637 | 10:15:52 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20024.22 Median:4167.83 stddev:28888.26 (693.1%) stddev-sans-first:28932.90 10:15:52 INFO - PROCESS | 1637 | Values: 711.6 730.7 765.3 817.8 829.8 15361.8 16137.1 16161.4 16163.8 16199.0 14470.5 14517.4 14541.3 14598.6 15137.4 752.0 763.0 784.6 813.0 832.7 943.6 943.9 944.7 945.0 946.2 993.1 994.7 995.2 995.8 997.6 991.8 991.8 992.4 994.8 995.8 733.1 734.3 734.6 735.7 737.0 15886.8 16064.4 16086.6 16407.8 16606.7 13999.0 14092.2 14149.9 14248.0 14297.2 11723.2 11776.2 11830.5 11846.5 12262.3 3528.6 3616.4 3633.0 3644.6 3713.4 104694.0 107697.5 108121.4 108278.0 108465.0 10300.2 10401.2 10671.1 10949.6 11307.5 21205.0 21501.8 21596.0 21621.9 21934.7 7514.2 7598.4 7627.7 7714.0 7727.7 4155.8 4205.2 4215.1 4225.8 4253.4 3423.2 3478.2 3483.9 3515.8 3517.9 611.7 617.6 618.4 631.2 635.3 610.4 616.7 644.4 647.3 657.1 9678.6 9684.3 9888.3 9964.2 10116.5 577.3 628.6 640.2 644.2 648.6 3862.8 4179.9 4775.4 4780.9 4784.5 102677.0 105625.5 106329.5 110110.0 111356.0 52392.2 76804.2 88229.0 89948.6 98191.5 67170.0 68181.7 69586.0 70259.0 70309.6 8828.0 10878.5 10954.0 11118.7 11202.4 37329.8 49670.8 49672.5 50823.7 51066.0 63440.0 64094.7 65745.7 65825.7 66908.3 12293.1 12347.4 12446.6 12627.8 12659.5 13704.8 13901.4 14361.6 14384.1 14568.4 12776.7 13107.5 13433.9 13530.8 13698.1 13512.6 13640.2 13774.0 13816.8 13944.9 12808.6 12984.2 13364.9 13556.0 13827.2 9246.9 9748.0 9843.1 9886.4 10301.6 8583.8 9342.0 9909.4 10962.9 11347.3 10:15:52 INFO - PROCESS | 1637 | -------- Summary: end -------- 10:15:52 INFO - PROCESS | 1637 | 10:15:53 INFO - TEST-INFO | 1637: exit 0 10:15:53 INFO - TEST-OK | dromaeo_css | took 1120516ms 10:15:53 INFO - TEST-START | kraken 10:15:53 INFO - operating with platform_type : mac_ 10:15:53 INFO - Initialising browser for kraken test... 10:15:53 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpD9RMoY/profile http://localhost:49236/getInfo.html) 10:15:55 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 10:15:55 INFO - PROCESS | 1647 | colorDepth:24 10:15:55 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 10:15:55 INFO - PROCESS | 1647 | __metrics 10:15:55 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:55 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:56 INFO - TEST-INFO | 1647: exit 0 10:15:56 INFO - Browser initialized. 10:15:56 INFO - Running cycle 1/1 for kraken test... 10:15:56 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpD9RMoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:08 INFO - PROCESS | 1648 | RSS: Main: 214970368 10:16:08 INFO - PROCESS | 1648 | 10:16:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:12 INFO - PROCESS | 1648 | RSS: Main: 267718656 10:16:12 INFO - PROCESS | 1648 | 10:16:14 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:16:15 INFO - PROCESS | 1648 | RSS: Main: 278790144 10:16:15 INFO - PROCESS | 1648 | 10:16:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:16:19 INFO - PROCESS | 1648 | RSS: Main: 376545280 10:16:19 INFO - PROCESS | 1648 | 10:16:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:16:22 INFO - PROCESS | 1648 | RSS: Main: 277688320 10:16:22 INFO - PROCESS | 1648 | 10:16:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:24 INFO - PROCESS | 1648 | RSS: Main: 280510464 10:16:24 INFO - PROCESS | 1648 | 10:16:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:28 INFO - PROCESS | 1648 | RSS: Main: 320458752 10:16:28 INFO - PROCESS | 1648 | 10:16:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:32 INFO - PROCESS | 1648 | RSS: Main: 320167936 10:16:32 INFO - PROCESS | 1648 | 10:16:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:16:35 INFO - PROCESS | 1648 | RSS: Main: 315977728 10:16:35 INFO - PROCESS | 1648 | 10:16:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:37 INFO - PROCESS | 1648 | RSS: Main: 295702528 10:16:37 INFO - PROCESS | 1648 | 10:16:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:40 INFO - PROCESS | 1648 | RSS: Main: 297877504 10:16:40 INFO - PROCESS | 1648 | 10:16:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:43 INFO - PROCESS | 1648 | RSS: Main: 307044352 10:16:43 INFO - PROCESS | 1648 | 10:16:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:46 INFO - PROCESS | 1648 | RSS: Main: 319266816 10:16:46 INFO - PROCESS | 1648 | 10:16:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:50 INFO - PROCESS | 1648 | RSS: Main: 312897536 10:16:50 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:16:52 INFO - PROCESS | 1648 | RSS: Main: 357732352 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | __start_tp_report 10:16:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:16:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:16:52 INFO - PROCESS | 1648 | |i|pagename|runs| 10:16:52 INFO - PROCESS | 1648 | |0;ai-astar;116;114;115;114;114;113;114;114;114;114 10:16:52 INFO - PROCESS | 1648 | |1;audio-beat-detection;144;112;109;144;110;109;110;107;128;109 10:16:52 INFO - PROCESS | 1648 | |2;audio-dft;180;183;182;196;233;251;234;184;184;184 10:16:52 INFO - PROCESS | 1648 | |3;audio-fft;82;61;61;101;62;58;61;59;76;60 10:16:52 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;87;72;97;100;82;68;68;84 10:16:52 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;89;88;88;87;89;88;89;88;89 10:16:52 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;96;95;98;95;94;96;98;99;95 10:16:52 INFO - PROCESS | 1648 | |7;imaging-desaturate;127;129;86;85;84;85;85;83;83;84 10:16:52 INFO - PROCESS | 1648 | |8;json-parse-financial;63;62;62;63;64;64;65;64;62;64 10:16:52 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;52;70;64;60;57;57;58;60;57;56 10:16:52 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;86;85;86;83;82;86;82;87;93;105 10:16:52 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;137;137;137;134;134;135;139;138;180;136 10:16:52 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;161;170;142;196;221;187;164;165;164;156 10:16:52 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;66;65;69;82;81;83;79;64;61;62 10:16:52 INFO - PROCESS | 1648 | __end_tp_report 10:16:52 INFO - PROCESS | 1648 | __start_cc_report 10:16:52 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2187 10:16:52 INFO - PROCESS | 1648 | __end_cc_report 10:16:52 INFO - PROCESS | 1648 | __startTimestamp1490807812454__endTimestamp 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:16:52 INFO - PROCESS | 1648 | Number of tests: 14 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.50 10:16:52 INFO - PROCESS | 1648 | Values: 116.0 114.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:111.00 stddev:14.83 (13.4%) stddev-sans-first:12.45 10:16:52 INFO - PROCESS | 1648 | Values: 144.0 112.0 109.0 144.0 110.0 109.0 110.0 107.0 128.0 109.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:201.10 Median:190.00 stddev:27.14 (14.3%) stddev-sans-first:27.70 10:16:52 INFO - PROCESS | 1648 | Values: 180.0 183.0 182.0 196.0 233.0 251.0 234.0 184.0 184.0 184.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:68.10 Median:61.00 stddev:14.05 (23.0%) stddev-sans-first:13.97 10:16:52 INFO - PROCESS | 1648 | Values: 82.0 61.0 61.0 101.0 62.0 58.0 61.0 59.0 76.0 60.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:83.00 stddev:11.78 (14.2%) stddev-sans-first:12.26 10:16:52 INFO - PROCESS | 1648 | Values: 88.0 70.0 87.0 72.0 97.0 100.0 82.0 68.0 68.0 84.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 10:16:52 INFO - PROCESS | 1648 | Values: 88.0 89.0 88.0 88.0 87.0 89.0 88.0 89.0 88.0 89.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:1.76 (1.8%) stddev-sans-first:1.72 10:16:52 INFO - PROCESS | 1648 | Values: 94.0 96.0 95.0 98.0 95.0 94.0 96.0 98.0 99.0 95.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:84.50 stddev:18.42 (21.8%) stddev-sans-first:14.91 10:16:52 INFO - PROCESS | 1648 | Values: 127.0 129.0 86.0 85.0 84.0 85.0 85.0 83.0 83.0 84.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 10:16:52 INFO - PROCESS | 1648 | Values: 63.0 62.0 62.0 63.0 64.0 64.0 65.0 64.0 62.0 64.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:4.93 (8.4%) stddev-sans-first:4.51 10:16:52 INFO - PROCESS | 1648 | Values: 52.0 70.0 64.0 60.0 57.0 57.0 58.0 60.0 57.0 56.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.00 stddev:6.92 (8.0%) stddev-sans-first:7.31 10:16:52 INFO - PROCESS | 1648 | Values: 86.0 85.0 86.0 83.0 82.0 86.0 82.0 87.0 93.0 105.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:137.00 stddev:13.90 (10.1%) stddev-sans-first:14.68 10:16:52 INFO - PROCESS | 1648 | Values: 137.0 137.0 137.0 134.0 134.0 135.0 139.0 138.0 180.0 136.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:167.50 stddev:22.75 (13.6%) stddev-sans-first:23.74 10:16:52 INFO - PROCESS | 1648 | Values: 161.0 170.0 142.0 196.0 221.0 187.0 164.0 165.0 164.0 156.0 10:16:52 INFO - PROCESS | 1648 | 10:16:52 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:74.00 stddev:8.97 (12.1%) stddev-sans-first:9.31 10:16:52 INFO - PROCESS | 1648 | Values: 66.0 65.0 69.0 82.0 81.0 83.0 79.0 64.0 61.0 62.0 10:16:52 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:16:52 INFO - PROCESS | 1648 | 10:16:53 INFO - TEST-INFO | 1648: exit 0 10:16:53 INFO - TEST-OK | kraken | took 60031ms 10:16:53 INFO - SUITE-END | took 1180s 10:16:53 INFO - Completed test suite (00:19:40) 10:16:53 INFO - javascript benchmark 10:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7624.029125670312, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.2469220348808, 3407.7784943978622, 3427.091820667523, 3437.793732376056, 3450.706689931356, 5917.556183286255, 5920.733566989485, 5939.049752039675, 5958.285005799299, 5995.640261584303, 6001.459868611824, 6038.0942858571125, 6061.424164704346, 6062.484688801446, 6065.787697430591, 5373.81191658292, 5406.0, 5416.377116631598, 5456.263404440389, 5505.504504594585, 5352.625316227865, 5371.355437347524, 5491.258680078178, 5492.917606235909, 5562.3047119110115, 5391.541718953894, 5449.073657478239, 5461.617686761928, 5465.890682186354, 5482.013237617227, 5442.619016668835, 5452.809151679712, 5458.61789674721, 5462.535684466785, 5464.0, 5358.33020872391, 5387.515123638891, 5405.054115529767, 5415.025295446818, 5433.565314774809, 6103.328633850273, 6111.327753947062, 6116.174316467264, 6117.847053823645, 6126.724297406583, 6238.781642642486, 6249.968750156266, 6258.123862659231, 6264.436200741955, 6272.0, 6358.459530939829, 6368.29948705642, 6448.613083214976, 6492.545521813475, 6565.606063636197, 5141.331626888518, 6070.726817293233, 6111.2666480022235, 6131.754729810802, 6133.84665383369, 6666.733330666768, 6672.833179170511, 6695.564788288843, 6697.062411262427, 6703.865922681616, 6170.136180934673, 6204.162438070803, 6239.688015599202, 6244.906326405107, 6276.215473065867, 6469.0, 6487.18910136233, 6489.837754056186, 6497.15536980199, 6497.902531462032, 6232.470240029648, 6390.584612000205, 6390.840228994312, 6396.264429590564, 6400.7119679614525, 4968.826091086867, 6118.923762351576, 6297.748090076438, 6393.136926514954, 6413.3266007069515, 5155.381354237516, 5159.690418574897, 5167.844964651066, 5177.611679124081, 5177.896442071137, 4599.862004139881, 4615.515370886076, 4617.653675974316, 4620.19146649335, 4633.513481084437, 6010.909836352458, 6027.9095813562835, 6034.9396506035255, 6089.025755879038, 6126.050462178369, 6208.2239720034995, 6499.025146228104, 6514.088027676129, 6520.217573891164, 6529.020646902907, 6030.216071910711, 6034.09488576717, 6109.526129009804, 6124.969375153096, 6156.6921653917125, 5743.023685973395, 5743.770249189985, 5745.3105627324985, 5759.85600359986, 5760.251167348301, 6421.133147025092, 6476.546641735222, 6571.868562628625, 6630.90053649186, 6773.288804675635, 6453.354664533509, 6498.415142637185, 6499.155109835691, 6513.218413790375, 6525.706343214471, 6722.226943901514, 6727.764528241488, 6737.056812046416, 6746.8650626988165, 6753.1220941277315, 5334.626576139633, 6106.035994416466, 6262.405071518198, 6262.843428914313, 6352.110704501281, 5260.736963151904, 6387.616742995435, 6411.5832470889245, 6421.197350331208, 6434.742610295723, 6119.632822030692, 6221.47117495018, 6232.594881332699, 6262.2172228471445, 6269.247690277196, 6137.232845894263, 6138.2044803098925, 6212.596181248205, 6286.685665716787, 6295.716692748746, 5185.792568297225, 6163.19878415803, 6204.937950620617, 6237.750489980532, 6270.811875643738, 6264.561480696308, 6272.0, 6274.466670333073, 6274.6548939808745, 6284.685765711788, 6034.366391528826, 6169.6915154241215, 6209.658468784261, 6221.47117495018, 6242.063690446288], "value": 5900.132600646393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.4319881688143, 796.1083586383252, 816.2408959667508, 883.4743327720005, 897.2373482539846, 28185.0, 39978.2004359913, 40337.59662403375, 40552.391714124315, 40574.56552606846, 40764.18471630573, 41081.79459102708, 41084.178316433725, 41101.794491027504, 41149.58850411495, 7336.449766267525, 9170.770730731734, 9325.300602454809, 9332.39339442934, 9332.626694932194, 7393.482456228066, 11003.954624310678, 11200.943995280053, 11294.20940534163, 11324.433778311093, 11132.888671113265, 11181.49683264251, 11187.160962927772, 11203.943980280128, 11241.718957026058, 7425.22035186303, 9548.665796697116, 11097.667069987872, 11157.442127893573, 11181.552737890475, 7379.3358597726465, 7391.408687305003, 7396.038514993016, 7399.260073992611, 10686.877877822872, 39377.60622393768, 39629.60370396317, 39649.80175099106, 39655.0, 39693.603063969276, 3700.278445703089, 3749.925001499982, 3751.0452753554055, 3754.9436758448646, 3761.680257178143, 27779.0, 27947.161585152273, 28238.011669591466, 28269.85865070682, 29199.854000730073, 3075.154332558542, 3085.2749603843304, 3106.332138590214, 3116.143060658337, 3140.8272545010013, 357886.0, 359697.0, 360350.0, 360519.0, 360642.0, 52236.738816305675, 52304.73847630737, 52338.21492677613, 52356.47643523516, 52462.213066804026, 55428.72285638546, 55445.0, 55491.0, 55528.88942221214, 55583.0, 14596.562103136923, 15049.021813582081, 15059.0, 15067.397304107932, 15072.849271507144, 11014.834777478345, 11157.497912593954, 12792.61622151337, 12808.295543745184, 12821.551245706542, 9036.186743193144, 10849.186311026704, 10918.50866711, 10919.945400272947, 10944.890551094546, 4849.854504364875, 4943.332650092263, 4985.750712464363, 5194.805194805141, 5639.859003524863, 926.5691453474033, 956.1299217711849, 966.5891995901713, 995.7261753017833, 1027.984580231297, 21328.253511127037, 21455.0, 26572.601410978852, 26628.334291642863, 26734.46531069368, 1039.9636012739518, 1059.4067322299384, 1062.293574772783, 1063.4523220541428, 1082.6535508637319, 13331.133476324201, 13539.45842166322, 13743.862561374459, 13804.93097534506, 13926.51257205993, 461356.0, 461523.0, 462222.68888656015, 462371.0, 465244.0, 54577.72711136419, 54874.451255486936, 54894.72552637291, 55006.44993550093, 55129.173062404094, 1269.4985480735243, 1444.4872070414851, 1484.3617244584932, 1485.034727427181, 1486.799282096903, 25306.493870122864, 26122.0, 26148.0, 26357.472850543265, 26380.8680956594, 47746.76126619345, 47755.0, 47874.521254787, 47891.52108478871, 47915.5208447925, 424087.0, 425560.0, 425642.0, 425884.0, 426354.0, 33774.66225337715, 34331.79838705733, 34373.79691710778, 34432.48351274783, 34442.655573443946, 39083.80458097805, 39093.41359879661, 42245.788771055944, 42530.57469425266, 42633.36049959191, 29380.853095734383, 29646.851765741896, 29879.0, 29910.0, 30690.07929762111, 28987.7101228985, 29837.254068648457, 29960.70039299579, 30030.099097027123, 30159.396812063198, 35926.10184745298, 36633.45049824201, 36764.080897976695, 36794.632053680194, 36916.446253306756, 29752.0, 30228.24429389283, 30371.088867334016, 30715.846420767753, 31448.52827207548, 19831.60336793285, 23127.0, 23702.866741993304, 24081.0, 24302.0], "value": 18359.98373797358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.78303843136473, 376.68546763452514, 387.4401489847172, 409.79715041054703, 455.2692927850799, 13514.932425337873, 19774.933253487034, 20661.896690516543, 21663.891680541616, 21872.125114995422, 19180.904095479502, 21183.788162118373, 22192.556148877055, 22512.437189070282, 22768.658470122962, 5498.9826882026955, 6293.999999999988, 6767.323267673218, 6808.5914845109455, 6808.6936087876165, 6608.834779130512, 6701.195856497227, 6753.831154221135, 6769.458443324522, 6819.0, 6470.74117035318, 6658.600483970953, 6710.127683401151, 6745.426638735713, 6782.050512928194, 6516.2731876052885, 6577.704003319862, 6623.7350505980185, 6723.125993620823, 6732.417881797749, 6393.168888044571, 6508.642024688687, 6509.4466970307585, 6514.674266286715, 6515.446187074057, 26880.924763009458, 27183.86408067967, 27212.183634490997, 27229.0, 27464.725352746416, 2970.910872673823, 2999.355138645202, 3000.699930007004, 3006.2634654509566, 3051.633803943541, 16020.460562067214, 16437.26032328548, 16718.08050557219, 16999.40502082421, 17332.480025599252, 1988.9701654475195, 2008.1365013044385, 2027.4120505053518, 2047.7440319960006, 2065.648839697255, 100328.0, 106902.0, 114196.4290178552, 114399.28401073991, 116298.0, 20643.07781521506, 20716.689249661267, 20763.27328543524, 20993.68509472359, 21615.45961350979, 33719.0, 33946.49080263798, 34521.82739086288, 34524.82737586346, 34585.0, 10282.742931426774, 10446.268761186797, 10643.148548116133, 10689.091427228617, 10794.298370605886, 8341.791455213668, 8682.479051256945, 8735.825283494294, 8895.421797583136, 8976.730698079067, 9956.303058785961, 10027.899721002697, 10105.5452504636, 10144.087032167141, 10149.904279194769, 4025.7785821780085, 4058.208240178864, 4078.5921407858978, 4108.219438306712, 4118.208579268028, 889.586342350797, 896.4262871762078, 909.6179604566098, 927.3601215161652, 950.353759443585, 21697.457563561038, 22393.55212895733, 22438.775612243997, 22624.547509049728, 22660.773392265866, 938.6620816506053, 941.8022215334856, 966.7873067925045, 967.5645959318335, 969.9030096990244, 10711.94644026775, 11261.493232804543, 11304.604338848101, 11438.656840294805, 12002.0, 776486.0, 790239.0, 797018.0, 806513.0, 815460.0, 102884.0, 158057.209713953, 160657.0, 165409.17295413447, 175129.0, 1326.7678156322604, 1339.370495866941, 1397.6645605054714, 1398.5384823008383, 1406.8452470228267, 18769.249230030648, 19062.856228626326, 19443.0, 19485.0, 19549.609007820047, 54769.26153692379, 60206.09690854728, 66518.0, 66531.0, 66962.66518667375, 94808.52595736977, 96243.51878240563, 96711.51644242015, 98382.0, 98535.0, 10412.68761937143, 10845.240833141605, 11326.207165498336, 11482.598109066143, 11686.415679215836, 11955.402229888297, 12684.936575317064, 12852.678683032998, 13202.405891735087, 13224.867751322749, 10110.69667909964, 10485.056344928993, 10852.67441976742, 11139.275947063416, 11399.487023083815, 10324.845127323246, 10382.844257336297, 10386.272960892666, 10509.684709458728, 10600.787984240118, 11053.0, 11196.83204751913, 11273.154513411691, 11332.206745527734, 11482.425878705864, 11299.0, 11308.660740177807, 11316.94341528287, 11342.262752921033, 11641.59254426125, 10727.302725322828, 11286.097112231166, 11303.547858085585, 11305.886941130813, 11317.886821131684], "value": 11541.440314362191, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.9393224271023, 1551.2631500037483, 1555.9844401555981, 1580.8656264217536, 1582.9762553561698, 10794.460276986149, 11441.370724610144, 11447.885521144806, 11450.942745286273, 11454.48454819533, 10671.946640266808, 10996.175286853479, 11111.666650000512, 11176.832347514794, 11194.160437967144, 2384.4754154086118, 2395.461021270209, 2419.9153029643967, 2421.5278020785954, 2435.2207293665947, 2304.8847557622053, 2364.645303204516, 2389.2593296078185, 2390.8326417150806, 2394.9042038318535, 2026.493376655836, 2321.767823217682, 2349.776771206741, 2387.1764241336796, 2399.064364897691, 2313.097891822191, 2344.800691941187, 2362.9645555316597, 2367.195153647751, 2368.83418160728, 2359.7050368703913, 2375.3705268103968, 2380.4762952150672, 2380.940476488084, 2384.237044145874, 10828.675139745741, 11050.944745276222, 11064.0, 11065.50205240766, 11071.114310855111, 5702.144678298247, 5805.0, 5853.5902486825935, 5888.205092312526, 5891.911621325684, 3524.436090225577, 3613.6205698401554, 3631.1285291529844, 3644.3075815594952, 3709.5733990591157, 1177.2112684501406, 1195.2171327780318, 1205.933673647949, 1232.48235740989, 1256.7298030923305, 13675.863241367559, 14036.789448158286, 14256.28718564078, 15530.068195908281, 15754.291056902352, 4161.708680392343, 4214.789260536961, 4321.265384884514, 4326.6754993375625, 4756.953470236543, 11670.474828632732, 11768.588099416651, 11776.88223117775, 11782.0, 11815.054795616503, 4879.853604391874, 5085.74571271435, 5785.971070144707, 5787.305523337142, 5791.623544469596, 5073.467285934998, 5236.711980841091, 5262.97368513155, 5283.207518872123, 5290.761915713802, 3838.0788610733225, 3845.3462911305146, 3861.092643228839, 3865.43951127085, 3884.1260716338597, 1024.2778840917135, 1026.3585259212991, 1034.9016843399866, 1047.9738006549744, 1048.0, 796.3828033274143, 904.5884122724144, 926.4719110107309, 938.5729493080632, 944.5041353289578, 6472.967635161888, 6536.150300460909, 6615.239247486505, 6649.503861631094, 6649.867002660017, 969.7187815533416, 982.729749318943, 994.5474808961905, 1000.7948370584013, 1051.8264486359817, 4086.0, 4217.135487225111, 4227.450431443893, 4344.261475549164, 4369.9126017479475, 13895.305234738222, 14389.928050359682, 14407.207603581903, 14407.78388324176, 14426.927865360605, 14275.357608907623, 14292.642683932776, 14310.57068287953, 14318.856811431753, 14330.641733956734, 9847.50762461874, 10183.490825458697, 10399.32404393712, 10404.375737455777, 10410.427426491615, 6532.869342613216, 6606.405423511907, 6619.735210591715, 6670.39966403026, 6705.195376554844, 12224.205426647239, 12505.874941250471, 12558.372081395712, 12565.308908009782, 12586.87413125857, 12404.19372740805, 12550.87449125497, 12556.497740090294, 12762.553310634083, 12847.743045139232, 8298.668053277801, 8500.14998500145, 8508.489490630582, 8509.659613615386, 8517.574121294034, 10184.490775461345, 10278.897211027794, 10307.072363487323, 10409.323393979366, 10421.583136674448, 8721.956390218009, 8783.516906569945, 8875.467471951704, 8925.73222803317, 9055.18503334703, 8609.741707748777, 8623.56882155877, 8657.177568131017, 8781.385303028726, 8900.777480563038, 6111.266648002268, 7762.534247945141, 7898.249666281694, 8010.158933311918, 8230.971128608924, 5727.8568035799435, 5866.090755932837, 5866.530677545701, 6059.969700151471, 6100.847478813065, 5419.810306639249, 5838.620489668158, 5930.584859059824, 5946.702664866826, 6080.331163571915], "value": 5119.5820472203495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6616211909979, 369.4015694574789, 378.52684144818977, 387.72084099448386, 389.06041908790274, 4236.555161708023, 4688.906221875561, 4849.77489969171, 4886.31591577179, 5119.692818430897, 4333.371661109145, 4521.123733650539, 4599.757171194308, 4911.75441227939, 4929.334539837121, 4275.904806644738, 4289.914201715964, 4325.653947684178, 4335.3063509838275, 4409.0, 3851.844446666003, 4215.49414070312, 4289.785510724451, 4308.418363520916, 4435.4233949586505, 3867.105118491933, 4275.209086319041, 4318.862163229206, 4364.934525982097, 4375.518692943773, 3780.584135745066, 4156.542780294165, 4195.895102622429, 4300.65594752419, 4301.462317210348, 4022.859199928018, 4089.3661482470266, 4089.5501494835844, 4111.280525907954, 4126.834926602963, 4370.934435983463, 4986.67586606873, 4997.400311962588, 5003.298878381332, 5018.573421259197, 4358.259095953696, 4699.412573428322, 5007.246014691941, 5081.65336185911, 5106.617003724736, 4398.6700997425005, 4828.975855120702, 5386.064594795806, 5432.348118225838, 5433.755481003364, 3881.4474210315816, 4132.33882578786, 4261.531231564525, 4738.8341408050555, 4741.976290118562, 4548.772561371951, 5344.91982620261, 5477.945220547784, 5706.429357064343, 5771.219850997603, 4254.851190178634, 4717.268823332389, 4737.8341758038305, 4759.95281038171, 4827.710337379768, 4346.760928148982, 4799.704079898408, 4815.951840481621, 4817.78319975602, 4910.116179087727, 4184.560621134737, 4638.953610463852, 4642.86071417858, 4750.5249475052215, 4927.733242708394, 4321.870343889688, 5139.717315547606, 5228.581713462914, 5246.501582349671, 5265.842024739264, 1317.0, 1371.8902487800951, 1374.9725005499834, 1414.8868090552937, 1470.0738534723057, 1222.3460448659923, 1237.5421094195206, 1242.6147894152841, 1283.6084994076896, 1389.4372779024511, 4768.594669453136, 4865.318855360252, 4892.651527266932, 4920.852374428773, 4960.305557221992, 4824.614030877521, 5077.822276220315, 5394.62237643369, 5462.262594549765, 5465.2562994349, 4297.78511074445, 4449.421575195204, 4449.933251001237, 4840.29815676732, 4869.659123861366, 2375.2541881716925, 2516.9370765731005, 2580.509703156394, 2771.9029833955715, 2855.528837741749, 4908.705477671351, 5480.654050350253, 5555.277863862216, 5573.5819813514145, 5602.4957753802355, 4475.328700694922, 5249.2126181073145, 5521.0, 5534.667919924817, 5557.972210138923, 4868.95131048692, 5187.0, 5406.405295417422, 5633.380328163817, 5677.870798450581, 4858.44127925279, 4904.852854414374, 5443.856790074129, 5477.02826982294, 5538.670719027324, 5171.482851714798, 5341.7062061586985, 5366.087765080024, 5367.302250707383, 5435.646682965595, 4759.714417134983, 5000.249962505508, 5049.57078648319, 5682.954136510935, 5735.218419066833, 3748.8875333738943, 4027.35562310029, 4052.2705912935953, 4102.569230230903, 4292.506361768436, 5008.9248661269385, 5436.755346009518, 5490.258815060076, 5669.291338582677, 5698.487136157766, 4836.975815120902, 4952.876178095432, 5249.317588713443, 5326.414094449685, 5431.782728690808, 4478.820847166076, 4542.432195975503, 4756.693003893179, 5262.552683021986, 5299.4700529946695, 4440.111977604557, 4547.386102876202, 4884.951150488591, 5111.779578865291, 5152.604039121827, 4556.498785133699, 5094.490550944876, 5127.564157046543, 5131.948680513147, 5249.162793022411, 5046.899062018666, 5084.339035925306, 5260.342457192851, 5331.3739309510975, 5333.466653334635], "value": 4117.546801372482, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6050591921481, 730.674849691887, 765.2500549461528, 817.7628487738555, 829.767665053785, 15361.769573456393, 16137.112458814761, 16161.434349797759, 16163.757543636855, 16199.0, 14470.493532726357, 14517.419303227858, 14541.345639446225, 14598.635034124125, 15137.394504219845, 751.9661615227328, 762.9580373079492, 784.6076961519241, 812.975610731676, 832.7293629570383, 943.6084025129563, 943.8537026760863, 944.6929747831948, 945.012461977232, 946.1768261612407, 993.1310103659298, 994.6717583197527, 995.2187532786763, 995.7809281957958, 997.5909876950452, 991.7520619845038, 991.8462638291004, 992.4491906991617, 994.820932232198, 995.7659949911765, 733.0982891044046, 734.2657342657343, 734.6143274780729, 735.7277807211366, 736.977890663281, 15886.76169857453, 16064.357425702958, 16086.597835054217, 16407.83592164075, 16606.66786664272, 13999.0, 14092.154470731686, 14149.929250353785, 14248.002639815217, 14297.213653249068, 11723.237989530653, 11776.175667703264, 11830.526778928832, 11846.46690898903, 12262.327504832048, 3528.59421166564, 3616.367135751233, 3632.963670363289, 3644.5626524816926, 3713.442983552489, 104694.0, 107697.46151269272, 108121.37817932737, 108278.0, 108465.0, 10300.175985921258, 10401.167906567456, 10671.092957098579, 10949.616763413242, 11307.49116289769, 21205.045772940255, 21501.78498215029, 21596.0, 21621.891890540446, 21934.670979935312, 7514.211007844207, 7598.354139898171, 7627.733029343946, 7714.0, 7727.729529466554, 4155.771432571238, 4205.222033923734, 4215.093754842724, 4225.830966761357, 4253.383259427365, 3423.1955490459723, 3478.2174010847357, 3483.860645574199, 3515.7890526567976, 3517.909448071106, 611.6574718157846, 617.5707883021257, 618.3785295777715, 631.1857703562445, 635.3233805996599, 610.3957082488394, 616.6566357187263, 644.44899610833, 647.2879832184653, 657.0833687006599, 9678.56446459911, 9684.32209745311, 9888.307818452638, 9964.20286377088, 10116.54475548602, 577.3302968556454, 628.644815679149, 640.177372076879, 644.2397970394885, 648.5557393185683, 3862.8454861805776, 4179.895502612459, 4775.42694876617, 4780.904381912343, 4784.497627749106, 102677.0, 105625.47187264015, 106329.46835265774, 110110.0, 111356.0, 52392.21411678828, 76804.2319576797, 88229.0, 89948.5502572483, 98191.50904245433, 67170.0, 68181.65909170422, 69585.95621065688, 70259.0, 70309.64845175741, 8828.0, 10878.456077196266, 10954.0, 11118.666440006813, 11202.38386888729, 37329.81335093307, 49670.751646242985, 49672.50327496679, 50823.745881270355, 51066.0, 63440.0, 64094.67952660207, 65745.67127164334, 65825.67087164725, 66908.3309166902, 12293.07801914878, 12347.444365003417, 12446.564370246997, 12627.810582841448, 12659.493620255087, 13704.794428083387, 13901.374438150106, 14361.569152925429, 14384.136951782926, 14568.41726330935, 12776.6805829855, 13107.475700971854, 13433.932830335785, 13530.79703804424, 13698.109622874481, 13512.59462216135, 13640.249786261851, 13774.0, 13816.792748108988, 13944.930275348559, 12808.551700690432, 12984.15602985803, 13364.866351336752, 13555.951899202119, 13827.170369777845, 9246.907530924605, 9748.0, 9843.064908833649, 9886.406815591088, 10301.587936482456, 8583.828323433372, 9341.953290233505, 9909.405435673883, 10962.945185274022, 11347.262427942487], "value": 7450.723808849179, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 109.0, 144.0, 110.0, 109.0, 110.0, 107.0, 128.0, 109.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 182.0, 196.0, 233.0, 251.0, 234.0, 184.0, 184.0, 184.0], "value": 201.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 61.0, 101.0, 62.0, 58.0, 61.0, 59.0, 76.0, 60.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 72.0, 97.0, 100.0, 82.0, 68.0, 68.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 87.0, 89.0, 88.0, 89.0, 88.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 98.0, 95.0, 94.0, 96.0, 98.0, 99.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 86.0, 85.0, 84.0, 85.0, 85.0, 83.0, 83.0, 84.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 64.0, 64.0, 65.0, 64.0, 62.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 70.0, 64.0, 60.0, 57.0, 57.0, 58.0, 60.0, 57.0, 56.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 83.0, 82.0, 86.0, 82.0, 87.0, 93.0, 105.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 137.0, 134.0, 134.0, 135.0, 139.0, 138.0, 180.0, 136.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 170.0, 142.0, 196.0, 221.0, 187.0, 164.0, 165.0, 164.0, 156.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 69.0, 82.0, 81.0, 83.0, 79.0, 64.0, 61.0, 62.0], "value": 71.2, "unit": "score"}]}]} 10:16:53 INFO - Return code: 0 10:16:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:53 ERROR - # TBPL SUCCESS # 10:16:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:53 INFO - 2017-03-29 10:16:53.802 screenresolution[1652:9702] starting screenresolution argv=screenresolution get 10:16:53 INFO - 2017-03-29 10:16:53.804 screenresolution[1652:9702] Display 0: 1600x1200x32@60 10:16:53 INFO - 2017-03-29 10:16:53.810 screenresolution[1653:9705] starting screenresolution argv=screenresolution list 10:16:53 INFO - Available Modes on Display 0 10:16:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:54 INFO - Intel Iris: 10:16:54 INFO - Chipset Model: Intel Iris 10:16:54 INFO - Type: GPU 10:16:54 INFO - Bus: Built-In 10:16:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:54 INFO - Vendor: Intel (0x8086) 10:16:54 INFO - Device ID: 0x0a2e 10:16:54 INFO - Revision ID: 0x0009 10:16:54 INFO - Displays: 10:16:54 INFO - Display: 10:16:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:54 INFO - Display Serial Number: 1600x1200 60 10:16:54 INFO - Main Display: Yes 10:16:54 INFO - Mirror: Off 10:16:54 INFO - Online: Yes 10:16:54 INFO - Rotation: Supported 10:16:54 INFO - Return code: 0 10:16:54 INFO - Running post-action listener: _resource_record_post_action 10:16:54 INFO - [mozharness: 2017-03-29 17:16:54.046398Z] Finished run-tests step (success) 10:16:54 INFO - Running post-run listener: _resource_record_post_run 10:16:54 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37942272; Write bytes: 510537216; Read time: 237; Write time: 1555 10:16:54 INFO - TinderboxPrint: CPU usage
53.9% 10:16:54 INFO - TinderboxPrint: I/O read bytes / time
37,942,272 / 237 10:16:54 INFO - TinderboxPrint: I/O write bytes / time
510,537,216 / 1,555 10:16:54 INFO - TinderboxPrint: CPU idle
2,216.2 (46.1%) 10:16:54 INFO - TinderboxPrint: CPU system
958.5 (19.9%) 10:16:54 INFO - TinderboxPrint: CPU user
1,631.1 (33.9%) 10:16:54 INFO - TinderboxPrint: Swap in / out
246,140,928 / 0 10:16:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205851136; Write bytes: 201517056; Read time: 15734; Write time: 426 10:16:54 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35836928; Write bytes: 297973248; Read time: 215; Write time: 1094 10:16:54 INFO - Running post-run listener: _upload_blobber_files 10:16:54 INFO - Blob upload gear active. 10:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:56 INFO - (blobuploader) - INFO - Done attempting. 10:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:57 INFO - (blobuploader) - INFO - Done attempting. 10:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:58 INFO - (blobuploader) - INFO - Done attempting. 10:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:00 INFO - (blobuploader) - INFO - Done attempting. 10:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:00 INFO - Return code: 0 10:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e74236aec864e073f2109f8e99ea324ebb9321e51b2c0f351087b06cbd53f621d81bf8aefa3d8fa2016f429c657c4693b18e0db07f739c4cede832c1f859b92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e42fea14221440d56fea3b991dfd2ff60548930c555e8bbf2a4b0937596b4be583340c75a6ffe0b23f5d23715804976fa23420a995ac3923b47930430d5efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36000912b498b289548dcfe979b9fe3e4583a87bc81f82f198513aaea266e8af28211a08d1626ec4fa08386c8f43c15b44ba27684d54260152adf943f27e942e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff391480c8a6ae31f168898eb507676e817ade0f81300361fa2703c6e457007d1360b1ae9eac33b70b9f58e678f3844854a9c66dd6812a2829ba5a3f63d4295c"} 10:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:00 INFO - Contents: 10:17:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e74236aec864e073f2109f8e99ea324ebb9321e51b2c0f351087b06cbd53f621d81bf8aefa3d8fa2016f429c657c4693b18e0db07f739c4cede832c1f859b92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e42fea14221440d56fea3b991dfd2ff60548930c555e8bbf2a4b0937596b4be583340c75a6ffe0b23f5d23715804976fa23420a995ac3923b47930430d5efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36000912b498b289548dcfe979b9fe3e4583a87bc81f82f198513aaea266e8af28211a08d1626ec4fa08386c8f43c15b44ba27684d54260152adf943f27e942e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff391480c8a6ae31f168898eb507676e817ade0f81300361fa2703c6e457007d1360b1ae9eac33b70b9f58e678f3844854a9c66dd6812a2829ba5a3f63d4295c"} 10:17:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:00 INFO - Copying logs to upload dir... 10:17:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.292650 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-29 10:17:00.305328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 10:17:00.309062) ========= 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.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e74236aec864e073f2109f8e99ea324ebb9321e51b2c0f351087b06cbd53f621d81bf8aefa3d8fa2016f429c657c4693b18e0db07f739c4cede832c1f859b92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e42fea14221440d56fea3b991dfd2ff60548930c555e8bbf2a4b0937596b4be583340c75a6ffe0b23f5d23715804976fa23420a995ac3923b47930430d5efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36000912b498b289548dcfe979b9fe3e4583a87bc81f82f198513aaea266e8af28211a08d1626ec4fa08386c8f43c15b44ba27684d54260152adf943f27e942e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff391480c8a6ae31f168898eb507676e817ade0f81300361fa2703c6e457007d1360b1ae9eac33b70b9f58e678f3844854a9c66dd6812a2829ba5a3f63d4295c"} build_url:https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011043 build_url: 'https://queue.taskcluster.net/v1/task/DiKvZ1N-QQy2KMTYoolEGw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e74236aec864e073f2109f8e99ea324ebb9321e51b2c0f351087b06cbd53f621d81bf8aefa3d8fa2016f429c657c4693b18e0db07f739c4cede832c1f859b92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e42fea14221440d56fea3b991dfd2ff60548930c555e8bbf2a4b0937596b4be583340c75a6ffe0b23f5d23715804976fa23420a995ac3923b47930430d5efb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36000912b498b289548dcfe979b9fe3e4583a87bc81f82f198513aaea266e8af28211a08d1626ec4fa08386c8f43c15b44ba27684d54260152adf943f27e942e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff391480c8a6ae31f168898eb507676e817ade0f81300361fa2703c6e457007d1360b1ae9eac33b70b9f58e678f3844854a9c66dd6812a2829ba5a3f63d4295c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 10:17:00.344243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 10:17:00.344716) ========= 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.ERH2LbGeHV/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.2rTm3qsk22/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 10:17:00.393485) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 10:17:00.393860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 10:17:00.394203) ========= ========= Total master_lag: 0.19 =========