builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1491217059.08 results: success (0) buildid: 20170403022922 builduid: e11d517989514f19b01f71617b6ad914 revision: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.083664) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.084102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.084377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.129649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.129995) ========= 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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-04-03 03:57:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-04-03 03:57:39 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137334 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.291953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.292267) ========= 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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.027395 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:39.340975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:57:39.341315) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c53411a2c11f43f6ea567fbb38efcf79b08bcf28 --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 c53411a2c11f43f6ea567fbb38efcf79b08bcf28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-04-03 03:57:39,408 truncating revision to first 12 chars 2017-04-03 03:57:39,409 Setting DEBUG logging. 2017-04-03 03:57:39,409 attempt 1/10 2017-04-03 03:57:39,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c53411a2c11f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 03:57:40,299 unpacking tar archive at: mozilla-aurora-c53411a2c11f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.165907 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 03:57:40.531030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:40.531352) ========= script_repo_revision: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:40.531780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:40.532045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 03:57:40.552359) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-03 03:57:40.552772) ========= /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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:57:40 INFO - MultiFileLogger online at 20170403 03:57:40 in /builds/slave/test 03:57:40 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 03:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:40 INFO - {'append_to_log': False, 03:57:40 INFO - 'base_work_dir': '/builds/slave/test', 03:57:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:40 INFO - 'branch': 'Mozilla-Aurora', 03:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:40 INFO - 'config_files': ('talos/mac_config.py',), 03:57:40 INFO - 'default_actions': ('clobber', 03:57:40 INFO - 'read-buildbot-config', 03:57:40 INFO - 'download-and-extract', 03:57:40 INFO - 'populate-webroot', 03:57:40 INFO - 'create-virtualenv', 03:57:40 INFO - 'install', 03:57:40 INFO - 'run-tests'), 03:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:40 INFO - 'download_minidump_stackwalk': True, 03:57:40 INFO - 'download_symbols': 'ondemand', 03:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:40 INFO - 'gecko_profile': False, 03:57:40 INFO - 'gecko_profile_interval': 0, 03:57:40 INFO - 'installer_path': 'installer.exe', 03:57:40 INFO - 'log_level': 'info', 03:57:40 INFO - 'log_name': 'talos', 03:57:40 INFO - 'log_to_console': True, 03:57:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:57:40 INFO - 'opt_config_files': (), 03:57:40 INFO - 'pip_index': False, 03:57:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:40 INFO - 'cmd': ('bash', 03:57:40 INFO - '-c', 03:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:40 INFO - 'enabled': True, 03:57:40 INFO - 'halt_on_failure': False, 03:57:40 INFO - 'name': 'check_screen_resolution'},), 03:57:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:40 INFO - 'cmd': ('bash', 03:57:40 INFO - '-c', 03:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:40 INFO - 'enabled': True, 03:57:40 INFO - 'halt_on_failure': False, 03:57:40 INFO - 'name': 'check_screen_resolution'},), 03:57:40 INFO - 'run_cmd_checks_enabled': True, 03:57:40 INFO - 'suite': 'dromaeojs', 03:57:40 INFO - 'system_bits': '32', 03:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:40 INFO - 'title': 't-yosemite-r7-0321', 03:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:40 INFO - 'use_talos_json': True, 03:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:40 INFO - 'work_dir': 'build'} 03:57:40 INFO - [mozharness: 2017-04-03 10:57:40.728493Z] Running clobber step. 03:57:40 INFO - Running pre-action listener: _resource_record_pre_action 03:57:40 INFO - Running main action method: clobber 03:57:40 INFO - rmtree: /builds/slave/test/build 03:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:43 INFO - Running post-action listener: _resource_record_post_action 03:57:43 INFO - [mozharness: 2017-04-03 10:57:43.221567Z] Finished clobber step (success) 03:57:43 INFO - [mozharness: 2017-04-03 10:57:43.221733Z] Running read-buildbot-config step. 03:57:43 INFO - Running pre-action listener: _resource_record_pre_action 03:57:43 INFO - Running main action method: read_buildbot_config 03:57:43 INFO - Using buildbot properties: 03:57:43 INFO - { 03:57:43 INFO - "project": "", 03:57:43 INFO - "product": "firefox", 03:57:43 INFO - "script_repo_revision": "production", 03:57:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:57:43 INFO - "repository": "", 03:57:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:57:43 INFO - "buildid": "20170403022922", 03:57:43 INFO - "pgo_build": "False", 03:57:43 INFO - "basedir": "/builds/slave/test", 03:57:43 INFO - "buildnumber": 83, 03:57:43 INFO - "slavename": "t-yosemite-r7-0321", 03:57:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:57:43 INFO - "platform": "yosemite_r7", 03:57:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:57:43 INFO - "branch": "mozilla-aurora", 03:57:43 INFO - "repo_path": "releases/mozilla-aurora", 03:57:43 INFO - "revision": "c53411a2c11f43f6ea567fbb38efcf79b08bcf28", 03:57:43 INFO - "stage_platform": "macosx64", 03:57:43 INFO - "builduid": "e11d517989514f19b01f71617b6ad914", 03:57:43 INFO - "slavebuilddir": "test" 03:57:43 INFO - } 03:57:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:57:43 INFO - Running post-action listener: _resource_record_post_action 03:57:43 INFO - [mozharness: 2017-04-03 10:57:43.225023Z] Finished read-buildbot-config step (success) 03:57:43 INFO - [mozharness: 2017-04-03 10:57:43.225132Z] Running download-and-extract step. 03:57:43 INFO - Running pre-action listener: _resource_record_pre_action 03:57:43 INFO - Running main action method: download_and_extract 03:57:43 INFO - mkdir: /builds/slave/test/build/tests 03:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:43 INFO - trying https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:57:43 INFO - Downloading https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:57:44 INFO - Downloaded 1199 bytes. 03:57:44 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:57:44 INFO - Using the following test package requirements: 03:57:44 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:57:44 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:57:44 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:57:44 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'jsshell-mac.zip'], 03:57:44 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:57:44 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:57:44 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:57:44 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:57:44 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:57:44 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:57:44 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:57:44 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:57:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:57:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:57:44 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:57:46 INFO - Expected file size: 51788822 03:57:46 INFO - Obtained file size: 51788822 03:58:02 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 03:58:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:58:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:58:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:58:03 INFO - Expected file size: 51788822 03:58:03 INFO - Obtained file size: 51788822 03:58:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:58:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:58:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:58:21 INFO - Expected file size: 14404438 03:58:21 INFO - Obtained file size: 14404438 03:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:21 INFO - trying https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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 03:58:23 INFO - Downloaded 74661606 bytes. 03:58:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:23 INFO - mkdir: /builds/slave/test/properties 03:58:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:23 INFO - Contents: 03:58:23 INFO - build_url:https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:58:24 INFO - Running post-action listener: _resource_record_post_action 03:58:24 INFO - Running post-action listener: set_extra_try_arguments 03:58:24 INFO - [mozharness: 2017-04-03 10:58:24.367494Z] Finished download-and-extract step (success) 03:58:24 INFO - [mozharness: 2017-04-03 10:58:24.367619Z] Running populate-webroot step. 03:58:24 INFO - Running pre-action listener: _resource_record_pre_action 03:58:24 INFO - Running main action method: populate_webroot 03:58:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:24 INFO - '--tppagecycles', 03:58:24 INFO - '7'], 03:58:24 INFO - 'tests': ['tsvgm']}}, 03:58:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['damp', 'tps']}, 03:58:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'tests': ['damp', 'tps']}, 03:58:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['dromaeo_dom']}, 03:58:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['basic_compositor_video']}, 03:58:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['a11yr', 03:58:24 INFO - 'ts_paint', 03:58:24 INFO - 'tpaint', 03:58:24 INFO - 'sessionrestore', 03:58:24 INFO - 'sessionrestore_no_auto_restore', 03:58:24 INFO - 'tabpaint']}, 03:58:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['tsvgx', 03:58:24 INFO - 'tsvgr_opacity', 03:58:24 INFO - 'tart', 03:58:24 INFO - 'tscrollx', 03:58:24 INFO - 'cart', 03:58:24 INFO - 'tsvg_static']}, 03:58:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:24 INFO - 'tsvgr_opacity', 03:58:24 INFO - 'tart', 03:58:24 INFO - 'tscrollx', 03:58:24 INFO - 'cart', 03:58:24 INFO - 'tsvg_static']}, 03:58:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'talos_options': ['--disable-e10s'], 03:58:24 INFO - 'tests': ['tp5o']}, 03:58:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:58:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'talos_options': ['--disable-e10s', 03:58:24 INFO - '--xperf_path', 03:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:24 INFO - 'tests': ['tp5n']}, 03:58:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:58:24 INFO - 'talos_options': ['--xperf_path', 03:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:24 INFO - 'tests': ['tp5n']}}, 03:58:24 INFO - 'talos.zip': {'path': '', 03:58:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:24 INFO - Running post-action listener: _resource_record_post_action 03:58:24 INFO - [mozharness: 2017-04-03 10:58:24.385881Z] Finished populate-webroot step (success) 03:58:24 INFO - [mozharness: 2017-04-03 10:58:24.386014Z] Running create-virtualenv step. 03:58:24 INFO - Running pre-action listener: _resource_record_pre_action 03:58:24 INFO - Running main action method: create_virtualenv 03:58:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:24 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 03:58:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:24 INFO - Using real prefix '/tools/python27' 03:58:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:28 INFO - Installing pip.................done. 03:58:28 INFO - Return code: 0 03:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:58:28 INFO - Reading from file tmpfile_stdout 03:58:28 INFO - Output received: 03:58:28 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) 03:58:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58: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', 'pip>=1.5'] in /builds/slave/test/build 03:58: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 pip>=1.5 03:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:28 INFO - 'HOME': '/Users/cltbld', 03:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:28 INFO - 'LOGNAME': 'cltbld', 03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:28 INFO - 'MOZ_NO_REMOTE': '1', 03:58:28 INFO - 'NO_EM_RESTART': '1', 03:58:28 INFO - 'PAGER': '/bin/cat', 03:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:28 INFO - 'PWD': '/builds/slave/test', 03:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:28 INFO - 'SHELL': '/bin/bash', 03:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:28 INFO - 'USER': 'cltbld', 03:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:28 INFO - 'XPC_FLAGS': '0x0', 03:58:28 INFO - 'XPC_SERVICE_NAME': '0', 03:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:58:28 INFO - Cleaning up... 03:58:28 INFO - Return code: 0 03:58:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:28 INFO - 'HOME': '/Users/cltbld', 03:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:28 INFO - 'LOGNAME': 'cltbld', 03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:28 INFO - 'MOZ_NO_REMOTE': '1', 03:58:28 INFO - 'NO_EM_RESTART': '1', 03:58:28 INFO - 'PAGER': '/bin/cat', 03:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:28 INFO - 'PWD': '/builds/slave/test', 03:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:28 INFO - 'SHELL': '/bin/bash', 03:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:28 INFO - 'USER': 'cltbld', 03:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:28 INFO - 'XPC_FLAGS': '0x0', 03:58:28 INFO - 'XPC_SERVICE_NAME': '0', 03:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:28 INFO - Downloading/unpacking psutil>=3.1.1 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:32 INFO - Installing collected packages: psutil 03:58:32 INFO - Running setup.py install for psutil 03:58:32 INFO - building 'psutil._psutil_osx' extension 03:58:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:58:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:58:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:58:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:58:33 INFO - building 'psutil._psutil_posix' extension 03:58:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:58:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:58:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:58:33 INFO - ^ 03:58:33 INFO - 1 warning generated. 03:58:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:33 INFO - Successfully installed psutil 03:58:33 INFO - Cleaning up... 03:58:33 INFO - Return code: 0 03:58:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:33 INFO - 'HOME': '/Users/cltbld', 03:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:33 INFO - 'LOGNAME': 'cltbld', 03:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:33 INFO - 'MOZ_NO_REMOTE': '1', 03:58:33 INFO - 'NO_EM_RESTART': '1', 03:58:33 INFO - 'PAGER': '/bin/cat', 03:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:33 INFO - 'PWD': '/builds/slave/test', 03:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:33 INFO - 'SHELL': '/bin/bash', 03:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:33 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:33 INFO - 'USER': 'cltbld', 03:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:33 INFO - 'XPC_FLAGS': '0x0', 03:58:33 INFO - 'XPC_SERVICE_NAME': '0', 03:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:36 INFO - Installing collected packages: mozsystemmonitor 03:58:36 INFO - Running setup.py install for mozsystemmonitor 03:58:36 INFO - Successfully installed mozsystemmonitor 03:58:36 INFO - Cleaning up... 03:58:36 INFO - Return code: 0 03:58:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:37 INFO - 'HOME': '/Users/cltbld', 03:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:37 INFO - 'LOGNAME': 'cltbld', 03:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:37 INFO - 'MOZ_NO_REMOTE': '1', 03:58:37 INFO - 'NO_EM_RESTART': '1', 03:58:37 INFO - 'PAGER': '/bin/cat', 03:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:37 INFO - 'PWD': '/builds/slave/test', 03:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:37 INFO - 'SHELL': '/bin/bash', 03:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:37 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:37 INFO - 'USER': 'cltbld', 03:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:37 INFO - 'XPC_FLAGS': '0x0', 03:58:37 INFO - 'XPC_SERVICE_NAME': '0', 03:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:41 INFO - warning: no files found matching '*.txt' 03:58:41 INFO - no previously-included directories found matching 'build' 03:58:41 INFO - no previously-included directories found matching 'dist' 03:58:41 INFO - no previously-included directories found matching '.git*' 03:58:41 INFO - Installing collected packages: jsonschema, functools32 03:58:41 INFO - Running setup.py install for functools32 03:58:41 INFO - warning: no files found matching '*.txt' 03:58:41 INFO - no previously-included directories found matching 'build' 03:58:41 INFO - no previously-included directories found matching 'dist' 03:58:41 INFO - no previously-included directories found matching '.git*' 03:58:41 INFO - Successfully installed jsonschema functools32 03:58:41 INFO - Cleaning up... 03:58:41 INFO - Return code: 0 03:58:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:41 INFO - 'HOME': '/Users/cltbld', 03:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PAGER': '/bin/cat', 03:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test', 03:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:41 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - 'XPC_FLAGS': '0x0', 03:58:41 INFO - 'XPC_SERVICE_NAME': '0', 03:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:58:41 INFO - Cleaning up... 03:58:41 INFO - Return code: 0 03:58:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:41 INFO - 'HOME': '/Users/cltbld', 03:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PAGER': '/bin/cat', 03:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test', 03:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:41 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - 'XPC_FLAGS': '0x0', 03:58:41 INFO - 'XPC_SERVICE_NAME': '0', 03:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:45 INFO - Downloading docopt-0.6.1.tar.gz 03:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:46 INFO - Running setup.py install for blobuploader 03:58:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:46 INFO - Running setup.py install for requests 03:58:46 INFO - Running setup.py install for docopt 03:58:46 INFO - Successfully installed blobuploader requests docopt 03:58:46 INFO - Cleaning up... 03:58:46 INFO - Return code: 0 03:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:46 INFO - 'HOME': '/Users/cltbld', 03:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:46 INFO - 'LOGNAME': 'cltbld', 03:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:46 INFO - 'MOZ_NO_REMOTE': '1', 03:58:46 INFO - 'NO_EM_RESTART': '1', 03:58:46 INFO - 'PAGER': '/bin/cat', 03:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:46 INFO - 'PWD': '/builds/slave/test', 03:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:46 INFO - 'SHELL': '/bin/bash', 03:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:46 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:46 INFO - 'USER': 'cltbld', 03:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:46 INFO - 'XPC_FLAGS': '0x0', 03:58:46 INFO - 'XPC_SERVICE_NAME': '0', 03:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-K67Fa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-pcL_fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-w4gMoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-8H_Wbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xjjPVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CF5tiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-LYLwpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZHTfHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-LklFnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-cHD5Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-JSN59Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dc97xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-v0TPFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-O4ERia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YTuPV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-qLJwAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-2baKq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:48 INFO - Running setup.py install for manifestparser 03:58:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozcrash 03:58:49 INFO - Running setup.py install for mozdebug 03:58:49 INFO - Running setup.py install for mozdevice 03:58:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozfile 03:58:49 INFO - Running setup.py install for mozhttpd 03:58:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozinfo 03:58:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozInstall 03:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozleak 03:58:50 INFO - Running setup.py install for mozlog 03:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for moznetwork 03:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozprocess 03:58:50 INFO - Running setup.py install for mozprofile 03:58:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozrunner 03:58:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:58:51 INFO - Running setup.py install for mozscreenshot 03:58:51 INFO - Running setup.py install for moztest 03:58:51 INFO - Running setup.py install for mozversion 03:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:51 INFO - Cleaning up... 03:58:51 INFO - Return code: 0 03:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:51 INFO - 'HOME': '/Users/cltbld', 03:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:51 INFO - 'LOGNAME': 'cltbld', 03:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:51 INFO - 'MOZ_NO_REMOTE': '1', 03:58:51 INFO - 'NO_EM_RESTART': '1', 03:58:51 INFO - 'PAGER': '/bin/cat', 03:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:51 INFO - 'PWD': '/builds/slave/test', 03:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:51 INFO - 'SHELL': '/bin/bash', 03:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:51 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:51 INFO - 'USER': 'cltbld', 03:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:51 INFO - 'XPC_FLAGS': '0x0', 03:58:51 INFO - 'XPC_SERVICE_NAME': '0', 03:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dMRB6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YJrKPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:52 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)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xMOV78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:52 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)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ByLA8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-uHzSgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6Snokx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RqbP0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-sieHL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-nonn73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xe3kVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Q48r6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:53 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)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Qvx_0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:53 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)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-vYB867-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-k_evrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-tT3gko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iYL7NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-I89_F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:56 INFO - Downloading blessings-1.6.tar.gz 03:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:56 INFO - Installing collected packages: blessings 03:58:56 INFO - Running setup.py install for blessings 03:58:56 INFO - Successfully installed blessings 03:58:56 INFO - Cleaning up... 03:58:56 INFO - Return code: 0 03:58:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:56 INFO - Reading from file tmpfile_stdout 03:58:56 INFO - Current package versions: 03:58:56 INFO - blessings == 1.6 03:58:56 INFO - blobuploader == 1.2.4 03:58:56 INFO - docopt == 0.6.1 03:58:56 INFO - functools32 == 3.2.3-2 03:58:56 INFO - jsonschema == 2.5.1 03:58:56 INFO - manifestparser == 1.1 03:58:56 INFO - mozInstall == 1.12 03:58:56 INFO - mozcrash == 1.0 03:58:56 INFO - mozdebug == 0.1 03:58:56 INFO - mozdevice == 0.49 03:58:56 INFO - mozfile == 1.2 03:58:56 INFO - mozhttpd == 0.7 03:58:56 INFO - mozinfo == 0.9 03:58:56 INFO - mozleak == 0.1 03:58:56 INFO - mozlog == 3.4 03:58:56 INFO - moznetwork == 0.27 03:58:56 INFO - mozprocess == 0.25 03:58:56 INFO - mozprofile == 0.28 03:58:56 INFO - mozrunner == 6.13 03:58:56 INFO - mozscreenshot == 0.1 03:58:56 INFO - mozsystemmonitor == 0.3 03:58:56 INFO - moztest == 0.8 03:58:56 INFO - mozversion == 1.4 03:58:56 INFO - psutil == 3.1.1 03:58:56 INFO - requests == 1.2.3 03:58:56 INFO - wsgiref == 0.1.2 03:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:56 INFO - 'HOME': '/Users/cltbld', 03:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:56 INFO - 'LOGNAME': 'cltbld', 03:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:56 INFO - 'MOZ_NO_REMOTE': '1', 03:58:56 INFO - 'NO_EM_RESTART': '1', 03:58:56 INFO - 'PAGER': '/bin/cat', 03:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:56 INFO - 'PWD': '/builds/slave/test', 03:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:56 INFO - 'SHELL': '/bin/bash', 03:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:56 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:56 INFO - 'USER': 'cltbld', 03:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:56 INFO - 'XPC_FLAGS': '0x0', 03:58:56 INFO - 'XPC_SERVICE_NAME': '0', 03:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 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)) 03:58:57 INFO - Cleaning up... 03:58:57 INFO - Return code: 0 03:58:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:57 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')]} 03:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:57 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')]} 03:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:57 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 0x10e9d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe71b58c070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, '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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 03:58:57 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 03:58:57 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 03:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:57 INFO - 'HOME': '/Users/cltbld', 03:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:57 INFO - 'LOGNAME': 'cltbld', 03:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:57 INFO - 'MOZ_NO_REMOTE': '1', 03:58:57 INFO - 'NO_EM_RESTART': '1', 03:58:57 INFO - 'PAGER': '/bin/cat', 03:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:57 INFO - 'PWD': '/builds/slave/test', 03:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:57 INFO - 'SHELL': '/bin/bash', 03:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:58:57 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:57 INFO - 'USER': 'cltbld', 03:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:57 INFO - 'XPC_FLAGS': '0x0', 03:58:57 INFO - 'XPC_SERVICE_NAME': '0', 03:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:57 INFO - Cleaning up... 03:58:57 INFO - Return code: 0 03:58:57 INFO - Running post-action listener: _resource_record_post_action 03:58:57 INFO - Running post-action listener: _start_resource_monitoring 03:58:57 INFO - Starting resource monitoring. 03:58:57 INFO - [mozharness: 2017-04-03 10:58:57.444826Z] Finished create-virtualenv step (success) 03:58:57 INFO - [mozharness: 2017-04-03 10:58:57.445864Z] Running install step. 03:58:57 INFO - Running pre-action listener: _resource_record_pre_action 03:58:57 INFO - Running main action method: install 03:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:57 INFO - Reading from file tmpfile_stdout 03:58:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:57 INFO - Reading from file tmpfile_stdout 03:58:57 INFO - Output received: 03:58:57 INFO - Usage: mozinstall [options] installer 03:58:57 INFO - Options: 03:58:57 INFO - -h, --help show this help message and exit 03:58:57 INFO - -d DEST, --destination=DEST 03:58:57 INFO - Directory to install application into. [default: 03:58:57 INFO - "/builds/slave/test"] 03:58:57 INFO - --app=APP Application being installed. [default: firefox] 03:58:57 INFO - mkdir: /builds/slave/test/build/application 03:58:57 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'] 03:58:57 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 03:59:17 INFO - Reading from file tmpfile_stdout 03:59:17 INFO - Output received: 03:59:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:59:17 INFO - Running post-action listener: _resource_record_post_action 03:59:17 INFO - [mozharness: 2017-04-03 10:59:17.846842Z] Finished install step (success) 03:59:17 INFO - [mozharness: 2017-04-03 10:59:17.847020Z] Running run-tests step. 03:59:17 INFO - Running pre-action listener: _resource_record_pre_action 03:59:17 INFO - Running main action method: run_tests 03:59:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:17 INFO - 2017-04-03 03:59:17.861 screenresolution[1629:7618] starting screenresolution argv=screenresolution get 03:59:17 INFO - 2017-04-03 03:59:17.864 screenresolution[1629:7618] Display 0: 1600x1200x32@60 03:59:17 INFO - 2017-04-03 03:59:17.869 screenresolution[1630:7621] starting screenresolution argv=screenresolution list 03:59:17 INFO - Available Modes on Display 0 03:59:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:18 INFO - Intel Iris: 03:59:18 INFO - Chipset Model: Intel Iris 03:59:18 INFO - Type: GPU 03:59:18 INFO - Bus: Built-In 03:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:18 INFO - Vendor: Intel (0x8086) 03:59:18 INFO - Device ID: 0x0a2e 03:59:18 INFO - Revision ID: 0x0009 03:59:18 INFO - Displays: 03:59:18 INFO - Display: 03:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:18 INFO - Display Serial Number: 1600x1200 60 03:59:18 INFO - Main Display: Yes 03:59:18 INFO - Mirror: Off 03:59:18 INFO - Online: Yes 03:59:18 INFO - Rotation: Supported 03:59:18 INFO - Return code: 0 03:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:18 INFO - Python 2.7.3 03:59:18 INFO - Return code: 0 03:59:18 INFO - grabbing minidump binary from tooltool 03:59:18 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')]} 03:59:18 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 0x10e7b5d30>, '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 0x10e6dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7aabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:18 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 03:59:18 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 03:59:18 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 03:59:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:18 INFO - Return code: 0 03:59:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:59:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:18 INFO - ENV: RUST_BACKTRACE is now 1 03:59:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:59:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:18 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 03:59:18 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 03:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fZ1YwdJw8h/Render', 03:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:18 INFO - 'HOME': '/Users/cltbld', 03:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:18 INFO - 'LOGNAME': 'cltbld', 03:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:18 INFO - 'MOZ_NO_REMOTE': '1', 03:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:18 INFO - 'NO_EM_RESTART': '1', 03:59:18 INFO - 'PAGER': '/bin/cat', 03:59:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:18 INFO - 'PWD': '/builds/slave/test', 03:59:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:18 INFO - 'RUST_BACKTRACE': '1', 03:59:18 INFO - 'SHELL': '/bin/bash', 03:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbaUMJz9eH/Listeners', 03:59:18 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 03:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:18 INFO - 'USER': 'cltbld', 03:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:18 INFO - 'XPC_FLAGS': '0x0', 03:59:18 INFO - 'XPC_SERVICE_NAME': '0', 03:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:18 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/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 03:59:18 INFO - mozversion application_buildid: 20170403022922 03:59:18 INFO - mozversion application_changeset: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 03:59:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:59:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:18 INFO - mozversion application_name: Firefox 03:59:18 INFO - mozversion application_remotingname: firefox-dev 03:59:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:18 INFO - mozversion application_vendor: Mozilla 03:59:18 INFO - mozversion application_version: 54.0a2 03:59:18 INFO - mozversion platform_buildid: 20170403022922 03:59:18 INFO - mozversion platform_changeset: c53411a2c11f43f6ea567fbb38efcf79b08bcf28 03:59:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:59:18 INFO - mozversion platform_version: 54.0a2 03:59:18 INFO - using testdate: 1491217158 03:59:18 INFO - actual date: 1491217158 03:59:18 INFO - starting webserver on 'localhost:49237' 03:59:18 INFO - SUITE-START | Running 2 tests 03:59:18 INFO - TEST-START | dromaeo_css 03:59:18 INFO - operating with platform_type : mac_ 03:59:18 INFO - Initialising browser for dromaeo_css test... 03:59:18 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpIsiD6D/profile http://localhost:49237/getInfo.html) 03:59:21 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 03:59:21 INFO - PROCESS | 1640 | colorDepth:24 03:59:21 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 03:59:21 INFO - PROCESS | 1640 | __metrics 03:59:21 INFO - PROCESS | 1640 | 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" 03:59:21 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:21 INFO - TEST-INFO | 1640: exit 0 03:59:21 INFO - Browser initialized. 03:59:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpIsiD6D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:34 INFO - PROCESS | 1642 | RSS: Main: 215171072 03:59:34 INFO - PROCESS | 1642 | 04:02:38 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 04:02:40 INFO - PROCESS | 1642 | RSS: Main: 432750592 04:02:40 INFO - PROCESS | 1642 | 04:04:23 INFO - PROCESS | 1642 | ************************* 04:04:23 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 04:04:23 INFO - PROCESS | 1642 | 04:04:23 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:04:23 INFO - PROCESS | 1642 | Full stack: 04:04:23 INFO - PROCESS | 1642 | ************************* 04:05:43 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 04:05:44 INFO - PROCESS | 1642 | RSS: Main: 350056448 04:05:44 INFO - PROCESS | 1642 | 04:08:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 04:08:47 INFO - PROCESS | 1642 | RSS: Main: 337793024 04:08:47 INFO - PROCESS | 1642 | 04:11:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 04:11:50 INFO - PROCESS | 1642 | RSS: Main: 322486272 04:11:50 INFO - PROCESS | 1642 | 04:14:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 04:14:55 INFO - PROCESS | 1642 | RSS: Main: 321716224 04:14:55 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 04:17:58 INFO - PROCESS | 1642 | RSS: Main: 489934848 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | __start_tp_report 04:17:58 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 04:17:58 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 04:17:58 INFO - PROCESS | 1642 | |i|pagename|runs| 04:17:58 INFO - PROCESS | 1642 | |0;dojo.html;2993.9850300748494;3372.494125881116;3397.5413319201903;3401.9149521261966;3407.420738474459;5206.895862082756;5626.971865140668;5925.200097986776;5987.161797348374;6001.579889407743;5893.528517718583;5946.554008449362;5965.135055416962;5982.371850955652;6005.3394126646035;5337.866553336159;5356.196570514415;5382.811601593945;5410.594205434589;5488.286522752037;5264.947350526484;5267.604929630274;5312.362516498026;5469.863253418676;5472.151816468454;5350.063738845686;5372.489613486732;5378.946210537883;5380.488853558905;5390.757415916273;5376.059189641797;5379.246905433203;5379.704116273603;5380;5386.13821788512;5206.505381988705;5323.707196104213;5331.067063263952;5335;5354.250404943311;5877.794277200277;5878.441548052928;5880.029795083806;5886.852828679274;5895.941040589582;5242.7378631068295;6281.811545653638;6308.495320374359;6316.115743795872;6324.620522768649;6302.401271879165;6348;6355.650439225841;6400.03999400089;6403.647799371032;5055.266986287004;5975.1037344398255;6034.969825150846;6038.245219347582;6065.939340606582;6293.811185664437;6380.776672816429;6465.870682586369;6473.996530537775;6494.188226471691;6214.906776398358;6218.22272215973;6238.750449982041;6288.088227207121;6328.968355158195;6402.903956440658;6403.391677790602;6421.389967953037;6423.678816059271;6429.774957876545;6305.936940630535;6421.197350331208;6438.163038804925;6460;6460.515461340418;6197.566170368121;6243.469305109116;6397.072424498421;6447.838804029937;6473;4635.165670179333;5127.435982041972;5175.896482070338;5176.948230517722;5207.661502002357;4559.452865656076;4563.178627846953;4572.428446444194;4572.497025327211;4596.37948876904;5768.250127483484;5813.651180929158;5996.700164991733;6055.666938318434;6057.969710151509;6327.17746692927;6353.96823015882;6371.299157092716;6419.51853610981;6435.22777266731;6041.093835924647;6057.42454466825;6057.575969682168;6068.514518838482;6069.15031895535;5652.123920792284;5654.9151762723595;5656.971715141398;5658.688772117573;5669.177969194444;6238.157848690369;6361.936380636134;6440.549161558646;6448.419642232034;6595.373439523238;6375.5218358624215;6397.680115994089;6401.391867772554;6414.903776443451;6432.195975503062;6502.349765023459;6591.736330546724;6593;6603.20761508622;6604.504662150454;6218.875622487615;6265.498760099273;6416.326285740117;6429;6451.032345148265;6283.151774510383;6351.396617321347;6359.96820015897;6381.010943303795;6396.968015159894;6366.267879193952;6366.872662546816;6373.776917807854;6373.93626063752;6385.201849768779;6128.9693551531955;6274.1843560336865;6285.088662144055;6352.460040896575;6352.777652782131;6065.60573562717;6069.423404776539;6073.605215660968;6092.664903430176;6102.786402475892;6209.2548894133;6278.434940855345;6298.11826344303;6385.584936979081;6394.6482943436695;5951.494122999594;5997.610155339889;6029.87940241184;6139.447449729546;6218.22272215973 04:17:58 INFO - PROCESS | 1642 | |1;ext.html;752.1575835064727;788.6805843633329;848.2492993700573;861.4271509446219;934.5887809363875;36907.261854762924;37638.247235055285;37885.052873678134;38626.8068659657;38826.223475530474;36764.89705308838;36850.631493685054;36910.261794764156;36939.07652308694;37039.25921481576;7247.528910620819;7417.332440080391;7599.772006839804;7681.039870016248;10916.126709863232;10935.781284374309;11054;11066.336019838795;11084.334939903632;11090.833637495443;11031.669049928514;11085.334879907232;11091.944540277287;11099.167562432809;11115.277506962022;7190;7342;10822.24244302899;11031.338119712802;11061.446927653626;10728.409937453436;10779.784404311948;10781.460926953621;10789.892101079045;10802.837957430645;37761.43357849635;37964.81017594922;37982.43026354607;38003.61996380029;38110.23779524422;3727.6322096181684;3754.831032603512;3821.293060783764;3856.267309211241;3866.574676785551;26333.604995925078;26985.1904442867;27911.86044069787;27930.882764689388;27978.720212797816;2985.134311049793;3045.4670432674416;3106.8912588059534;3115.610548681415;3124.984375078133;370435;373283;374602;374689.1265543655;375678.1216093929;36153.45769813455;37087.25825483475;42484.57515424868;43661.56338436638;44069;46201.76899115483;46241.7687911565;46295;46352;46410.303845442344;13437.395317210749;13470.326483675777;13519.391627376792;13532.797008044887;13569.592912212649;11676.065914726802;11713.707157320965;11722.648320550397;11770.470328835223;11809.23239989398;9914.900850991542;11613.070954323633;11654.825177622342;11704.70738231551;11758.294502329887;5374.381946076252;5542.224088627595;5562.694051827189;5578.24693666358;5584.720763961785;1142.7771584540935;1157.311399717167;1165.6328256599145;1169.386072312026;1214.678110300771;21292.574148516942;25738.613920791202;26625.068122615616;27123.321916952234;27128.32179195536;1261.186534685123;1269.8000389631893;1270.4029106320015;1309.6987692830512;1319.6041187643862;13810.135631689593;13937.790933136012;13965.720685586435;13972.301384930714;14025.29873506341;509213;510710;510897;511415;511614;55726;56228.782841287066;56247;56390;56521;1413.6819215676392;1459.9708005840037;1468.2218424235386;1468.2805425341505;1471.279073254119;25327;25623.871880640476;26382.944682212496;26503.734962650127;26546.469070618867;45367.09265814731;45388.31917521306;45441.09117817559;45459;45549.54450455453;449687;449989;450599;450976;451428;25343.493130137664;25415.491690166462;25508.61737073908;25740.871295643403;30779.69220307858;34199.658003419645;41246.175076498905;43818.78090609654;43940.34089488724;44068.33897491476;27214.582826019145;30197.849010754806;30497.085087447413;30672.386552269276;30677.53983690202;29583.408331833674;29707.70292297136;30540.541891872082;30547.694523055376;30560.235994100327;35189;36032.919012429666;36659.45010824893;36674.633253667125;36772.63227367799;24304.635430468203;30490.237744056576;30847.69152308538;31001.534976974912;31378.372432551678;23068.884655576614;24073.51852962966;24152;24246.393840154138;24392.51214975655 04:17:58 INFO - PROCESS | 1642 | |2;jquery.html;385.7839609818501;387.0111864187001;407.468253928623;428.34249427129356;429.896824762057;12103.939480302597;12536.874631253684;20454.488637784027;20634.17463301468;21193.258235961745;20167.49581260469;20306.49433413661;20549.178032878703;21693.67459488105;21715;5532.889342213143;6567.868642627169;6687.598744075347;6718;6857.828554286133;6609.966950165266;6612.70242839071;6643.534952553323;6655.201375834882;6656.667166641672;4014.2372949139717;4324.632406245473;4425.7565833879125;7575.939368488416;7703.922960770405;7397.889031664529;7545.773626791205;7680.884786728176;7685.846283074307;7706;7345.55926644403;7401.148867880155;7403.4447416443445;7405.481616286862;7426.405887528985;23621.409464763346;24430.511389772106;25003.87498062498;25681.743182568123;25954.610680839614;2367.8342516023886;2913.475574396608;2942.8381439020845;2976.1369202931123;2986.119094866998;16544.83455165445;16974.321027158898;17108.657826843395;17490.300387984465;17791.911040444844;2012.9238292457744;2014.143988804752;2032.2886989553685;2035.3181684135832;2064.64900966836;165641;165672.34327656688;176366.35450468253;179068;181583;23201.939660559336;24529.018839246586;24623.507529849303;24701.382465438506;24828.751712483005;35555.64444355523;42313.78843105827;43059.13881722348;43693.34459983103;43741.469048583145;11046.613368532062;11093.445327733742;11287.830682539605;11314;11520.251183673034;8991.775205619912;9016.323775716848;9016.504092274989;9189.127032931861;9207.815843683089;8586.527740974307;9069.410488318239;10054.29619926598;10493.895061049445;10623.043926046694;4167.97916010418;4276.593723596254;4320;4321;4327.6321512671775;666.2471407309806;757.7423675950204;786.7246463737646;790.328221012135;811.7240138352988;18237.361692340968;20032.399028028893;20079.598408031758;20281.718231906576;20344;816.338735721552;832.5046597274612;837.8240569480478;840.0507426607894;841.9242268195892;9986.151177150025;10291.794164116676;10318.329308594917;10338.224633152544;10391.945343401618;740218;741812;750305;763775;775456;161291;161417.19291403468;162232;162521;166173;1150.8446359741495;1173.6713720158198;1202.7955247607927;1205.4093494187784;1208.4441157067847;14847.628809279422;17542.64914701673;17602.823971760117;17653.735193971843;18447.354342597944;44308.589808904166;62685.74628507496;63323.36676633359;63554.411139720025;63984;89053;89730.55134724284;90003.54998224966;90579;90616;9623.711288661352;10522;10766.676999690022;11394.54421823151;11629.76740465169;12177.147599667938;12201.63395098113;12347.3826308686;12403;12524.311162886128;5891.440313170242;9787;10759.892401076202;11122.666320010412;11174;9947.602095916081;10011;10012.899871001197;10268.948655256676;10373.066424021572;10994.28537145083;11260.94369528147;11357.48891299877;11444.71388215268;11471.541138354372;11311.660650180507;11602.303861768321;11603.549556305461;11614.941925290319;11688.824667630162;10031.347962382422;10441.843372349573;10472.424016679155;10497.632582859564;10524.000879665984 04:17:58 INFO - PROCESS | 1642 | |3;mootools.html;1342.3020029584616;1547.7910482084915;1550.5503404012836;1577.7396729539626;1579.4708772561194;10469.371837689734;11055.447227638617;11075.224734268604;11075.612353567627;11076.280041797278;10484;10887.782244355109;11058.889411105887;11073.446327683603;11074.944625276883;2355.222776483756;2397.160993652225;2402.711674599042;2403.062805505854;2405.350555350063;2283.828712846543;2356.516914032628;2374.6675465434855;2378.8096952243777;2383.9642405363934;2300.1374484568287;2365.184011516033;2371.703537057868;2373.4303767095944;2374.9762502375015;2303.424143964009;2344.519373528431;2351.541449417364;2352.7059117610297;2359.351178425921;2337.731160916482;2355.057976809273;2357.3281614739717;2366.8461549999197;2373.3947843299848;8889.911100889038;11081.667549973434;11088.778224435466;11090.833637495443;11096.223264371498;5507.807226747044;5660.915086273709;5675.262215911905;5678.949394362015;5689.203511508392;3452.7583069185166;3464.9653503464897;3538.5576802899636;3549.2546565221332;3574.999000279926;1089.7384627689378;1114.9498272577753;1170.4557380817876;1203.951841926322;1215;13493.392797324144;13937.721245575132;14212.85787142136;15151;15210.619734506616;4176.331786914079;4307.741535507879;4310.719803212781;4312.245357062501;4313.9137217255475;11162.274452160584;11454.48454819535;11518.827217591743;11552.537898483966;11635.185537012328;5484.7531861066345;5527.170924361298;5542.61201715876;5549.805756798492;5553.083741182741;4988.326575912278;5182.274481572583;5221.138512145453;5227.581793456515;5238.083335416287;3719.683826874692;3821.617838216156;3851.8459261629782;3894.2795582816702;3894.5910679378826;1023.8515415264745;1025.8563801067855;1033.8655974723238;1037.527924794217;1038.5430410619304;799.0770659887838;824.7773101262626;840.9992109389807;955.9569819358146;967.4098799732158;6450.6774661266745;6496.870062598721;6506.479481641552;6514.185726784152;6707.6981535831;838.8657814749611;1017.2828156150044;1022.9795404092025;1042.468341146021;1060.151878497199;3424.9143771405916;3813.387829336913;4078.5513593504693;4165.937510937339;4198.6641068714425;13111.60665180046;13711.971602129881;13744.244066576433;13750.724985500434;13804;13205.47178112884;13389.531366402323;13718;13755.931220343835;13761.17432954026;8093.231143041402;8424.957875210584;9926;10184.388936663823;10195.898041019494;6326.114343991753;6327.3988971047675;6356.77751278703;6401.263854656588;6481.708323125565;11699.12256580777;12020.398980050788;12109.878901210875;12138.878611214128;12229.571964981184;11336.469576607382;11352.205345625727;11755.294682319089;12398.132130751123;12419.130660854014;8795.91204087951;9298.023707510885;9371.671991480265;9378.624855005723;9394.154526092685;10158.13655839262;10168.440735759605;10177.338472999232;10290.691279261635;10290.897091029294;8683.869741954002;8746.431481953652;8757.255633271243;8758;8804;7978.760637180894;8139.308158806568;8153.266206041248;8177.877331840146;8217.055038670629;7822.45242833019;7864.174261702439;7966.960165199137;7989.760307190793;8029.919700802917;5061.569766569735;5501.724913754377;5800.56495762811;5868.589198756046;6019.367966363644;5642.266505354278;5814.476697097281;5821.94178058231;5947.197128387612;5980.611260268069 04:17:58 INFO - PROCESS | 1642 | |4;prototype.html;364.64082878364803;378.55141657136295;381.4888050012982;382.4225419616378;390.29162070841403;4990.47600002;5028.59771218303;5065.924011139831;5093.872653183672;5162.322245270293;3949.64453199212;4087.734297270675;4375.796655919624;4655.837045703401;4733.928991065137;3739.466818604366;3884.3784994400903;4082.3058430751353;4212.2098108304;4217.894552636178;3380.9545225138804;3431.897043088711;4035.5762644922156;4222.282212023963;4290.184864875664;3623.184783423722;3640.0353906214873;4035.57626449223;4273.786310684469;4326.199653064177;3509.1575823582725;3533.752637315389;4254.957450425487;4278.529361770203;4288.598384904432;3484.5992710838073;3589.838457269429;3673.669369756708;3758.9436158457647;3824.770513769183;4938.80244790208;4951.455339912607;4959.925601115986;4968.254761785725;5028.84913452597;4432.490263619693;4895.185268470608;4907.533784290486;4933.45731969483;4981.861427300813;4544.545745361485;4746.5490778376;4782.665213435061;5302.734863256822;5341.1988201769655;4295.570442955711;4309.1381723655395;4311.741295522279;4343.437371950565;4371.4972778130605;4953.405591329064;5192.208688002633;5219.164933610604;5741.052726300156;5783.248177736909;3641.908952276214;3688.5942546319884;3834.8657796976972;4387.758673273001;4404.480454243281;3719.9070023249637;3889.7082718796205;4025.6248813200355;4490.977545112253;4602.470715867718;4560.589546940725;4580.732537394011;4681.414823147106;4854.077725232195;4937.851864444073;4273.743575385487;4846.80612775492;5034.370703662043;5192.649911023162;5404.864878377994;1352.208957759702;1357.6877318216866;1533.1797488343682;1535.7619568966827;1541.8072740907387;918.2241006349624;1123.966281011571;1144.6909334479644;1146.1633007904277;1169.4152923538231;4727.432708075053;4744.3595114659765;5048.217526283432;5066.9746651266505;5088.262201980766;4893.143699852511;5071.518205770446;5588.469095435927;5589.74846131925;5606.971965140148;4126.370083816875;4595.494495605481;5077.136886729265;5121.951219512225;5134.204198349262;2780.2493326802055;2913.2134323732475;2974.9256268593026;2978;2978.717021882918;5111.980767596779;5130.461301563282;5557.5831812614215;5900.878833021712;5947.345791962881;5057.671251368723;5313.57491400687;5506.807261745819;5774.769009239667;5797.2173356788135;4694.788734507024;5461.371942226695;5595.265467705024;5625.156226566048;5637.830865074055;4843.878903027453;5558.832645144404;5619.466150715675;5630.887382252414;5676.290463692038;4740.431148262092;4965.900681986413;5014.473480284663;5151.922721159261;5602.327720673546;5481.355593321908;5594.601349662585;5669.801556945487;5753.568482363756;5822.544363909023;4407.655665022199;4461.397711308931;4465.972826249916;4492.640588752957;4504.414426124583;5205.609579281493;5406.64787831547;5544.9483691032965;5562.16567514876;5603.915941260966;4693.366395536559;5307.65500242483;5359.758810853599;5382;5452.700101494456;4735.408073990751;5056.393232812086;5204.453532379046;5346.048692227231;5604.178641941304;3974.8608798691907;4511.954880451153;5202.713850738246;5232.843014709565;5250.343707036621;4211.347241177622;4605.342076852397;4795.448523419851;5322.627416080992;5414.593905457185;4441.422615060022;4516.345129956204;5262.868428289324;5282.656627319212;5294.391145018218 04:17:58 INFO - PROCESS | 1642 | |5;yui.html;607.5504126946062;734.3427632269122;779.5829231361223;830.9667613295468;840.3907167303705;15147.242637868103;15898.761518577201;15934.760978585331;15945.36218551258;15962.600934976617;14521.20133392663;14592.781108283385;14632.048916820399;14676.633084172874;14679.706405871877;907.9500627465487;909.5179554835947;933.2673851026946;942.4345392764355;949.378157306965;937.3813283233068;938.2306508662899;938.9906100939006;939.6241503398661;940.614348117272;992.3995982430633;996.1134590214715;998.0069830518644;998.5656239535825;999.5701848205268;985.6648739428557;987.7925635616565;989.3519744567247;989.8465737810651;991.7322322972793;731.5208538407352;732.5714457042636;732.9780106596811;733.3839574757229;736.0468193689186;15797.526074217792;16112.355505779871;16130.516084517483;16255.51233462998;16480;13975.440982360795;13991.720165596631;14032;14056.297185140702;14083;11677.649670509812;11829.171957962946;11873.287602743863;11903.880961190363;11972.221805582609;3591.6228795976567;3592.8562857485667;3623.40213864712;3716.1824398632257;3831.06138995945;52198.739006305106;87827.56086219529;110711.48013722453;113377.43311283473;115955;10411.895881041244;10853;11022.338659680445;11105.38920359388;11131.387773672526;21902.561948760937;21918.671219931715;21927.12291508322;21959.780402196095;21974.560508789735;5862.853428664317;5872.58891877573;6894.413974812097;7431.459946711778;7616.695332186761;4339.1972485090355;4367.45406824147;4416.911661766747;4503.347014682852;4536.183486972311;3349.8995030149135;3433.8626454942023;3440.139965008748;3451.551298331251;3453.8963831085107;654.8919428294373;676.2392308652766;677.4174210179242;689.1902015132199;699.3740602161139;677.3192941094169;680.6528670378143;709.2871663977669;719.6221983458726;739.9223081576357;9836.213102951746;10090.890002099763;10103.343282686601;10296.588136474607;10486.213533984828;623.4389049855076;665.5474277491352;702.5924963521145;722.5953466059024;725.8802297620833;4702.412198475191;5016.698998060128;5024.221245706921;5025.39695236574;5028.321176641107;96248;96514.51742741241;97320.54019189718;100395;100700.49649751704;89460;89680;90150;91757.54121229351;91804.54097729603;79328;81031.3793724134;81211.59394203109;83824;84895.57552212199;9602.135807777333;9715.222782177267;9758.707238782848;9769.46267955241;9786.461744604116;52869.7356513215;53203.733981329846;53562.660933476975;54045.189322160986;54989.501049894694;64804.675976619816;66705.66647166733;66829;66971;67209.32790672031;11446.255993360404;11448.484818183368;11540.365279909685;11710.355930423908;11839.230450020721;14469.565913022627;14609;14690.779638305648;14818.407263709762;14952.700945981236;12612.369381530703;13203.537876174289;13551.186928784304;13623.727525449634;13649.38577763983;12390.442430090487;13244.072914895865;13730.588082357544;13906;14094.083884547472;12831.294278814756;13796.586102416944;13964.092333998258;13985;13988.58034258974;9788.804223915624;9947.950260248652;10058.195344372287;10131.703195666043;10678.238090715256;9119.726408207764;9768.316217864965;10324.380537167794;11537.307761534335;11680 04:17:58 INFO - PROCESS | 1642 | __end_tp_report 04:17:58 INFO - PROCESS | 1642 | __start_cc_report 04:17:58 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2595 04:17:58 INFO - PROCESS | 1642 | __end_cc_report 04:17:58 INFO - PROCESS | 1642 | __startTimestamp1491218278603__endTimestamp 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | ------- Summary: start ------- 04:17:58 INFO - PROCESS | 1642 | Number of tests: 6 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5902.36 Median:6092.66 stddev:674.53 (11.1%) stddev-sans-first:636.85 04:17:58 INFO - PROCESS | 1642 | Values: 2994.0 3372.5 3397.5 3401.9 3407.4 5206.9 5627.0 5925.2 5987.2 6001.6 5893.5 5946.6 5965.1 5982.4 6005.3 5337.9 5356.2 5382.8 5410.6 5488.3 5264.9 5267.6 5312.4 5469.9 5472.2 5350.1 5372.5 5378.9 5380.5 5390.8 5376.1 5379.2 5379.7 5380.0 5386.1 5206.5 5323.7 5331.1 5335.0 5354.3 5877.8 5878.4 5880.0 5886.9 5895.9 5242.7 6281.8 6308.5 6316.1 6324.6 6302.4 6348.0 6355.7 6400.0 6403.6 5055.3 5975.1 6035.0 6038.2 6065.9 6293.8 6380.8 6465.9 6474.0 6494.2 6214.9 6218.2 6238.8 6288.1 6329.0 6402.9 6403.4 6421.4 6423.7 6429.8 6305.9 6421.2 6438.2 6460.0 6460.5 6197.6 6243.5 6397.1 6447.8 6473.0 4635.2 5127.4 5175.9 5176.9 5207.7 4559.5 4563.2 4572.4 4572.5 4596.4 5768.3 5813.7 5996.7 6055.7 6058.0 6327.2 6354.0 6371.3 6419.5 6435.2 6041.1 6057.4 6057.6 6068.5 6069.2 5652.1 5654.9 5657.0 5658.7 5669.2 6238.2 6361.9 6440.5 6448.4 6595.4 6375.5 6397.7 6401.4 6414.9 6432.2 6502.3 6591.7 6593.0 6603.2 6604.5 6218.9 6265.5 6416.3 6429.0 6451.0 6283.2 6351.4 6360.0 6381.0 6397.0 6366.3 6366.9 6373.8 6373.9 6385.2 6129.0 6274.2 6285.1 6352.5 6352.8 6065.6 6069.4 6073.6 6092.7 6102.8 6209.3 6278.4 6298.1 6385.6 6394.6 5951.5 5997.6 6029.9 6139.4 6218.2 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:56993.86 Median:30728.62 stddev:119383.53 (388.5%) stddev-sans-first:119643.75 04:17:58 INFO - PROCESS | 1642 | Values: 752.2 788.7 848.2 861.4 934.6 36907.3 37638.2 37885.1 38626.8 38826.2 36764.9 36850.6 36910.3 36939.1 37039.3 7247.5 7417.3 7599.8 7681.0 10916.1 10935.8 11054.0 11066.3 11084.3 11090.8 11031.7 11085.3 11091.9 11099.2 11115.3 7190.0 7342.0 10822.2 11031.3 11061.4 10728.4 10779.8 10781.5 10789.9 10802.8 37761.4 37964.8 37982.4 38003.6 38110.2 3727.6 3754.8 3821.3 3856.3 3866.6 26333.6 26985.2 27911.9 27930.9 27978.7 2985.1 3045.5 3106.9 3115.6 3125.0 370435.0 373283.0 374602.0 374689.1 375678.1 36153.5 37087.3 42484.6 43661.6 44069.0 46201.8 46241.8 46295.0 46352.0 46410.3 13437.4 13470.3 13519.4 13532.8 13569.6 11676.1 11713.7 11722.6 11770.5 11809.2 9914.9 11613.1 11654.8 11704.7 11758.3 5374.4 5542.2 5562.7 5578.2 5584.7 1142.8 1157.3 1165.6 1169.4 1214.7 21292.6 25738.6 26625.1 27123.3 27128.3 1261.2 1269.8 1270.4 1309.7 1319.6 13810.1 13937.8 13965.7 13972.3 14025.3 509213.0 510710.0 510897.0 511415.0 511614.0 55726.0 56228.8 56247.0 56390.0 56521.0 1413.7 1460.0 1468.2 1468.3 1471.3 25327.0 25623.9 26382.9 26503.7 26546.5 45367.1 45388.3 45441.1 45459.0 45549.5 449687.0 449989.0 450599.0 450976.0 451428.0 25343.5 25415.5 25508.6 25740.9 30779.7 34199.7 41246.2 43818.8 43940.3 44068.3 27214.6 30197.8 30497.1 30672.4 30677.5 29583.4 29707.7 30540.5 30547.7 30560.2 35189.0 36032.9 36659.5 36674.6 36772.6 24304.6 30490.2 30847.7 31001.5 31378.4 23068.9 24073.5 24152.0 24246.4 24392.5 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:44066.90 Median:13399.17 stddev:126610.27 (944.9%) stddev-sans-first:126922.96 04:17:58 INFO - PROCESS | 1642 | Values: 385.8 387.0 407.5 428.3 429.9 12103.9 12536.9 20454.5 20634.2 21193.3 20167.5 20306.5 20549.2 21693.7 21715.0 5532.9 6567.9 6687.6 6718.0 6857.8 6610.0 6612.7 6643.5 6655.2 6656.7 4014.2 4324.6 4425.8 7575.9 7703.9 7397.9 7545.8 7680.9 7685.8 7706.0 7345.6 7401.1 7403.4 7405.5 7426.4 23621.4 24430.5 25003.9 25681.7 25954.6 2367.8 2913.5 2942.8 2976.1 2986.1 16544.8 16974.3 17108.7 17490.3 17791.9 2012.9 2014.1 2032.3 2035.3 2064.6 165641.0 165672.3 176366.4 179068.0 181583.0 23201.9 24529.0 24623.5 24701.4 24828.8 35555.6 42313.8 43059.1 43693.3 43741.5 11046.6 11093.4 11287.8 11314.0 11520.3 8991.8 9016.3 9016.5 9189.1 9207.8 8586.5 9069.4 10054.3 10493.9 10623.0 4168.0 4276.6 4320.0 4321.0 4327.6 666.2 757.7 786.7 790.3 811.7 18237.4 20032.4 20079.6 20281.7 20344.0 816.3 832.5 837.8 840.1 841.9 9986.2 10291.8 10318.3 10338.2 10391.9 740218.0 741812.0 750305.0 763775.0 775456.0 161291.0 161417.2 162232.0 162521.0 166173.0 1150.8 1173.7 1202.8 1205.4 1208.4 14847.6 17542.6 17602.8 17653.7 18447.4 44308.6 62685.7 63323.4 63554.4 63984.0 89053.0 89730.6 90003.5 90579.0 90616.0 9623.7 10522.0 10766.7 11394.5 11629.8 12177.1 12201.6 12347.4 12403.0 12524.3 5891.4 9787.0 10759.9 11122.7 11174.0 9947.6 10011.0 10012.9 10268.9 10373.1 10994.3 11260.9 11357.5 11444.7 11471.5 11311.7 11602.3 11603.5 11614.9 11688.8 10031.3 10441.8 10472.4 10497.6 10524.0 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6578.48 Median:2390.56 stddev:4122.98 (172.5%) stddev-sans-first:4115.77 04:17:58 INFO - PROCESS | 1642 | Values: 1342.3 1547.8 1550.6 1577.7 1579.5 10469.4 11055.4 11075.2 11075.6 11076.3 10484.0 10887.8 11058.9 11073.4 11074.9 2355.2 2397.2 2402.7 2403.1 2405.4 2283.8 2356.5 2374.7 2378.8 2384.0 2300.1 2365.2 2371.7 2373.4 2375.0 2303.4 2344.5 2351.5 2352.7 2359.4 2337.7 2355.1 2357.3 2366.8 2373.4 8889.9 11081.7 11088.8 11090.8 11096.2 5507.8 5660.9 5675.3 5678.9 5689.2 3452.8 3465.0 3538.6 3549.3 3575.0 1089.7 1114.9 1170.5 1204.0 1215.0 13493.4 13937.7 14212.9 15151.0 15210.6 4176.3 4307.7 4310.7 4312.2 4313.9 11162.3 11454.5 11518.8 11552.5 11635.2 5484.8 5527.2 5542.6 5549.8 5553.1 4988.3 5182.3 5221.1 5227.6 5238.1 3719.7 3821.6 3851.8 3894.3 3894.6 1023.9 1025.9 1033.9 1037.5 1038.5 799.1 824.8 841.0 956.0 967.4 6450.7 6496.9 6506.5 6514.2 6707.7 838.9 1017.3 1023.0 1042.5 1060.2 3424.9 3813.4 4078.6 4165.9 4198.7 13111.6 13712.0 13744.2 13750.7 13804.0 13205.5 13389.5 13718.0 13755.9 13761.2 8093.2 8425.0 9926.0 10184.4 10195.9 6326.1 6327.4 6356.8 6401.3 6481.7 11699.1 12020.4 12109.9 12138.9 12229.6 11336.5 11352.2 11755.3 12398.1 12419.1 8795.9 9298.0 9371.7 9378.6 9394.2 10158.1 10168.4 10177.3 10290.7 10290.9 8683.9 8746.4 8757.3 8758.0 8804.0 7978.8 8139.3 8153.3 8177.9 8217.1 7822.5 7864.2 7967.0 7989.8 8029.9 5061.6 5501.7 5800.6 5868.6 6019.4 5642.3 5814.5 5821.9 5947.2 5980.6 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4440.05 Median:4789.06 stddev:1250.72 (26.1%) stddev-sans-first:1216.25 04:17:58 INFO - PROCESS | 1642 | Values: 364.6 378.6 381.5 382.4 390.3 4990.5 5028.6 5065.9 5093.9 5162.3 3949.6 4087.7 4375.8 4655.8 4733.9 3739.5 3884.4 4082.3 4212.2 4217.9 3381.0 3431.9 4035.6 4222.3 4290.2 3623.2 3640.0 4035.6 4273.8 4326.2 3509.2 3533.8 4255.0 4278.5 4288.6 3484.6 3589.8 3673.7 3758.9 3824.8 4938.8 4951.5 4959.9 4968.3 5028.8 4432.5 4895.2 4907.5 4933.5 4981.9 4544.5 4746.5 4782.7 5302.7 5341.2 4295.6 4309.1 4311.7 4343.4 4371.5 4953.4 5192.2 5219.2 5741.1 5783.2 3641.9 3688.6 3834.9 4387.8 4404.5 3719.9 3889.7 4025.6 4491.0 4602.5 4560.6 4580.7 4681.4 4854.1 4937.9 4273.7 4846.8 5034.4 5192.6 5404.9 1352.2 1357.7 1533.2 1535.8 1541.8 918.2 1124.0 1144.7 1146.2 1169.4 4727.4 4744.4 5048.2 5067.0 5088.3 4893.1 5071.5 5588.5 5589.7 5607.0 4126.4 4595.5 5077.1 5122.0 5134.2 2780.2 2913.2 2974.9 2978.0 2978.7 5112.0 5130.5 5557.6 5900.9 5947.3 5057.7 5313.6 5506.8 5774.8 5797.2 4694.8 5461.4 5595.3 5625.2 5637.8 4843.9 5558.8 5619.5 5630.9 5676.3 4740.4 4965.9 5014.5 5151.9 5602.3 5481.4 5594.6 5669.8 5753.6 5822.5 4407.7 4461.4 4466.0 4492.6 4504.4 5205.6 5406.6 5544.9 5562.2 5603.9 4693.4 5307.7 5359.8 5382.0 5452.7 4735.4 5056.4 5204.5 5346.0 5604.2 3974.9 4512.0 5202.7 5232.8 5250.3 4211.3 4605.3 4795.4 5322.6 5414.6 4441.4 4516.3 5262.9 5282.7 5294.4 04:17:58 INFO - PROCESS | 1642 | 04:17:58 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20287.44 Median:4859.56 stddev:28939.54 (595.5%) stddev-sans-first:28983.00 04:17:58 INFO - PROCESS | 1642 | Values: 607.6 734.3 779.6 831.0 840.4 15147.2 15898.8 15934.8 15945.4 15962.6 14521.2 14592.8 14632.0 14676.6 14679.7 908.0 909.5 933.3 942.4 949.4 937.4 938.2 939.0 939.6 940.6 992.4 996.1 998.0 998.6 999.6 985.7 987.8 989.4 989.8 991.7 731.5 732.6 733.0 733.4 736.0 15797.5 16112.4 16130.5 16255.5 16480.0 13975.4 13991.7 14032.0 14056.3 14083.0 11677.6 11829.2 11873.3 11903.9 11972.2 3591.6 3592.9 3623.4 3716.2 3831.1 52198.7 87827.6 110711.5 113377.4 115955.0 10411.9 10853.0 11022.3 11105.4 11131.4 21902.6 21918.7 21927.1 21959.8 21974.6 5862.9 5872.6 6894.4 7431.5 7616.7 4339.2 4367.5 4416.9 4503.3 4536.2 3349.9 3433.9 3440.1 3451.6 3453.9 654.9 676.2 677.4 689.2 699.4 677.3 680.7 709.3 719.6 739.9 9836.2 10090.9 10103.3 10296.6 10486.2 623.4 665.5 702.6 722.6 725.9 4702.4 5016.7 5024.2 5025.4 5028.3 96248.0 96514.5 97320.5 100395.0 100700.5 89460.0 89680.0 90150.0 91757.5 91804.5 79328.0 81031.4 81211.6 83824.0 84895.6 9602.1 9715.2 9758.7 9769.5 9786.5 52869.7 53203.7 53562.7 54045.2 54989.5 64804.7 66705.7 66829.0 66971.0 67209.3 11446.3 11448.5 11540.4 11710.4 11839.2 14469.6 14609.0 14690.8 14818.4 14952.7 12612.4 13203.5 13551.2 13623.7 13649.4 12390.4 13244.1 13730.6 13906.0 14094.1 12831.3 13796.6 13964.1 13985.0 13988.6 9788.8 9948.0 10058.2 10131.7 10678.2 9119.7 9768.3 10324.4 11537.3 11680.0 04:17:58 INFO - PROCESS | 1642 | -------- Summary: end -------- 04:17:58 INFO - PROCESS | 1642 | 04:17:59 INFO - TEST-INFO | 1642: exit 0 04:17:59 INFO - TEST-OK | dromaeo_css | took 1120834ms 04:17:59 INFO - TEST-START | kraken 04:17:59 INFO - operating with platform_type : mac_ 04:17:59 INFO - Initialising browser for kraken test... 04:17:59 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpfNCgWE/profile http://localhost:49237/getInfo.html) 04:18:01 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:18:01 INFO - PROCESS | 1652 | colorDepth:24 04:18:01 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:18:01 INFO - PROCESS | 1652 | __metrics 04:18:01 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:18:01 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:02 INFO - TEST-INFO | 1652: exit 0 04:18:02 INFO - Browser initialized. 04:18:02 INFO - Running cycle 1/1 for kraken test... 04:18:02 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpfNCgWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:14 INFO - PROCESS | 1653 | RSS: Main: 215359488 04:18:14 INFO - PROCESS | 1653 | 04:18:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:18 INFO - PROCESS | 1653 | RSS: Main: 268365824 04:18:18 INFO - PROCESS | 1653 | 04:18:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 04:18:21 INFO - PROCESS | 1653 | RSS: Main: 279199744 04:18:21 INFO - PROCESS | 1653 | 04:18:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 04:18:25 INFO - PROCESS | 1653 | RSS: Main: 377864192 04:18:25 INFO - PROCESS | 1653 | 04:18:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 04:18:27 INFO - PROCESS | 1653 | RSS: Main: 277979136 04:18:27 INFO - PROCESS | 1653 | 04:18:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:30 INFO - PROCESS | 1653 | RSS: Main: 279351296 04:18:30 INFO - PROCESS | 1653 | 04:18:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:34 INFO - PROCESS | 1653 | RSS: Main: 320380928 04:18:34 INFO - PROCESS | 1653 | 04:18:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:37 INFO - PROCESS | 1653 | RSS: Main: 321060864 04:18:37 INFO - PROCESS | 1653 | 04:18:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 04:18:41 INFO - PROCESS | 1653 | RSS: Main: 317386752 04:18:41 INFO - PROCESS | 1653 | 04:18:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:43 INFO - PROCESS | 1653 | RSS: Main: 295194624 04:18:43 INFO - PROCESS | 1653 | 04:18:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:45 INFO - PROCESS | 1653 | RSS: Main: 298295296 04:18:45 INFO - PROCESS | 1653 | 04:18:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:48 INFO - PROCESS | 1653 | RSS: Main: 300740608 04:18:48 INFO - PROCESS | 1653 | 04:18:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:52 INFO - PROCESS | 1653 | RSS: Main: 320053248 04:18:52 INFO - PROCESS | 1653 | 04:18:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:55 INFO - PROCESS | 1653 | RSS: Main: 312496128 04:18:55 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 04:18:57 INFO - PROCESS | 1653 | RSS: Main: 356999168 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | __start_tp_report 04:18:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:18:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:18:57 INFO - PROCESS | 1653 | |i|pagename|runs| 04:18:57 INFO - PROCESS | 1653 | |0;ai-astar;124;172;147;117;115;116;117;117;115;116 04:18:57 INFO - PROCESS | 1653 | |1;audio-beat-detection;146;109;109;147;109;105;111;110;128;108 04:18:57 INFO - PROCESS | 1653 | |2;audio-dft;187;186;182;183;182;185;184;183;184;184 04:18:57 INFO - PROCESS | 1653 | |3;audio-fft;83;62;60;89;63;63;62;60;75;61 04:18:57 INFO - PROCESS | 1653 | |4;audio-oscillator;88;71;88;70;69;68;82;68;69;84 04:18:57 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;87;88;92;135;87;88;89;87;87 04:18:57 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;95;95;95;94;94;94;94;94;100 04:18:57 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;84;85;85;86;83;86;84;83;86 04:18:57 INFO - PROCESS | 1653 | |8;json-parse-financial;62;60;64;63;65;67;66;64;64;64 04:18:57 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;58;57;68;64;60;57;58;58;57;57 04:18:57 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;81;96;100;101;101;85;80;80;83;86 04:18:57 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;138;137;136;150;154;147;141;187;172 04:18:57 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;160;165;163;163;166;173;163;164;165;159 04:18:57 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;65;64;66;65;64;66;66;61;82;65 04:18:57 INFO - PROCESS | 1653 | __end_tp_report 04:18:57 INFO - PROCESS | 1653 | __start_cc_report 04:18:57 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2120 04:18:57 INFO - PROCESS | 1653 | __end_cc_report 04:18:57 INFO - PROCESS | 1653 | __startTimestamp1491218337971__endTimestamp 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:18:57 INFO - PROCESS | 1653 | Number of tests: 14 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:125.60 Median:117.00 stddev:18.99 (16.2%) stddev-sans-first:20.13 04:18:57 INFO - PROCESS | 1653 | Values: 124.0 172.0 147.0 117.0 115.0 116.0 117.0 117.0 115.0 116.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:110.50 stddev:16.16 (14.6%) stddev-sans-first:13.65 04:18:57 INFO - PROCESS | 1653 | Values: 146.0 109.0 109.0 147.0 109.0 105.0 111.0 110.0 128.0 108.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.63 (0.9%) stddev-sans-first:1.32 04:18:57 INFO - PROCESS | 1653 | Values: 187.0 186.0 182.0 183.0 182.0 185.0 184.0 183.0 184.0 184.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:67.80 Median:63.00 stddev:10.61 (16.8%) stddev-sans-first:9.73 04:18:57 INFO - PROCESS | 1653 | Values: 83.0 62.0 60.0 89.0 63.0 63.0 62.0 60.0 75.0 61.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.50 stddev:8.65 (11.3%) stddev-sans-first:7.95 04:18:57 INFO - PROCESS | 1653 | Values: 88.0 71.0 88.0 70.0 69.0 68.0 82.0 68.0 69.0 84.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:88.00 stddev:14.87 (16.9%) stddev-sans-first:15.71 04:18:57 INFO - PROCESS | 1653 | Values: 89.0 87.0 88.0 92.0 135.0 87.0 88.0 89.0 87.0 87.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.00 stddev:1.85 (2.0%) stddev-sans-first:1.94 04:18:57 INFO - PROCESS | 1653 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 100.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 04:18:57 INFO - PROCESS | 1653 | Values: 85.0 84.0 85.0 85.0 86.0 83.0 86.0 84.0 83.0 86.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:1.96 04:18:57 INFO - PROCESS | 1653 | Values: 62.0 60.0 64.0 63.0 65.0 67.0 66.0 64.0 64.0 64.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:58.00 stddev:3.72 (6.4%) stddev-sans-first:3.91 04:18:57 INFO - PROCESS | 1653 | Values: 58.0 57.0 68.0 64.0 60.0 57.0 58.0 58.0 57.0 57.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:82.00 stddev:9.09 (11.1%) stddev-sans-first:9.13 04:18:57 INFO - PROCESS | 1653 | Values: 81.0 96.0 100.0 101.0 101.0 85.0 80.0 80.0 83.0 86.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:148.50 stddev:17.12 (11.5%) stddev-sans-first:17.51 04:18:57 INFO - PROCESS | 1653 | Values: 137.0 138.0 137.0 136.0 150.0 154.0 147.0 141.0 187.0 172.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:3.81 (2.3%) stddev-sans-first:3.75 04:18:57 INFO - PROCESS | 1653 | Values: 160.0 165.0 163.0 163.0 166.0 173.0 163.0 164.0 165.0 159.0 04:18:57 INFO - PROCESS | 1653 | 04:18:57 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:65.50 stddev:5.68 (8.7%) stddev-sans-first:6.00 04:18:57 INFO - PROCESS | 1653 | Values: 65.0 64.0 66.0 65.0 64.0 66.0 66.0 61.0 82.0 65.0 04:18:57 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:18:57 INFO - PROCESS | 1653 | 04:18:58 INFO - TEST-INFO | 1653: exit 0 04:18:58 INFO - TEST-OK | kraken | took 59628ms 04:18:58 INFO - SUITE-END | took 1180s 04:18:59 INFO - Completed test suite (00:19:40) 04:18:59 INFO - javascript benchmark 04:18:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7586.649867964945, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2993.9850300748494, 3372.494125881116, 3397.5413319201903, 3401.9149521261966, 3407.420738474459, 5206.895862082756, 5626.971865140668, 5925.200097986776, 5987.161797348374, 6001.579889407743, 5893.528517718583, 5946.554008449362, 5965.135055416962, 5982.371850955652, 6005.3394126646035, 5337.866553336159, 5356.196570514415, 5382.811601593945, 5410.594205434589, 5488.286522752037, 5264.947350526484, 5267.604929630274, 5312.362516498026, 5469.863253418676, 5472.151816468454, 5350.063738845686, 5372.489613486732, 5378.946210537883, 5380.488853558905, 5390.757415916273, 5376.059189641797, 5379.246905433203, 5379.704116273603, 5380.0, 5386.13821788512, 5206.505381988705, 5323.707196104213, 5331.067063263952, 5335.0, 5354.250404943311, 5877.794277200277, 5878.441548052928, 5880.029795083806, 5886.852828679274, 5895.941040589582, 5242.7378631068295, 6281.811545653638, 6308.495320374359, 6316.115743795872, 6324.620522768649, 6302.401271879165, 6348.0, 6355.650439225841, 6400.03999400089, 6403.647799371032, 5055.266986287004, 5975.1037344398255, 6034.969825150846, 6038.245219347582, 6065.939340606582, 6293.811185664437, 6380.776672816429, 6465.870682586369, 6473.996530537775, 6494.188226471691, 6214.906776398358, 6218.22272215973, 6238.750449982041, 6288.088227207121, 6328.968355158195, 6402.903956440658, 6403.391677790602, 6421.389967953037, 6423.678816059271, 6429.774957876545, 6305.936940630535, 6421.197350331208, 6438.163038804925, 6460.0, 6460.515461340418, 6197.566170368121, 6243.469305109116, 6397.072424498421, 6447.838804029937, 6473.0, 4635.165670179333, 5127.435982041972, 5175.896482070338, 5176.948230517722, 5207.661502002357, 4559.452865656076, 4563.178627846953, 4572.428446444194, 4572.497025327211, 4596.37948876904, 5768.250127483484, 5813.651180929158, 5996.700164991733, 6055.666938318434, 6057.969710151509, 6327.17746692927, 6353.96823015882, 6371.299157092716, 6419.51853610981, 6435.22777266731, 6041.093835924647, 6057.42454466825, 6057.575969682168, 6068.514518838482, 6069.15031895535, 5652.123920792284, 5654.9151762723595, 5656.971715141398, 5658.688772117573, 5669.177969194444, 6238.157848690369, 6361.936380636134, 6440.549161558646, 6448.419642232034, 6595.373439523238, 6375.5218358624215, 6397.680115994089, 6401.391867772554, 6414.903776443451, 6432.195975503062, 6502.349765023459, 6591.736330546724, 6593.0, 6603.20761508622, 6604.504662150454, 6218.875622487615, 6265.498760099273, 6416.326285740117, 6429.0, 6451.032345148265, 6283.151774510383, 6351.396617321347, 6359.96820015897, 6381.010943303795, 6396.968015159894, 6366.267879193952, 6366.872662546816, 6373.776917807854, 6373.93626063752, 6385.201849768779, 6128.9693551531955, 6274.1843560336865, 6285.088662144055, 6352.460040896575, 6352.777652782131, 6065.60573562717, 6069.423404776539, 6073.605215660968, 6092.664903430176, 6102.786402475892, 6209.2548894133, 6278.434940855345, 6298.11826344303, 6385.584936979081, 6394.6482943436695, 5951.494122999594, 5997.610155339889, 6029.87940241184, 6139.447449729546, 6218.22272215973], "value": 5857.401182942232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1575835064727, 788.6805843633329, 848.2492993700573, 861.4271509446219, 934.5887809363875, 36907.261854762924, 37638.247235055285, 37885.052873678134, 38626.8068659657, 38826.223475530474, 36764.89705308838, 36850.631493685054, 36910.261794764156, 36939.07652308694, 37039.25921481576, 7247.528910620819, 7417.332440080391, 7599.772006839804, 7681.039870016248, 10916.126709863232, 10935.781284374309, 11054.0, 11066.336019838795, 11084.334939903632, 11090.833637495443, 11031.669049928514, 11085.334879907232, 11091.944540277287, 11099.167562432809, 11115.277506962022, 7190.0, 7342.0, 10822.24244302899, 11031.338119712802, 11061.446927653626, 10728.409937453436, 10779.784404311948, 10781.460926953621, 10789.892101079045, 10802.837957430645, 37761.43357849635, 37964.81017594922, 37982.43026354607, 38003.61996380029, 38110.23779524422, 3727.6322096181684, 3754.831032603512, 3821.293060783764, 3856.267309211241, 3866.574676785551, 26333.604995925078, 26985.1904442867, 27911.86044069787, 27930.882764689388, 27978.720212797816, 2985.134311049793, 3045.4670432674416, 3106.8912588059534, 3115.610548681415, 3124.984375078133, 370435.0, 373283.0, 374602.0, 374689.1265543655, 375678.1216093929, 36153.45769813455, 37087.25825483475, 42484.57515424868, 43661.56338436638, 44069.0, 46201.76899115483, 46241.7687911565, 46295.0, 46352.0, 46410.303845442344, 13437.395317210749, 13470.326483675777, 13519.391627376792, 13532.797008044887, 13569.592912212649, 11676.065914726802, 11713.707157320965, 11722.648320550397, 11770.470328835223, 11809.23239989398, 9914.900850991542, 11613.070954323633, 11654.825177622342, 11704.70738231551, 11758.294502329887, 5374.381946076252, 5542.224088627595, 5562.694051827189, 5578.24693666358, 5584.720763961785, 1142.7771584540935, 1157.311399717167, 1165.6328256599145, 1169.386072312026, 1214.678110300771, 21292.574148516942, 25738.613920791202, 26625.068122615616, 27123.321916952234, 27128.32179195536, 1261.186534685123, 1269.8000389631893, 1270.4029106320015, 1309.6987692830512, 1319.6041187643862, 13810.135631689593, 13937.790933136012, 13965.720685586435, 13972.301384930714, 14025.29873506341, 509213.0, 510710.0, 510897.0, 511415.0, 511614.0, 55726.0, 56228.782841287066, 56247.0, 56390.0, 56521.0, 1413.6819215676392, 1459.9708005840037, 1468.2218424235386, 1468.2805425341505, 1471.279073254119, 25327.0, 25623.871880640476, 26382.944682212496, 26503.734962650127, 26546.469070618867, 45367.09265814731, 45388.31917521306, 45441.09117817559, 45459.0, 45549.54450455453, 449687.0, 449989.0, 450599.0, 450976.0, 451428.0, 25343.493130137664, 25415.491690166462, 25508.61737073908, 25740.871295643403, 30779.69220307858, 34199.658003419645, 41246.175076498905, 43818.78090609654, 43940.34089488724, 44068.33897491476, 27214.582826019145, 30197.849010754806, 30497.085087447413, 30672.386552269276, 30677.53983690202, 29583.408331833674, 29707.70292297136, 30540.541891872082, 30547.694523055376, 30560.235994100327, 35189.0, 36032.919012429666, 36659.45010824893, 36674.633253667125, 36772.63227367799, 24304.635430468203, 30490.237744056576, 30847.69152308538, 31001.534976974912, 31378.372432551678, 23068.884655576614, 24073.51852962966, 24152.0, 24246.393840154138, 24392.51214975655], "value": 18357.496142607306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7839609818501, 387.0111864187001, 407.468253928623, 428.34249427129356, 429.896824762057, 12103.939480302597, 12536.874631253684, 20454.488637784027, 20634.17463301468, 21193.258235961745, 20167.49581260469, 20306.49433413661, 20549.178032878703, 21693.67459488105, 21715.0, 5532.889342213143, 6567.868642627169, 6687.598744075347, 6718.0, 6857.828554286133, 6609.966950165266, 6612.70242839071, 6643.534952553323, 6655.201375834882, 6656.667166641672, 4014.2372949139717, 4324.632406245473, 4425.7565833879125, 7575.939368488416, 7703.922960770405, 7397.889031664529, 7545.773626791205, 7680.884786728176, 7685.846283074307, 7706.0, 7345.55926644403, 7401.148867880155, 7403.4447416443445, 7405.481616286862, 7426.405887528985, 23621.409464763346, 24430.511389772106, 25003.87498062498, 25681.743182568123, 25954.610680839614, 2367.8342516023886, 2913.475574396608, 2942.8381439020845, 2976.1369202931123, 2986.119094866998, 16544.83455165445, 16974.321027158898, 17108.657826843395, 17490.300387984465, 17791.911040444844, 2012.9238292457744, 2014.143988804752, 2032.2886989553685, 2035.3181684135832, 2064.64900966836, 165641.0, 165672.34327656688, 176366.35450468253, 179068.0, 181583.0, 23201.939660559336, 24529.018839246586, 24623.507529849303, 24701.382465438506, 24828.751712483005, 35555.64444355523, 42313.78843105827, 43059.13881722348, 43693.34459983103, 43741.469048583145, 11046.613368532062, 11093.445327733742, 11287.830682539605, 11314.0, 11520.251183673034, 8991.775205619912, 9016.323775716848, 9016.504092274989, 9189.127032931861, 9207.815843683089, 8586.527740974307, 9069.410488318239, 10054.29619926598, 10493.895061049445, 10623.043926046694, 4167.97916010418, 4276.593723596254, 4320.0, 4321.0, 4327.6321512671775, 666.2471407309806, 757.7423675950204, 786.7246463737646, 790.328221012135, 811.7240138352988, 18237.361692340968, 20032.399028028893, 20079.598408031758, 20281.718231906576, 20344.0, 816.338735721552, 832.5046597274612, 837.8240569480478, 840.0507426607894, 841.9242268195892, 9986.151177150025, 10291.794164116676, 10318.329308594917, 10338.224633152544, 10391.945343401618, 740218.0, 741812.0, 750305.0, 763775.0, 775456.0, 161291.0, 161417.19291403468, 162232.0, 162521.0, 166173.0, 1150.8446359741495, 1173.6713720158198, 1202.7955247607927, 1205.4093494187784, 1208.4441157067847, 14847.628809279422, 17542.64914701673, 17602.823971760117, 17653.735193971843, 18447.354342597944, 44308.589808904166, 62685.74628507496, 63323.36676633359, 63554.411139720025, 63984.0, 89053.0, 89730.55134724284, 90003.54998224966, 90579.0, 90616.0, 9623.711288661352, 10522.0, 10766.676999690022, 11394.54421823151, 11629.76740465169, 12177.147599667938, 12201.63395098113, 12347.3826308686, 12403.0, 12524.311162886128, 5891.440313170242, 9787.0, 10759.892401076202, 11122.666320010412, 11174.0, 9947.602095916081, 10011.0, 10012.899871001197, 10268.948655256676, 10373.066424021572, 10994.28537145083, 11260.94369528147, 11357.48891299877, 11444.71388215268, 11471.541138354372, 11311.660650180507, 11602.303861768321, 11603.549556305461, 11614.941925290319, 11688.824667630162, 10031.347962382422, 10441.843372349573, 10472.424016679155, 10497.632582859564, 10524.000879665984], "value": 11413.220983892035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.3020029584616, 1547.7910482084915, 1550.5503404012836, 1577.7396729539626, 1579.4708772561194, 10469.371837689734, 11055.447227638617, 11075.224734268604, 11075.612353567627, 11076.280041797278, 10484.0, 10887.782244355109, 11058.889411105887, 11073.446327683603, 11074.944625276883, 2355.222776483756, 2397.160993652225, 2402.711674599042, 2403.062805505854, 2405.350555350063, 2283.828712846543, 2356.516914032628, 2374.6675465434855, 2378.8096952243777, 2383.9642405363934, 2300.1374484568287, 2365.184011516033, 2371.703537057868, 2373.4303767095944, 2374.9762502375015, 2303.424143964009, 2344.519373528431, 2351.541449417364, 2352.7059117610297, 2359.351178425921, 2337.731160916482, 2355.057976809273, 2357.3281614739717, 2366.8461549999197, 2373.3947843299848, 8889.911100889038, 11081.667549973434, 11088.778224435466, 11090.833637495443, 11096.223264371498, 5507.807226747044, 5660.915086273709, 5675.262215911905, 5678.949394362015, 5689.203511508392, 3452.7583069185166, 3464.9653503464897, 3538.5576802899636, 3549.2546565221332, 3574.999000279926, 1089.7384627689378, 1114.9498272577753, 1170.4557380817876, 1203.951841926322, 1215.0, 13493.392797324144, 13937.721245575132, 14212.85787142136, 15151.0, 15210.619734506616, 4176.331786914079, 4307.741535507879, 4310.719803212781, 4312.245357062501, 4313.9137217255475, 11162.274452160584, 11454.48454819535, 11518.827217591743, 11552.537898483966, 11635.185537012328, 5484.7531861066345, 5527.170924361298, 5542.61201715876, 5549.805756798492, 5553.083741182741, 4988.326575912278, 5182.274481572583, 5221.138512145453, 5227.581793456515, 5238.083335416287, 3719.683826874692, 3821.617838216156, 3851.8459261629782, 3894.2795582816702, 3894.5910679378826, 1023.8515415264745, 1025.8563801067855, 1033.8655974723238, 1037.527924794217, 1038.5430410619304, 799.0770659887838, 824.7773101262626, 840.9992109389807, 955.9569819358146, 967.4098799732158, 6450.6774661266745, 6496.870062598721, 6506.479481641552, 6514.185726784152, 6707.6981535831, 838.8657814749611, 1017.2828156150044, 1022.9795404092025, 1042.468341146021, 1060.151878497199, 3424.9143771405916, 3813.387829336913, 4078.5513593504693, 4165.937510937339, 4198.6641068714425, 13111.60665180046, 13711.971602129881, 13744.244066576433, 13750.724985500434, 13804.0, 13205.47178112884, 13389.531366402323, 13718.0, 13755.931220343835, 13761.17432954026, 8093.231143041402, 8424.957875210584, 9926.0, 10184.388936663823, 10195.898041019494, 6326.114343991753, 6327.3988971047675, 6356.77751278703, 6401.263854656588, 6481.708323125565, 11699.12256580777, 12020.398980050788, 12109.878901210875, 12138.878611214128, 12229.571964981184, 11336.469576607382, 11352.205345625727, 11755.294682319089, 12398.132130751123, 12419.130660854014, 8795.91204087951, 9298.023707510885, 9371.671991480265, 9378.624855005723, 9394.154526092685, 10158.13655839262, 10168.440735759605, 10177.338472999232, 10290.691279261635, 10290.897091029294, 8683.869741954002, 8746.431481953652, 8757.255633271243, 8758.0, 8804.0, 7978.760637180894, 8139.308158806568, 8153.266206041248, 8177.877331840146, 8217.055038670629, 7822.45242833019, 7864.174261702439, 7966.960165199137, 7989.760307190793, 8029.919700802917, 5061.569766569735, 5501.724913754377, 5800.56495762811, 5868.589198756046, 6019.367966363644, 5642.266505354278, 5814.476697097281, 5821.94178058231, 5947.197128387612, 5980.611260268069], "value": 5016.341343104355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.64082878364803, 378.55141657136295, 381.4888050012982, 382.4225419616378, 390.29162070841403, 4990.47600002, 5028.59771218303, 5065.924011139831, 5093.872653183672, 5162.322245270293, 3949.64453199212, 4087.734297270675, 4375.796655919624, 4655.837045703401, 4733.928991065137, 3739.466818604366, 3884.3784994400903, 4082.3058430751353, 4212.2098108304, 4217.894552636178, 3380.9545225138804, 3431.897043088711, 4035.5762644922156, 4222.282212023963, 4290.184864875664, 3623.184783423722, 3640.0353906214873, 4035.57626449223, 4273.786310684469, 4326.199653064177, 3509.1575823582725, 3533.752637315389, 4254.957450425487, 4278.529361770203, 4288.598384904432, 3484.5992710838073, 3589.838457269429, 3673.669369756708, 3758.9436158457647, 3824.770513769183, 4938.80244790208, 4951.455339912607, 4959.925601115986, 4968.254761785725, 5028.84913452597, 4432.490263619693, 4895.185268470608, 4907.533784290486, 4933.45731969483, 4981.861427300813, 4544.545745361485, 4746.5490778376, 4782.665213435061, 5302.734863256822, 5341.1988201769655, 4295.570442955711, 4309.1381723655395, 4311.741295522279, 4343.437371950565, 4371.4972778130605, 4953.405591329064, 5192.208688002633, 5219.164933610604, 5741.052726300156, 5783.248177736909, 3641.908952276214, 3688.5942546319884, 3834.8657796976972, 4387.758673273001, 4404.480454243281, 3719.9070023249637, 3889.7082718796205, 4025.6248813200355, 4490.977545112253, 4602.470715867718, 4560.589546940725, 4580.732537394011, 4681.414823147106, 4854.077725232195, 4937.851864444073, 4273.743575385487, 4846.80612775492, 5034.370703662043, 5192.649911023162, 5404.864878377994, 1352.208957759702, 1357.6877318216866, 1533.1797488343682, 1535.7619568966827, 1541.8072740907387, 918.2241006349624, 1123.966281011571, 1144.6909334479644, 1146.1633007904277, 1169.4152923538231, 4727.432708075053, 4744.3595114659765, 5048.217526283432, 5066.9746651266505, 5088.262201980766, 4893.143699852511, 5071.518205770446, 5588.469095435927, 5589.74846131925, 5606.971965140148, 4126.370083816875, 4595.494495605481, 5077.136886729265, 5121.951219512225, 5134.204198349262, 2780.2493326802055, 2913.2134323732475, 2974.9256268593026, 2978.0, 2978.717021882918, 5111.980767596779, 5130.461301563282, 5557.5831812614215, 5900.878833021712, 5947.345791962881, 5057.671251368723, 5313.57491400687, 5506.807261745819, 5774.769009239667, 5797.2173356788135, 4694.788734507024, 5461.371942226695, 5595.265467705024, 5625.156226566048, 5637.830865074055, 4843.878903027453, 5558.832645144404, 5619.466150715675, 5630.887382252414, 5676.290463692038, 4740.431148262092, 4965.900681986413, 5014.473480284663, 5151.922721159261, 5602.327720673546, 5481.355593321908, 5594.601349662585, 5669.801556945487, 5753.568482363756, 5822.544363909023, 4407.655665022199, 4461.397711308931, 4465.972826249916, 4492.640588752957, 4504.414426124583, 5205.609579281493, 5406.64787831547, 5544.9483691032965, 5562.16567514876, 5603.915941260966, 4693.366395536559, 5307.65500242483, 5359.758810853599, 5382.0, 5452.700101494456, 4735.408073990751, 5056.393232812086, 5204.453532379046, 5346.048692227231, 5604.178641941304, 3974.8608798691907, 4511.954880451153, 5202.713850738246, 5232.843014709565, 5250.343707036621, 4211.347241177622, 4605.342076852397, 4795.448523419851, 5322.627416080992, 5414.593905457185, 4441.422615060022, 4516.345129956204, 5262.868428289324, 5282.656627319212, 5294.391145018218], "value": 4081.2879837271703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.5504126946062, 734.3427632269122, 779.5829231361223, 830.9667613295468, 840.3907167303705, 15147.242637868103, 15898.761518577201, 15934.760978585331, 15945.36218551258, 15962.600934976617, 14521.20133392663, 14592.781108283385, 14632.048916820399, 14676.633084172874, 14679.706405871877, 907.9500627465487, 909.5179554835947, 933.2673851026946, 942.4345392764355, 949.378157306965, 937.3813283233068, 938.2306508662899, 938.9906100939006, 939.6241503398661, 940.614348117272, 992.3995982430633, 996.1134590214715, 998.0069830518644, 998.5656239535825, 999.5701848205268, 985.6648739428557, 987.7925635616565, 989.3519744567247, 989.8465737810651, 991.7322322972793, 731.5208538407352, 732.5714457042636, 732.9780106596811, 733.3839574757229, 736.0468193689186, 15797.526074217792, 16112.355505779871, 16130.516084517483, 16255.51233462998, 16480.0, 13975.440982360795, 13991.720165596631, 14032.0, 14056.297185140702, 14083.0, 11677.649670509812, 11829.171957962946, 11873.287602743863, 11903.880961190363, 11972.221805582609, 3591.6228795976567, 3592.8562857485667, 3623.40213864712, 3716.1824398632257, 3831.06138995945, 52198.739006305106, 87827.56086219529, 110711.48013722453, 113377.43311283473, 115955.0, 10411.895881041244, 10853.0, 11022.338659680445, 11105.38920359388, 11131.387773672526, 21902.561948760937, 21918.671219931715, 21927.12291508322, 21959.780402196095, 21974.560508789735, 5862.853428664317, 5872.58891877573, 6894.413974812097, 7431.459946711778, 7616.695332186761, 4339.1972485090355, 4367.45406824147, 4416.911661766747, 4503.347014682852, 4536.183486972311, 3349.8995030149135, 3433.8626454942023, 3440.139965008748, 3451.551298331251, 3453.8963831085107, 654.8919428294373, 676.2392308652766, 677.4174210179242, 689.1902015132199, 699.3740602161139, 677.3192941094169, 680.6528670378143, 709.2871663977669, 719.6221983458726, 739.9223081576357, 9836.213102951746, 10090.890002099763, 10103.343282686601, 10296.588136474607, 10486.213533984828, 623.4389049855076, 665.5474277491352, 702.5924963521145, 722.5953466059024, 725.8802297620833, 4702.412198475191, 5016.698998060128, 5024.221245706921, 5025.39695236574, 5028.321176641107, 96248.0, 96514.51742741241, 97320.54019189718, 100395.0, 100700.49649751704, 89460.0, 89680.0, 90150.0, 91757.54121229351, 91804.54097729603, 79328.0, 81031.3793724134, 81211.59394203109, 83824.0, 84895.57552212199, 9602.135807777333, 9715.222782177267, 9758.707238782848, 9769.46267955241, 9786.461744604116, 52869.7356513215, 53203.733981329846, 53562.660933476975, 54045.189322160986, 54989.501049894694, 64804.675976619816, 66705.66647166733, 66829.0, 66971.0, 67209.32790672031, 11446.255993360404, 11448.484818183368, 11540.365279909685, 11710.355930423908, 11839.230450020721, 14469.565913022627, 14609.0, 14690.779638305648, 14818.407263709762, 14952.700945981236, 12612.369381530703, 13203.537876174289, 13551.186928784304, 13623.727525449634, 13649.38577763983, 12390.442430090487, 13244.072914895865, 13730.588082357544, 13906.0, 14094.083884547472, 12831.294278814756, 13796.586102416944, 13964.092333998258, 13985.0, 13988.58034258974, 9788.804223915624, 9947.950260248652, 10058.195344372287, 10131.703195666043, 10678.238090715256, 9119.726408207764, 9768.316217864965, 10324.380537167794, 11537.307761534335, 11680.0], "value": 7588.338405826007, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 172.0, 147.0, 117.0, 115.0, 116.0, 117.0, 117.0, 115.0, 116.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 109.0, 147.0, 109.0, 105.0, 111.0, 110.0, 128.0, 108.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 182.0, 183.0, 182.0, 185.0, 184.0, 183.0, 184.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 60.0, 89.0, 63.0, 63.0, 62.0, 60.0, 75.0, 61.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 88.0, 70.0, 69.0, 68.0, 82.0, 68.0, 69.0, 84.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 92.0, 135.0, 87.0, 88.0, 89.0, 87.0, 87.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 100.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 86.0, 83.0, 86.0, 84.0, 83.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 64.0, 63.0, 65.0, 67.0, 66.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 68.0, 64.0, 60.0, 57.0, 58.0, 58.0, 57.0, 57.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 96.0, 100.0, 101.0, 101.0, 85.0, 80.0, 80.0, 83.0, 86.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 137.0, 136.0, 150.0, 154.0, 147.0, 141.0, 187.0, 172.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 163.0, 163.0, 166.0, 173.0, 163.0, 164.0, 165.0, 159.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 64.0, 66.0, 66.0, 61.0, 82.0, 65.0], "value": 66.4, "unit": "score"}]}]} 04:18:59 INFO - Return code: 0 04:18:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:18:59 ERROR - # TBPL SUCCESS # 04:18:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:18:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:18:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:18:59 INFO - 2017-04-03 04:18:59.297 screenresolution[1657:10037] starting screenresolution argv=screenresolution get 04:18:59 INFO - 2017-04-03 04:18:59.300 screenresolution[1657:10037] Display 0: 1600x1200x32@60 04:18:59 INFO - 2017-04-03 04:18:59.306 screenresolution[1658:10040] starting screenresolution argv=screenresolution list 04:18:59 INFO - Available Modes on Display 0 04:18:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:18:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:18:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:18:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:18:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:18:59 INFO - Intel Iris: 04:18:59 INFO - Chipset Model: Intel Iris 04:18:59 INFO - Type: GPU 04:18:59 INFO - Bus: Built-In 04:18:59 INFO - VRAM (Dynamic, Max): 1536 MB 04:18:59 INFO - Vendor: Intel (0x8086) 04:18:59 INFO - Device ID: 0x0a2e 04:18:59 INFO - Revision ID: 0x0009 04:18:59 INFO - Displays: 04:18:59 INFO - Display: 04:18:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:18:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:18:59 INFO - Display Serial Number: 1600x1200 60 04:18:59 INFO - Main Display: Yes 04:18:59 INFO - Mirror: Off 04:18:59 INFO - Online: Yes 04:18:59 INFO - Rotation: Supported 04:18:59 INFO - Return code: 0 04:18:59 INFO - Running post-action listener: _resource_record_post_action 04:18:59 INFO - [mozharness: 2017-04-03 11:18:59.544890Z] Finished run-tests step (success) 04:18:59 INFO - Running post-run listener: _resource_record_post_run 04:18:59 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38110208; Write bytes: 511396864; Read time: 245; Write time: 1593 04:18:59 INFO - TinderboxPrint: CPU usage
53.9% 04:18:59 INFO - TinderboxPrint: I/O read bytes / time
38,110,208 / 245 04:18:59 INFO - TinderboxPrint: I/O write bytes / time
511,396,864 / 1,593 04:18:59 INFO - TinderboxPrint: CPU idle
2,215.6 (46.1%) 04:18:59 INFO - TinderboxPrint: CPU system
960.1 (20.0%) 04:18:59 INFO - TinderboxPrint: CPU user
1,629.9 (33.9%) 04:18:59 INFO - TinderboxPrint: Swap in / out
246,497,280 / 0 04:18:59 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205896192; Write bytes: 202819584; Read time: 15762; Write time: 466 04:18:59 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36062208; Write bytes: 297608192; Read time: 213; Write time: 1095 04:19:00 INFO - Running post-run listener: _upload_blobber_files 04:19:00 INFO - Blob upload gear active. 04:19:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:19:00 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'] 04:19:00 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 04:19:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:03 INFO - (blobuploader) - INFO - Done attempting. 04:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:04 INFO - (blobuploader) - INFO - Done attempting. 04:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:06 INFO - (blobuploader) - INFO - Done attempting. 04:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:10 INFO - (blobuploader) - INFO - Done attempting. 04:19:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:10 INFO - Return code: 0 04:19:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01cd3f0ae717627ee8f0a7c915cd39d46d35053c301db6d8c702c5ffe1abc1851c22b527c345b36f3be61c698c0240c358dcc1342eb6d1cdd051ce8a2dcee5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab978b3f2b2e3a1f1d1e9dc7c7fcee2820939e332635adcc0d0a1363593f3ea7815b238b5a0b4ea8f5e2a356ae0054af61293f722d113ef38d923fe326f209b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e08e15f3e4983cb139d62584bedf62448b5f760c1d61a56c832f4ab791e63dcf121a8afbd5cd60c31de1ff5c0714c1be9f4f839b65080a15e117ef2b5a67d30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bee70b36eaeeced63f71b2226d7efe2ba37b52fe91d6066d4181b79f0a92b76ffecb4c4c80642e876c41f59e8b9cc969c81974f09ef59102389ff48d0499a10e"} 04:19:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:10 INFO - Contents: 04:19:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01cd3f0ae717627ee8f0a7c915cd39d46d35053c301db6d8c702c5ffe1abc1851c22b527c345b36f3be61c698c0240c358dcc1342eb6d1cdd051ce8a2dcee5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab978b3f2b2e3a1f1d1e9dc7c7fcee2820939e332635adcc0d0a1363593f3ea7815b238b5a0b4ea8f5e2a356ae0054af61293f722d113ef38d923fe326f209b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e08e15f3e4983cb139d62584bedf62448b5f760c1d61a56c832f4ab791e63dcf121a8afbd5cd60c31de1ff5c0714c1be9f4f839b65080a15e117ef2b5a67d30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bee70b36eaeeced63f71b2226d7efe2ba37b52fe91d6066d4181b79f0a92b76ffecb4c4c80642e876c41f59e8b9cc969c81974f09ef59102389ff48d0499a10e"} 04:19:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:10 INFO - Copying logs to upload dir... 04:19:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.788303 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-03 04:19:10.381818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:10.385122) ========= 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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/e01cd3f0ae717627ee8f0a7c915cd39d46d35053c301db6d8c702c5ffe1abc1851c22b527c345b36f3be61c698c0240c358dcc1342eb6d1cdd051ce8a2dcee5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab978b3f2b2e3a1f1d1e9dc7c7fcee2820939e332635adcc0d0a1363593f3ea7815b238b5a0b4ea8f5e2a356ae0054af61293f722d113ef38d923fe326f209b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e08e15f3e4983cb139d62584bedf62448b5f760c1d61a56c832f4ab791e63dcf121a8afbd5cd60c31de1ff5c0714c1be9f4f839b65080a15e117ef2b5a67d30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bee70b36eaeeced63f71b2226d7efe2ba37b52fe91d6066d4181b79f0a92b76ffecb4c4c80642e876c41f59e8b9cc969c81974f09ef59102389ff48d0499a10e"} build_url:https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/DxQRCaz9RkCiH2iDWCLXLw/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/e01cd3f0ae717627ee8f0a7c915cd39d46d35053c301db6d8c702c5ffe1abc1851c22b527c345b36f3be61c698c0240c358dcc1342eb6d1cdd051ce8a2dcee5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab978b3f2b2e3a1f1d1e9dc7c7fcee2820939e332635adcc0d0a1363593f3ea7815b238b5a0b4ea8f5e2a356ae0054af61293f722d113ef38d923fe326f209b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e08e15f3e4983cb139d62584bedf62448b5f760c1d61a56c832f4ab791e63dcf121a8afbd5cd60c31de1ff5c0714c1be9f4f839b65080a15e117ef2b5a67d30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bee70b36eaeeced63f71b2226d7efe2ba37b52fe91d6066d4181b79f0a92b76ffecb4c4c80642e876c41f59e8b9cc969c81974f09ef59102389ff48d0499a10e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:10.422499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:10.422860) ========= 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.fZ1YwdJw8h/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.mbaUMJz9eH/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:19:10.471194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:19:10.471512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:19:10.471806) ========= ========= Total master_lag: 0.18 =========