builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1489313666.73 results: success (0) buildid: 20170312004006 builduid: d71e7d8c45954750a79f3c0d2750ab78 revision: 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:26.734184) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:26.734780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:26.735068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:26.905313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:26.905642) ========= 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.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-12 03:14:26-- 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% 41.3M=0s 2017-03-12 03:14:27 (41.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.612689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:27.542180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:27.542521) ========= 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.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.026844 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:27.591422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-12 03:14:27.591796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 --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 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-12 03:14:27,696 truncating revision to first 12 chars 2017-03-12 03:14:27,696 Setting DEBUG logging. 2017-03-12 03:14:27,696 attempt 1/10 2017-03-12 03:14:27,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/83ac51cb9cfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-12 03:14:29,246 unpacking tar archive at: mozilla-aurora-83ac51cb9cfd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.847971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-12 03:14:29.463698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:29.464291) ========= script_repo_revision: 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:29.464708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:29.464970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-12 03:14:29.560904) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-03-12 03:14:29.561302) ========= /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.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:14:29 INFO - MultiFileLogger online at 20170312 03:14:29 in /builds/slave/test 03:14:29 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:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:14:29 INFO - {'append_to_log': False, 03:14:29 INFO - 'base_work_dir': '/builds/slave/test', 03:14:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:14:29 INFO - 'branch': 'Mozilla-Aurora', 03:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:14:29 INFO - 'config_files': ('talos/mac_config.py',), 03:14:29 INFO - 'default_actions': ('clobber', 03:14:29 INFO - 'read-buildbot-config', 03:14:29 INFO - 'download-and-extract', 03:14:29 INFO - 'populate-webroot', 03:14:29 INFO - 'create-virtualenv', 03:14:29 INFO - 'install', 03:14:29 INFO - 'run-tests'), 03:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:14:29 INFO - 'download_minidump_stackwalk': True, 03:14:29 INFO - 'download_symbols': 'ondemand', 03:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:14:29 INFO - 'gecko_profile': False, 03:14:29 INFO - 'gecko_profile_interval': 0, 03:14:29 INFO - 'installer_path': 'installer.exe', 03:14:29 INFO - 'log_level': 'info', 03:14:29 INFO - 'log_name': 'talos', 03:14:29 INFO - 'log_to_console': True, 03:14:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:14:29 INFO - 'opt_config_files': (), 03:14:29 INFO - 'pip_index': False, 03:14:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:29 INFO - 'cmd': ('bash', 03:14:29 INFO - '-c', 03:14:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:29 INFO - 'enabled': True, 03:14:29 INFO - 'halt_on_failure': False, 03:14:29 INFO - 'name': 'check_screen_resolution'},), 03:14:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:29 INFO - 'cmd': ('bash', 03:14:29 INFO - '-c', 03:14:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:29 INFO - 'enabled': True, 03:14:29 INFO - 'halt_on_failure': False, 03:14:29 INFO - 'name': 'check_screen_resolution'},), 03:14:29 INFO - 'run_cmd_checks_enabled': True, 03:14:29 INFO - 'suite': 'dromaeojs', 03:14:29 INFO - 'system_bits': '32', 03:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:14:29 INFO - 'title': 't-yosemite-r7-0225', 03:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:14:29 INFO - 'use_talos_json': True, 03:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:14:29 INFO - 'work_dir': 'build'} 03:14:29 INFO - [mozharness: 2017-03-12 10:14:29.778456Z] Running clobber step. 03:14:29 INFO - Running pre-action listener: _resource_record_pre_action 03:14:29 INFO - Running main action method: clobber 03:14:29 INFO - rmtree: /builds/slave/test/build 03:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:14:32 INFO - Running post-action listener: _resource_record_post_action 03:14:32 INFO - [mozharness: 2017-03-12 10:14:32.161690Z] Finished clobber step (success) 03:14:32 INFO - [mozharness: 2017-03-12 10:14:32.161821Z] Running read-buildbot-config step. 03:14:32 INFO - Running pre-action listener: _resource_record_pre_action 03:14:32 INFO - Running main action method: read_buildbot_config 03:14:32 INFO - Using buildbot properties: 03:14:32 INFO - { 03:14:32 INFO - "project": "", 03:14:32 INFO - "product": "firefox", 03:14:32 INFO - "script_repo_revision": "production", 03:14:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:14:32 INFO - "repository": "", 03:14:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:14:32 INFO - "buildid": "20170312004006", 03:14:32 INFO - "stage_platform": "macosx64", 03:14:32 INFO - "basedir": "/builds/slave/test", 03:14:32 INFO - "nightly_build": "True", 03:14:32 INFO - "buildnumber": 12, 03:14:32 INFO - "slavename": "t-yosemite-r7-0225", 03:14:32 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:14:32 INFO - "platform": "yosemite_r7", 03:14:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:14:32 INFO - "branch": "mozilla-aurora", 03:14:32 INFO - "repo_path": "releases/mozilla-aurora", 03:14:32 INFO - "revision": "83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67", 03:14:32 INFO - "pgo_build": "False", 03:14:32 INFO - "builduid": "d71e7d8c45954750a79f3c0d2750ab78", 03:14:32 INFO - "slavebuilddir": "test" 03:14:32 INFO - } 03:14:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:14:32 INFO - Running post-action listener: _resource_record_post_action 03:14:32 INFO - [mozharness: 2017-03-12 10:14:32.165219Z] Finished read-buildbot-config step (success) 03:14:32 INFO - [mozharness: 2017-03-12 10:14:32.165303Z] Running download-and-extract step. 03:14:32 INFO - Running pre-action listener: _resource_record_pre_action 03:14:32 INFO - Running main action method: download_and_extract 03:14:32 INFO - mkdir: /builds/slave/test/build/tests 03:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:32 INFO - trying https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:14:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/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:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/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:14:33 INFO - Downloaded 1199 bytes. 03:14:33 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:14:33 INFO - Using the following test package requirements: 03:14:33 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:14:33 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:14:33 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:14:33 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'jsshell-mac.zip'], 03:14:33 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:14:33 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:14:33 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:14:33 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:14:33 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:14:33 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:14:33 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:14:33 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:14:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:14:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:14:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:14:34 INFO - Expected file size: 51779538 03:14:34 INFO - Obtained file size: 51779538 03:14:50 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:14:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:14:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:14:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:14:56 INFO - Expected file size: 51779538 03:14:56 INFO - Obtained file size: 51779538 03:15:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:15:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:15:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:15:12 INFO - Expected file size: 14404424 03:15:12 INFO - Obtained file size: 14404424 03:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:13 INFO - trying https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:15:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/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:15:29 INFO - Downloaded 74649759 bytes. 03:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:15:29 INFO - mkdir: /builds/slave/test/properties 03:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:29 INFO - Contents: 03:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:15:30 INFO - Running post-action listener: _resource_record_post_action 03:15:30 INFO - Running post-action listener: set_extra_try_arguments 03:15:30 INFO - [mozharness: 2017-03-12 10:15:30.743953Z] Finished download-and-extract step (success) 03:15:30 INFO - [mozharness: 2017-03-12 10:15:30.744109Z] Running populate-webroot step. 03:15:30 INFO - Running pre-action listener: _resource_record_pre_action 03:15:30 INFO - Running main action method: populate_webroot 03:15:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:30 INFO - '--tppagecycles', 03:15:30 INFO - '7'], 03:15:30 INFO - 'tests': ['tsvgm']}}, 03:15:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['damp', 'tps']}, 03:15:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'tests': ['damp', 'tps']}, 03:15:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['dromaeo_dom']}, 03:15:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['basic_compositor_video']}, 03:15:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:15:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['a11yr', 03:15:30 INFO - 'ts_paint', 03:15:30 INFO - 'tpaint', 03:15:30 INFO - 'sessionrestore', 03:15:30 INFO - 'sessionrestore_no_auto_restore', 03:15:30 INFO - 'tabpaint']}, 03:15:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['tsvgx', 03:15:30 INFO - 'tsvgr_opacity', 03:15:30 INFO - 'tart', 03:15:30 INFO - 'tscrollx', 03:15:30 INFO - 'cart', 03:15:30 INFO - 'tsvg_static']}, 03:15:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:30 INFO - 'tsvgr_opacity', 03:15:30 INFO - 'tart', 03:15:30 INFO - 'tscrollx', 03:15:30 INFO - 'cart', 03:15:30 INFO - 'tsvg_static']}, 03:15:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'talos_options': ['--disable-e10s'], 03:15:30 INFO - 'tests': ['tp5o']}, 03:15:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:15:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'talos_options': ['--disable-e10s', 03:15:30 INFO - '--xperf_path', 03:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:30 INFO - 'tests': ['tp5n']}, 03:15:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:15:30 INFO - 'talos_options': ['--xperf_path', 03:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:30 INFO - 'tests': ['tp5n']}}, 03:15:30 INFO - 'talos.zip': {'path': '', 03:15:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:30 INFO - Running post-action listener: _resource_record_post_action 03:15:30 INFO - [mozharness: 2017-03-12 10:15:30.763002Z] Finished populate-webroot step (success) 03:15:30 INFO - [mozharness: 2017-03-12 10:15:30.763140Z] Running create-virtualenv step. 03:15:30 INFO - Running pre-action listener: _resource_record_pre_action 03:15:30 INFO - Running main action method: create_virtualenv 03:15:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:30 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:15:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:30 INFO - Using real prefix '/tools/python27' 03:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:34 INFO - Installing pip.................done. 03:15:34 INFO - Return code: 0 03:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:15:34 INFO - Reading from file tmpfile_stdout 03:15:34 INFO - Output received: 03:15:34 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:15:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:34 INFO - 'HOME': '/Users/cltbld', 03:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:34 INFO - 'LOGNAME': 'cltbld', 03:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:34 INFO - 'MOZ_NO_REMOTE': '1', 03:15:34 INFO - 'NO_EM_RESTART': '1', 03:15:34 INFO - 'PAGER': '/bin/cat', 03:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:34 INFO - 'PWD': '/builds/slave/test', 03:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:34 INFO - 'SHELL': '/bin/bash', 03:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:34 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:34 INFO - 'USER': 'cltbld', 03:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:34 INFO - 'XPC_FLAGS': '0x0', 03:15:34 INFO - 'XPC_SERVICE_NAME': '0', 03:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:35 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:15:35 INFO - Cleaning up... 03:15:35 INFO - Return code: 0 03:15:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:35 INFO - 'HOME': '/Users/cltbld', 03:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:35 INFO - 'LOGNAME': 'cltbld', 03:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:35 INFO - 'MOZ_NO_REMOTE': '1', 03:15:35 INFO - 'NO_EM_RESTART': '1', 03:15:35 INFO - 'PAGER': '/bin/cat', 03:15:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:35 INFO - 'PWD': '/builds/slave/test', 03:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:35 INFO - 'SHELL': '/bin/bash', 03:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:35 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:35 INFO - 'USER': 'cltbld', 03:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:35 INFO - 'XPC_FLAGS': '0x0', 03:15:35 INFO - 'XPC_SERVICE_NAME': '0', 03:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:35 INFO - Downloading/unpacking psutil>=3.1.1 03:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:41 INFO - Installing collected packages: psutil 03:15:41 INFO - Running setup.py install for psutil 03:15:41 INFO - building 'psutil._psutil_osx' extension 03:15:41 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:15:42 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:15:42 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:15:42 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:15:42 INFO - building 'psutil._psutil_posix' extension 03:15:42 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:15:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:15:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:15:42 INFO - ^ 03:15:42 INFO - 1 warning generated. 03:15:42 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:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:42 INFO - Successfully installed psutil 03:15:42 INFO - Cleaning up... 03:15:42 INFO - Return code: 0 03:15:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15:42 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:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:42 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:15:42 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:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:42 INFO - 'HOME': '/Users/cltbld', 03:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:42 INFO - 'LOGNAME': 'cltbld', 03:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:42 INFO - 'MOZ_NO_REMOTE': '1', 03:15:42 INFO - 'NO_EM_RESTART': '1', 03:15:42 INFO - 'PAGER': '/bin/cat', 03:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:42 INFO - 'PWD': '/builds/slave/test', 03:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:42 INFO - 'SHELL': '/bin/bash', 03:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:42 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:42 INFO - 'USER': 'cltbld', 03:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:42 INFO - 'XPC_FLAGS': '0x0', 03:15:42 INFO - 'XPC_SERVICE_NAME': '0', 03:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:43 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:15:43 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:15:43 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:15:43 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:15:43 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:15:43 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:15:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:46 INFO - Installing collected packages: mozsystemmonitor 03:15:46 INFO - Running setup.py install for mozsystemmonitor 03:15:47 INFO - Successfully installed mozsystemmonitor 03:15:47 INFO - Cleaning up... 03:15:47 INFO - Return code: 0 03:15:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:47 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:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 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:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:47 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:47 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:15:47 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:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:47 INFO - 'HOME': '/Users/cltbld', 03:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:47 INFO - 'LOGNAME': 'cltbld', 03:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:47 INFO - 'MOZ_NO_REMOTE': '1', 03:15:47 INFO - 'NO_EM_RESTART': '1', 03:15:47 INFO - 'PAGER': '/bin/cat', 03:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:47 INFO - 'PWD': '/builds/slave/test', 03:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:47 INFO - 'SHELL': '/bin/bash', 03:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:47 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:47 INFO - 'USER': 'cltbld', 03:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:47 INFO - 'XPC_FLAGS': '0x0', 03:15:47 INFO - 'XPC_SERVICE_NAME': '0', 03:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:47 INFO - Downloading/unpacking jsonschema==2.5.1 03:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:47 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:15:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 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:15:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:51 INFO - warning: no files found matching '*.txt' 03:15:51 INFO - no previously-included directories found matching 'build' 03:15:51 INFO - no previously-included directories found matching 'dist' 03:15:51 INFO - no previously-included directories found matching '.git*' 03:15:51 INFO - Installing collected packages: jsonschema, functools32 03:15:51 INFO - Running setup.py install for functools32 03:15:52 INFO - warning: no files found matching '*.txt' 03:15:52 INFO - no previously-included directories found matching 'build' 03:15:52 INFO - no previously-included directories found matching 'dist' 03:15:52 INFO - no previously-included directories found matching '.git*' 03:15:52 INFO - Successfully installed jsonschema functools32 03:15:52 INFO - Cleaning up... 03:15:52 INFO - Return code: 0 03:15:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:15:52 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:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:52 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:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:52 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:52 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:15:52 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:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:52 INFO - 'HOME': '/Users/cltbld', 03:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:52 INFO - 'LOGNAME': 'cltbld', 03:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:52 INFO - 'MOZ_NO_REMOTE': '1', 03:15:52 INFO - 'NO_EM_RESTART': '1', 03:15:52 INFO - 'PAGER': '/bin/cat', 03:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:52 INFO - 'PWD': '/builds/slave/test', 03:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:52 INFO - 'SHELL': '/bin/bash', 03:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:52 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:52 INFO - 'USER': 'cltbld', 03:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:52 INFO - 'XPC_FLAGS': '0x0', 03:15:52 INFO - 'XPC_SERVICE_NAME': '0', 03:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:15:52 INFO - Cleaning up... 03:15:52 INFO - Return code: 0 03:15:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:52 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:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:52 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:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:52 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:15:52 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:15:52 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:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:52 INFO - 'HOME': '/Users/cltbld', 03:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:52 INFO - 'LOGNAME': 'cltbld', 03:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:52 INFO - 'MOZ_NO_REMOTE': '1', 03:15:52 INFO - 'NO_EM_RESTART': '1', 03:15:52 INFO - 'PAGER': '/bin/cat', 03:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:52 INFO - 'PWD': '/builds/slave/test', 03:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:52 INFO - 'SHELL': '/bin/bash', 03:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:15:52 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:52 INFO - 'USER': 'cltbld', 03:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:52 INFO - 'XPC_FLAGS': '0x0', 03:15:52 INFO - 'XPC_SERVICE_NAME': '0', 03:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:58 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:15:58 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:15:58 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:15:58 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:15:58 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:15:58 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:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:00 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:16:00 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:16:00 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:16:00 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:16:00 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:16:00 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:16:00 INFO - Downloading docopt-0.6.1.tar.gz 03:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:01 INFO - Running setup.py install for blobuploader 03:16:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:01 INFO - Running setup.py install for requests 03:16:01 INFO - Running setup.py install for docopt 03:16:01 INFO - Successfully installed blobuploader requests docopt 03:16:01 INFO - Cleaning up... 03:16:01 INFO - Return code: 0 03:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:01 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:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:01 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:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:01 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:16:01 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:16:01 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:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:01 INFO - 'HOME': '/Users/cltbld', 03:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:01 INFO - 'LOGNAME': 'cltbld', 03:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:01 INFO - 'MOZ_NO_REMOTE': '1', 03:16:01 INFO - 'NO_EM_RESTART': '1', 03:16:01 INFO - 'PAGER': '/bin/cat', 03:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:01 INFO - 'PWD': '/builds/slave/test', 03:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:01 INFO - 'SHELL': '/bin/bash', 03:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:16:01 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:01 INFO - 'USER': 'cltbld', 03:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:01 INFO - 'XPC_FLAGS': '0x0', 03:16:01 INFO - 'XPC_SERVICE_NAME': '0', 03:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Z7sZ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-iyHURu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-bU36pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-u3SjkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-KEfdsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-CzsrvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-DZHrrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_y4mrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:02 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-QWVBxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-pg261X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Fjn_yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5NrM1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-fNhTeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-FVlNkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-7m0lvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-XnQWLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:03 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-LUX1YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:03 INFO - Running setup.py install for manifestparser 03:16:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:04 INFO - Running setup.py install for mozcrash 03:16:04 INFO - Running setup.py install for mozdebug 03:16:04 INFO - Running setup.py install for mozdevice 03:16:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:04 INFO - Running setup.py install for mozfile 03:16:04 INFO - Running setup.py install for mozhttpd 03:16:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:04 INFO - Running setup.py install for mozinfo 03:16:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozInstall 03:16:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozleak 03:16:05 INFO - Running setup.py install for mozlog 03:16:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for moznetwork 03:16:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozprocess 03:16:05 INFO - Running setup.py install for mozprofile 03:16:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:05 INFO - Running setup.py install for mozrunner 03:16:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozscreenshot 03:16:06 INFO - Running setup.py install for moztest 03:16:06 INFO - Running setup.py install for mozversion 03:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:06 INFO - Cleaning up... 03:16:06 INFO - Return code: 0 03:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:06 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:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:06 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:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:06 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:16:06 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:16:06 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:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:06 INFO - 'HOME': '/Users/cltbld', 03:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:06 INFO - 'LOGNAME': 'cltbld', 03:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:06 INFO - 'MOZ_NO_REMOTE': '1', 03:16:06 INFO - 'NO_EM_RESTART': '1', 03:16:06 INFO - 'PAGER': '/bin/cat', 03:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:06 INFO - 'PWD': '/builds/slave/test', 03:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:06 INFO - 'SHELL': '/bin/bash', 03:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:16:06 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:06 INFO - 'USER': 'cltbld', 03:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:06 INFO - 'XPC_FLAGS': '0x0', 03:16:06 INFO - 'XPC_SERVICE_NAME': '0', 03:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:06 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-dKHZM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:06 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:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:06 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6EqSjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-MnWbSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-oCA1e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-0DIRs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mwrdI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-VRxD7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8hDS5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-YQ9jeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-dE06cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:07 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:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:07 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-RHB_oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xjwShl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_8mBbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-uDcsou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-jtfKNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-m9c7Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:08 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yNA0En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:08 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:16:08 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:16:08 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:16:08 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:16:08 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:16:08 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:16:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:08 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:16:08 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:16:08 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:16:08 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:16:08 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:16:08 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:16:11 INFO - Downloading blessings-1.6.tar.gz 03:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:12 INFO - Installing collected packages: blessings 03:16:12 INFO - Running setup.py install for blessings 03:16:12 INFO - Successfully installed blessings 03:16:12 INFO - Cleaning up... 03:16:12 INFO - Return code: 0 03:16:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:12 INFO - Reading from file tmpfile_stdout 03:16:12 INFO - Current package versions: 03:16:12 INFO - blessings == 1.6 03:16:12 INFO - blobuploader == 1.2.4 03:16:12 INFO - docopt == 0.6.1 03:16:12 INFO - functools32 == 3.2.3-2 03:16:12 INFO - jsonschema == 2.5.1 03:16:12 INFO - manifestparser == 1.1 03:16:12 INFO - mozInstall == 1.12 03:16:12 INFO - mozcrash == 1.0 03:16:12 INFO - mozdebug == 0.1 03:16:12 INFO - mozdevice == 0.49 03:16:12 INFO - mozfile == 1.2 03:16:12 INFO - mozhttpd == 0.7 03:16:12 INFO - mozinfo == 0.9 03:16:12 INFO - mozleak == 0.1 03:16:12 INFO - mozlog == 3.4 03:16:12 INFO - moznetwork == 0.27 03:16:12 INFO - mozprocess == 0.25 03:16:12 INFO - mozprofile == 0.28 03:16:12 INFO - mozrunner == 6.13 03:16:12 INFO - mozscreenshot == 0.1 03:16:12 INFO - mozsystemmonitor == 0.3 03:16:12 INFO - moztest == 0.8 03:16:12 INFO - mozversion == 1.4 03:16:12 INFO - psutil == 3.1.1 03:16:12 INFO - requests == 1.2.3 03:16:12 INFO - wsgiref == 0.1.2 03:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:12 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:16:12 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:16:12 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:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:12 INFO - 'HOME': '/Users/cltbld', 03:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:12 INFO - 'LOGNAME': 'cltbld', 03:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:12 INFO - 'MOZ_NO_REMOTE': '1', 03:16:12 INFO - 'NO_EM_RESTART': '1', 03:16:12 INFO - 'PAGER': '/bin/cat', 03:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:12 INFO - 'PWD': '/builds/slave/test', 03:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:12 INFO - 'SHELL': '/bin/bash', 03:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:16:12 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:12 INFO - 'USER': 'cltbld', 03:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:12 INFO - 'XPC_FLAGS': '0x0', 03:16:12 INFO - 'XPC_SERVICE_NAME': '0', 03:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:12 INFO - Cleaning up... 03:16:12 INFO - Return code: 0 03:16:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:12 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 0x1087e4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087e7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa623593260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, '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.whC1CxXfp9/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.3NqjVim4mc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:16:12 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:16:12 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:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:12 INFO - 'HOME': '/Users/cltbld', 03:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:12 INFO - 'LOGNAME': 'cltbld', 03:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:12 INFO - 'MOZ_NO_REMOTE': '1', 03:16:12 INFO - 'NO_EM_RESTART': '1', 03:16:12 INFO - 'PAGER': '/bin/cat', 03:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:12 INFO - 'PWD': '/builds/slave/test', 03:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:12 INFO - 'SHELL': '/bin/bash', 03:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:16:12 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:12 INFO - 'USER': 'cltbld', 03:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:12 INFO - 'XPC_FLAGS': '0x0', 03:16:12 INFO - 'XPC_SERVICE_NAME': '0', 03:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:13 INFO - Cleaning up... 03:16:13 INFO - Return code: 0 03:16:13 INFO - Running post-action listener: _resource_record_post_action 03:16:13 INFO - Running post-action listener: _start_resource_monitoring 03:16:13 INFO - Starting resource monitoring. 03:16:13 INFO - [mozharness: 2017-03-12 10:16:13.268483Z] Finished create-virtualenv step (success) 03:16:13 INFO - [mozharness: 2017-03-12 10:16:13.269521Z] Running install step. 03:16:13 INFO - Running pre-action listener: _resource_record_pre_action 03:16:13 INFO - Running main action method: install 03:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Output received: 03:16:13 INFO - Usage: mozinstall [options] installer 03:16:13 INFO - Options: 03:16:13 INFO - -h, --help show this help message and exit 03:16:13 INFO - -d DEST, --destination=DEST 03:16:13 INFO - Directory to install application into. [default: 03:16:13 INFO - "/builds/slave/test"] 03:16:13 INFO - --app=APP Application being installed. [default: firefox] 03:16:13 INFO - mkdir: /builds/slave/test/build/application 03:16:13 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:16:13 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:16:33 INFO - Reading from file tmpfile_stdout 03:16:33 INFO - Output received: 03:16:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:16:33 INFO - Running post-action listener: _resource_record_post_action 03:16:33 INFO - [mozharness: 2017-03-12 10:16:33.855186Z] Finished install step (success) 03:16:33 INFO - [mozharness: 2017-03-12 10:16:33.855348Z] Running run-tests step. 03:16:33 INFO - Running pre-action listener: _resource_record_pre_action 03:16:33 INFO - Running main action method: run_tests 03:16:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:33 INFO - 2017-03-12 03:16:33.870 screenresolution[1637:9141] starting screenresolution argv=screenresolution get 03:16:33 INFO - 2017-03-12 03:16:33.873 screenresolution[1637:9141] Display 0: 1600x1200x32@60 03:16:33 INFO - 2017-03-12 03:16:33.879 screenresolution[1638:9144] starting screenresolution argv=screenresolution list 03:16:33 INFO - Available Modes on Display 0 03:16:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:34 INFO - Intel Iris: 03:16:34 INFO - Chipset Model: Intel Iris 03:16:34 INFO - Type: GPU 03:16:34 INFO - Bus: Built-In 03:16:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:34 INFO - Vendor: Intel (0x8086) 03:16:34 INFO - Device ID: 0x0a2e 03:16:34 INFO - Revision ID: 0x0009 03:16:34 INFO - Displays: 03:16:34 INFO - Display: 03:16:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:34 INFO - Display Serial Number: 1600x1200 60 03:16:34 INFO - Main Display: Yes 03:16:34 INFO - Mirror: Off 03:16:34 INFO - Online: Yes 03:16:34 INFO - Rotation: Supported 03:16:34 INFO - Return code: 0 03:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:34 INFO - Python 2.7.3 03:16:34 INFO - Return code: 0 03:16:34 INFO - grabbing minidump binary from tooltool 03:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:34 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 0x1085c2d30>, '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 0x1084e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085b7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:34 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:16:34 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:16:34 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:16:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:34 INFO - Return code: 0 03:16:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:16:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:34 INFO - ENV: RUST_BACKTRACE is now 1 03:16:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:16:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:34 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/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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:16:34 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/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --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:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whC1CxXfp9/Render', 03:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:34 INFO - 'HOME': '/Users/cltbld', 03:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:34 INFO - 'LOGNAME': 'cltbld', 03:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:34 INFO - 'MOZ_NO_REMOTE': '1', 03:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:34 INFO - 'NO_EM_RESTART': '1', 03:16:34 INFO - 'PAGER': '/bin/cat', 03:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:34 INFO - 'PWD': '/builds/slave/test', 03:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:34 INFO - 'RUST_BACKTRACE': '1', 03:16:34 INFO - 'SHELL': '/bin/bash', 03:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3NqjVim4mc/Listeners', 03:16:34 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:34 INFO - 'USER': 'cltbld', 03:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:34 INFO - 'XPC_FLAGS': '0x0', 03:16:34 INFO - 'XPC_SERVICE_NAME': '0', 03:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:34 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/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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:16:34 INFO - mozversion application_buildid: 20170312004006 03:16:34 INFO - mozversion application_changeset: 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 03:16:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:34 INFO - mozversion application_name: Firefox 03:16:34 INFO - mozversion application_remotingname: firefox-dev 03:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:34 INFO - mozversion application_vendor: Mozilla 03:16:34 INFO - mozversion application_version: 54.0a2 03:16:34 INFO - mozversion platform_buildid: 20170312004006 03:16:34 INFO - mozversion platform_changeset: 83ac51cb9cfdfc5985d68a6ddc30eb86a9ceef67 03:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:34 INFO - mozversion platform_version: 54.0a2 03:16:34 INFO - using testdate: 1489313794 03:16:34 INFO - actual date: 1489313794 03:16:34 INFO - starting webserver on 'localhost:49249' 03:16:34 INFO - SUITE-START | Running 2 tests 03:16:34 INFO - TEST-START | dromaeo_css 03:16:34 INFO - operating with platform_type : mac_ 03:16:34 INFO - Initialising browser for dromaeo_css test... 03:16:34 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmptJ72jJ/profile http://localhost:49249/getInfo.html) 03:16:37 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 03:16:37 INFO - PROCESS | 1648 | colorDepth:24 03:16:37 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 03:16:37 INFO - PROCESS | 1648 | __metrics 03:16:37 INFO - PROCESS | 1648 | 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:16:37 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:38 INFO - TEST-INFO | 1648: exit 0 03:16:38 INFO - Browser initialized. 03:16:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:38 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmptJ72jJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:50 INFO - PROCESS | 1652 | RSS: Main: 214880256 03:16:50 INFO - PROCESS | 1652 | 03:19:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 03:19:57 INFO - PROCESS | 1652 | RSS: Main: 398970880 03:19:57 INFO - PROCESS | 1652 | 03:21:39 INFO - PROCESS | 1652 | ************************* 03:21:39 INFO - PROCESS | 1652 | A coding exception was thrown and uncaught in a Task. 03:21:39 INFO - PROCESS | 1652 | 03:21:39 ERROR - PROCESS | 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:21:39 INFO - PROCESS | 1652 | Full stack: 03:21:39 INFO - PROCESS | 1652 | ************************* 03:23:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 03:23:01 INFO - PROCESS | 1652 | RSS: Main: 352022528 03:23:01 INFO - PROCESS | 1652 | 03:26:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 03:26:04 INFO - PROCESS | 1652 | RSS: Main: 334196736 03:26:04 INFO - PROCESS | 1652 | 03:29:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 03:29:07 INFO - PROCESS | 1652 | RSS: Main: 326217728 03:29:07 INFO - PROCESS | 1652 | 03:32:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 03:32:11 INFO - PROCESS | 1652 | RSS: Main: 328167424 03:32:11 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 03:35:15 INFO - PROCESS | 1652 | RSS: Main: 598888448 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | __start_tp_report 03:35:15 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 03:35:15 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 03:35:15 INFO - PROCESS | 1652 | |i|pagename|runs| 03:35:15 INFO - PROCESS | 1652 | |0;dojo.html;3412.607550131734;3419.145213696576;3424.041268444835;3439.0886415099985;3476.235228249786;5918.970405147974;5923.081922302039;5984.072468767348;5995.880082398349;6020.668863212527;5974.8506287342725;6038.456538911497;6051.394860513947;6070.301915279744;6077.696115194233;4524.253498172798;5371.979323928451;5377.435369286227;5421.810236641718;5471.863203419926;5344.518993290603;5348.572114230872;5420.214068959998;5440.347158340985;5449.945500545004;5417.83746487606;5418;5422.48486393792;5424.945750542483;5447.12845944649;5430.972845135789;5442.183672449125;5442.591805614595;5448.645838020536;5451.127819548893;5299.894002119936;5387.568994480472;5404.432534583891;5411.56707463402;5425.593080518976;5993.550483713695;6005.909911351289;6010.639361638316;6027.578069535134;6035.517158627299;6390.201224846895;6404.4236018758065;6408.871822563569;6417.294097649255;6420.293767685597;6373.107764912916;6374.553781235315;6392.616443013434;6398.424141827211;6416.7754128605275;6117.418845209698;6129.846753831145;6135.570510064297;6137.508999280047;6151.169592105053;5005.524475174852;6336.04959256106;6362.268339141058;6425.871482570323;6482.805515834532;5265.605079619044;6142.529470848956;6332.018537126753;6340.3976622221735;6341.778037768656;4849.456693744066;6355.777547785805;6397.936020639734;6409.647469389135;6431.839204019843;6355.968220158962;6368.203974503187;6384.170057892445;6386.10594516768;6423.357664233539;6390.680465976682;6423.518236132309;6424.13274207976;6432.839179020469;6433.228012638513;5040.697558146523;5112.872178195575;5116.718580478109;5167.354080739908;5182.274481572583;3724.6647801697436;4524.47968483622;4529.230030894756;4566;4588.747618880993;6053;6063.818085457443;6064.514838812973;6071.150038994544;6081.087836824423;6340.365963403623;6372.522060845455;6385.616862988236;6420.646864422408;6495.805125846232;6001.639901605918;6001.7599296027665;6112.755489780359;6128.264608247039;6138.815835524942;5678.68767217807;5692.402297758758;5711.200431939532;5714.2571465710025;5716.1997320375185;6642.368974947372;6651.767188148391;6682.9331706682315;6692.130023096966;6693.464522838161;5342.9465705342445;6313.873722525615;6378.425941665272;6397.616143031433;6486.513511486752;6504.512161587805;6520.087187793618;6521.217453905561;6540.215174179129;6553.082568440517;6337.302896681454;6379.77670781539;6379.904301435575;6413;6430.164078669743;6480.675966201766;6485.967570162119;6490.8052758417325;6495.350464953467;6504.219493660791;5093.821716239914;6203.565750397429;6334.841628959313;6389.009703495965;6391.041343798467;6278.466330361788;6288.5598008138995;6290.433860952537;6297.307296197506;6301.558890877778;6154.938450615616;6169.84575385601;6192.628442293477;6260.593061450991;6280.277768056732;6347;6362.395572420613;6366;6367.299597044414;6397.616143031247;6279.937200628118;6296.244450665949;6304.211973503312;6310.6529140895855;6322.3045464997895 03:35:15 INFO - PROCESS | 1652 | |1;ext.html;667.2393471442556;748.827769612989;813.6704634622976;878.1043335797486;890.0921060518276;27927.72072279279;39926.60073399265;40374.79812600933;40448.99999999996;40571.391429128584;41534.58465415345;41606;41614.16771664565;41653.16693666133;41657.37513937293;9222.077792220774;9384.436933783994;9393.295502837314;9399.154076133147;9448.055194480532;6375.936240637604;7268.854622907539;7528.698852045912;7540.472166948316;7550.735724249625;10837.67486975392;11085.168612354066;11183.776324473505;11183.888161118406;11191.328520288767;10922.18083643726;10951;10962.725931851688;10966.396848173346;10973.177011724112;5563.36021357541;10280.331778434453;10874.45627718611;10948.905109488987;10949.178811589083;27939.720602793914;28106;28154.718452815618;38494;39070.804645976874;3804.5054142961517;3847.1343947611845;3859.6333348331864;3922.882313530599;4031.798410079514;26140;26605.86697066502;26617.201483955512;26826.597601036;28755.712442875512;3138.2938838761324;3183.920401989969;3188.9043328700177;3260.576125103745;3286.9506957395656;355244;355909;356238;356336.2183189119;359463;52228.47771522312;52304.21543676848;52354.47645523496;52393.47606523962;52401;54704.17943730847;54734.72632636891;54762.45237547653;54766.630834228665;54821.903561929335;12253.95841353477;14816.777748333783;14938.70122597542;14961.40154393812;14994.850051499345;12914;12935.223886566837;12951.287679177736;12957.870421295855;12962.935185324202;9212.447253164832;10364.689059328231;10574.471276436147;12007.759844803055;12131.332776697367;4612.60792832613;4779.942718489069;5633.239712540907;6014.398560143951;6190.473809726223;948.9335746497679;963.6097380560884;966.9951650241844;975.8046393168312;1006.2503434940869;27512;27675.169744907686;27839.582406263922;28126.43747125046;28230;1038.8337865941412;1046.6441409920662;1082.4641802307908;1083.2525557365393;1091.4597274349248;14324.212168330634;14391.568252952427;14495.20276384788;14577.562673119823;14662;441206.79396602814;443934;444255;444554;446146;55489;55581.44418555763;55585;55684;55837.72081139568;1421.3603878254826;1461.189040082743;1464.0556840837812;1467.185711929889;1471.3893734100443;26387.868060659574;26741.732582673925;26802.463950721267;27565.31086722848;27643.170704878885;45050;45151.77424112859;45235.32147017732;45269.77365113153;45329.41347052837;420235;421212;421480;422668;423283.8835805801;29176.687049083266;29716.55425168581;30828.53757193599;30877.8456107718;32146;38198.80900595479;38908.80545597367;39078.24147913408;39384.21231575295;39466.605333946296;32268.35463290674;32616.510752339207;32665.18337041593;33060.66939330672;33608.32783344271;32157.35685286328;33235.6705731768;33326.33347333088;33548.161295967795;33553.32893342071;32122;32666.836665816518;33077.17307067342;33168.50247246341;33209.33581328311;27074.32314192161;27691.892324306802;29547.704522954496;29969;29984.61968680093;22641.320760377213;22969.540609188058;23005.194818181284;23018.53962920766;23109.84450777488 03:35:15 INFO - PROCESS | 1652 | |2;jquery.html;383.4746397435514;423.6986905151208;426.82500174928276;432.20258622840845;435.373062789583;13153.342332883354;16689.83310166898;19904.004799760027;21905.561888762255;22130.225442109488;21741.13035478579;21975;22448.55102897941;22733;22843.657345139796;6803.55776874504;6804.48966327525;6813.761518346859;6905.413039891615;6914.55055421396;6679.064930909676;6790.898136527956;6881.65591720412;6883.414909732679;6903.758368457105;6608.405243528082;6804.897926531081;6880.483963702717;6894.069300644424;6905.965470172668;6771.661416929183;6800.557963732391;6856.314368563154;6931.064306318633;6936.549124306929;6702.899456508157;6704.363085506869;6710.966445167792;6711.362420570038;6717.227518835348;26331.473370532483;26390;26508.73491265082;26853.462930741473;26946.730532694815;3344.4481660525985;3384.76306658534;3424.4007298722872;3425.6231814500384;3429.091290807913;15831.366745330173;15929.522114336589;15963.680726385523;16005;16548;1988.5028742814297;1989.1446677928484;2049.3851844446754;2065.710800487933;2068.6483297839404;111669;137732;139806;149441.50558494384;152640.23679881642;14858.514148585054;15997.60005999836;19881.204751810055;19883.801161988486;20292.898535507524;29233.85383073071;29271;29685.1094467162;29820.552691709643;29822.40355192884;7230.602316872517;8589.312854971588;9684.41893486393;10247;10357.896421035844;7004.299570042955;8605.569721514024;8673.04596494385;8754.47473151613;8822.117788221254;8505.23452889243;8684.044755076937;9255.676051338305;9349.502320179843;9469.337146399686;3541.831195705411;3594.8185855518054;3795.316842968237;3871.3612253977776;3879.922401551953;791.9287264146254;813.6818354266127;889.3152272749946;895.6865097215922;919.0763282900775;21306;21790.89104554467;21854.781452185274;21914.342569722932;21933.341999740034;898.6270697660528;908.9590968406437;920.8342498350228;926.8053708721109;931.5854444772147;11142.164337674707;11321.94339028316;11405.714857128638;11416.771664566662;11471.885281147082;704797;713957;714266;721921;722696.3865180745;109823.45088274508;127182.36408817896;135932;153723.23138384236;164394;1177.8822117788325;1220.6216073017392;1235.7034311765112;1279.2963869871533;1285.2095960984113;19598.902005489883;19869.900650496656;20321.79678203199;20329.186832527124;20336.59326813426;62945.68527157335;63753.36246637474;65258;65965.67017164883;67563.66218169074;86886.56556717175;87620.5329694229;88957.11042889488;90103;90233.54883225805;7670.348020418327;10907.345559266469;11284.435778210893;11446.255993360404;11806;12722.982161426879;12776.808347874976;12796.296203708513;13076.673083172996;13106.737865242832;11028.613998510335;11082.833757493805;11363.54545818191;11379.943100284445;11499.425028748696;9148.496832674267;9437.57530911097;10763.623273185402;10770.353778773298;10987.670369888916;11245;11280.943595281971;11542.711432214262;11552.364619945984;11673.007794337576;11384.316940983568;11407.885921140682;11673.649790506299;11745;11767.470463829319;8538.892834262653;10533.104686101768;10985.68405328022;11180.608678696206;11324.150688698546 03:35:15 INFO - PROCESS | 1652 | |3;mootools.html;1553.231150580462;1560.258877033409;1561.2037860691044;1579.849914258145;1592.1004632382699;10484.108850747685;11046.668599941995;11056.447177641126;11059;11061.668149955494;10686.412247326414;10807.945960270208;11038.944805275962;11124.443777811117;11135.387553684544;2371.6323969784667;2413.54142712884;2414.0947144820693;2415.5893498105274;2417.9637305440433;2352.9647055294186;2382.4401265702545;2383.1778036577352;2387;2388.8088952883727;2347.9060837566476;2360.681308023412;2363.432776133724;2372.632242002492;2376.1683410806254;1792.2741289777662;2114.3339847948;2131.403207102006;2139.4544391180307;2141.0900367343816;1904.2478221102726;2375.655529948148;2376.7860892519584;2377.8335516513853;2383.7258715247794;10883.18376121794;10955.397453140075;10974.506147223394;10996.780064398667;11029.172812039049;4747.52524747526;5744.626599271076;5768.567357448208;5776.537876969833;5777.364489906107;3015.1858998070616;3322.103032181322;3451.741119416054;3626.3291291111227;3651.7991510466913;1133.104916937225;1161.6456980620992;1167.177140116216;1182.043672984484;1209.419478650244;15130;15293;15412.922935385364;15415.768763468557;15477.690446191013;3531.805750683686;4522.163399770987;4574.954250457453;4649.349091127245;4656.674032817738;11446.313221206754;11462.713432164262;11480;11485.770284594428;11495.770084598262;5563.777448902079;5567.137093750475;5568.554515638739;5570.969370666439;5574.052411090124;4991.051700176955;5086.237064440364;5114.951434955825;5189.974050129801;5190.091733946544;3699.79651119191;3771.132639492932;3792.791396473165;3827.961720382816;3850.557185923599;849.8087930215776;997.3666721631671;999.5851721535481;1006.0794373148633;1015.3400289811682;897.1970086772302;915.720705184925;928.8606708993569;929.1730359979623;956.1299217711849;6351.237851457855;6426.518011149089;6427.389398007182;6482.805515834532;6514.957606782892;808.4623725222662;933.3373304953424;973.5445508964144;985.9014098590227;1001.5843424978698;3955.248502784462;4050.41269015991;4065.59344065597;4121.464209652726;4181.97909010453;10727.785444291227;13700.725985480234;13701.246431446367;13744.793828092586;13765.449382024806;12003.879961200451;12452.003839692803;13445.193288402726;13641;13691.520796772264;7521.398288136936;8910.955445222862;10127.291089623655;10192.439415832201;10302.433366164933;5094.363204599425;6444.677766111582;6448.742050317935;6525.575837570543;6654.3012983637955;11671.183017188716;12178.634640960785;12260.26438413698;12307.50769969227;12373.195742276723;11954.222975506913;12347.012239020678;12377.876221237673;12411;12433.254004759743;9139.086091391073;9183.908160918572;9366.157045865904;9376.67181648639;9379.249660027044;10175.491225438847;10261;10270;10296;10307.94846025765;8929.10708929102;9107;9139.77150571241;9184.448933064037;9202.493862837608;8876;8908.331875109263;8964.775880603038;8985.146411090936;8995.190432860813;7660.502067365604;7724;7795.883061754192;7804.8829267559895;7813.492123012214;4826.348442960156;5308.54015145838;5679.261695979496;5705.37240903492;5850.736716847667;5805.622634528742;5860.648361098348;5928.970355148197;5939.406059394026;6029.698515074317 03:35:15 INFO - PROCESS | 1652 | |4;prototype.html;316.4241081232158;378.7386703174809;385.0450881813104;386.8413950280384;387.68791123145894;4394.989152494928;4705.411823522059;4767.16574599445;5144;5248.291480650111;4149.626533611974;4373.759443230621;4546.999660074778;4795.880102997418;5037.647364684473;3290.8190049547266;3414.965850341502;3908.2965066288057;4115.814788334517;4226.640735537483;3347.815870127142;4068.942075060491;4180.602842729951;4181.540030596632;4195.4545909031785;3816.503854498911;4172.874813755592;4181.498220213579;4206.455094667728;4217.111278774049;3312.7681062325646;3983.40248962655;4120.1553681495225;4171.457710497631;4197.811098500575;2997.190758495216;3326.3513614845115;3403.863845446204;3757.3236817372863;3758.9436158457647;4342.413774140482;4473.2842745160615;4545.0909818036525;4762.261849413347;5008.898042430659;4501.649505148443;4522.982328975987;4651.88370290742;4855.781489832966;4891.9755401222765;4522.88692782683;5096.541311281965;5129.589632829402;5255.86860328491;5291.5448251730695;3826.9617303826885;4205.60046795557;4259.659227261812;4308.9138217235795;4345.956540434587;4444.31113177458;4580.290055041407;5480.86143519261;5635.957347890612;5750.65496070233;3643.508126402902;3826.8086595670106;4129.545749967501;4184.979075104666;4312.827486900552;4297.462817147856;4434.889127771767;4484;4508.039003033691;4557.498675145731;3713.7586056906216;4460.03057279022;4801.351817504662;4826.420829500483;4872.4153101628035;4749.928751068736;5313.57491400687;5398.595105367113;5442.510174084272;5466.599387493026;1331.8534961154264;1359.9392473870396;1372.75079677495;1517.5523220649934;1530.7677319757702;1004.7139661233633;1139.3334899083964;1142.3945308986251;1144.9942750286361;1157.5472781658964;4563.840265590688;4746.264329029006;5031.77357018935;5087.592992560586;5093.898122037613;4892.633052521075;5209.843704688866;5455.372632147354;5573.077288335518;5588.608797384144;4868.805247790048;4962.305277261186;4971.2543118531785;5013.949860501421;5047.60238886526;2508.16903660329;2730.276476733667;2809.7049809770087;2830.2216890354907;2913.6794952555624;5280.894382112337;5575.52608028314;5731.742071606787;5744.597878148489;5832.941670583325;4537.546245375436;5329.738904697703;5686.431356864363;5687.60186786921;5714.657120572779;4899.149841656734;4915.43472500667;5595.838351331485;5716.199732037601;5727.713614319267;5174.560162386239;5306.8407947761625;5561.944380556142;5671.716414179192;5746;4941.998490611309;4949.777260023379;5071.923921141112;5381.408045115112;5480.040777980005;4981.800727970841;5134.663728003824;5502.835869375205;5649.638465113251;5799.884002320015;4648.442186937589;4851.102546028996;4874.926876096791;4901.3138160658245;4923.15993525051;4947.233178857283;5431.864203394946;5564.248826408383;5580.414056524169;5685.886282274414;4551;4755.738434386142;4838.741927098909;5224.399194092728;5450;4857.927131093107;5264.236685680631;5303.814366497154;5349.358077030781;5371.650842695212;4556.450806725729;4778.948631301108;5026;5268.894622107459;5399.973000134974;4670.859874203779;5247.4490178530705;5361.463853614608;5446.264754258124;5515.69663668486;4521.118381915495;4833.9033219334715;4994.425641051325;5092.8472145835685;5354.518093371616 03:35:15 INFO - PROCESS | 1652 | |5;yui.html;707.6072779607322;726.5931078595984;783.0173132718437;824.5671022713076;840.6889450903167;15306.846931530696;15852.28664710088;15852.28664710088;15866.524004279876;15888.285027173775;14453.494127705533;14479.78280325796;14512.709745805105;14615.269236538184;14684.706305873902;922.0548937339214;925.5326060339519;937.5593471068587;945.9479728614923;963.5326866469757;942.2603256443693;942.4109931292942;943.0145497954619;943.5188054092393;967.685502211784;975.9268054895875;976.1312431935582;976.9560369783377;977.359829311802;978.2125389061803;770.7649167004062;969.1035791892542;970.1850445625673;972.6304004478288;972.9951350243274;716.5521549031855;718.795143384133;719.022129903331;720.1789959446236;721.6247551273361;15323.693526129415;15604.375824966988;15772.684546309125;15810.525684229491;15891;14022.509212177525;14125.505607303696;14149.575512734635;14180.290985450687;14472.204028778413;10600.681979540548;11685.182037257395;11883.40582970848;11884.524619015228;11910.761784764343;3662.688671462929;3673.7612055216327;3692.7968961707097;3724.236531511061;3761.9435708464393;77858;100939;108704;117161.4141929285;119329.80670193274;11063.557457701601;11069.72325691848;11106.722331941604;11380.54477820878;11581.42092895352;22482.32553023412;22763.544729105324;23032.65451018236;23072.307830765105;23179;7316.56100633953;7584.2794934481135;7783.260590243918;7819.648115834687;8037.557934313669;4250.978745106255;4345.261305578059;4355.67152018631;4451.354553589711;4523.864284071483;3439.243366459375;3519.63043880394;3558.1104723819044;3558.5373901393173;3561.1809283864854;536.610957056139;636.4303947966544;639.3638329861817;645.2031740800109;649.1463725201345;642.877853207889;650.5803756576981;652.7780554611455;665.4543274514851;687.08274453604;9749.220062394992;9808.872698238321;9988.350757200758;10107.899425856294;11208.887911120784;518.4582111693289;608.966506842128;610.2981571193163;647.9190101237346;711.9608421536865;4111.177764447122;4517.932231016537;5026.673266237683;5045.167547354718;5095.490450954949;84042.73935890966;99555.50222248987;101069;103593.96406035994;103858.48070759598;38963.41554876679;55999;63839.68080159569;64362.6781866097;67359;72413;83140;90231.54884225538;90665.54667226621;91343.17313653689;10561.63034293796;10935.03799589136;11256.662300131009;11292.153088518558;11303;47285.05429891452;47894.563163105166;48063;49111.75444122899;50299.74850125726;62011.41897229271;62119.6894015527;63296.05055924257;63941.3605863954;64361.03458448033;13808.13233618955;14081.786089493859;14132.646683832576;14384.952654289184;14569;14829.332680029209;14873.18197499148;14893.542982983452;15117.54647360581;15852.890297679052;13618.319084045956;13886.652833679238;14227.430902764188;14241.931855111116;14248.572542823731;13209.273489958145;13269;13358.86641133615;13659.453621855015;14378.784318235445;12845.351284386032;13837.930810345884;13913.165210087427;13991.16053036821;14095.224762638154;10772.838407423738;11093.667189983991;11263.718407039889;11340.829887551528;11354.26197297173;9969.451680157661;11041.44792760375;11175.273607215506;11410.94294528522;11437.42812859337 03:35:15 INFO - PROCESS | 1652 | __end_tp_report 03:35:15 INFO - PROCESS | 1652 | __start_cc_report 03:35:15 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1936 03:35:15 INFO - PROCESS | 1652 | __end_cc_report 03:35:15 INFO - PROCESS | 1652 | __startTimestamp1489314915516__endTimestamp 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | ------- Summary: start ------- 03:35:15 INFO - PROCESS | 1652 | Number of tests: 6 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5929.16 Median:6169.85 stddev:693.83 (11.2%) stddev-sans-first:667.28 03:35:15 INFO - PROCESS | 1652 | Values: 3412.6 3419.1 3424.0 3439.1 3476.2 5919.0 5923.1 5984.1 5995.9 6020.7 5974.9 6038.5 6051.4 6070.3 6077.7 4524.3 5372.0 5377.4 5421.8 5471.9 5344.5 5348.6 5420.2 5440.3 5449.9 5417.8 5418.0 5422.5 5424.9 5447.1 5431.0 5442.2 5442.6 5448.6 5451.1 5299.9 5387.6 5404.4 5411.6 5425.6 5993.6 6005.9 6010.6 6027.6 6035.5 6390.2 6404.4 6408.9 6417.3 6420.3 6373.1 6374.6 6392.6 6398.4 6416.8 6117.4 6129.8 6135.6 6137.5 6151.2 5005.5 6336.0 6362.3 6425.9 6482.8 5265.6 6142.5 6332.0 6340.4 6341.8 4849.5 6355.8 6397.9 6409.6 6431.8 6356.0 6368.2 6384.2 6386.1 6423.4 6390.7 6423.5 6424.1 6432.8 6433.2 5040.7 5112.9 5116.7 5167.4 5182.3 3724.7 4524.5 4529.2 4566.0 4588.7 6053.0 6063.8 6064.5 6071.2 6081.1 6340.4 6372.5 6385.6 6420.6 6495.8 6001.6 6001.8 6112.8 6128.3 6138.8 5678.7 5692.4 5711.2 5714.3 5716.2 6642.4 6651.8 6682.9 6692.1 6693.5 5342.9 6313.9 6378.4 6397.6 6486.5 6504.5 6520.1 6521.2 6540.2 6553.1 6337.3 6379.8 6379.9 6413.0 6430.2 6480.7 6486.0 6490.8 6495.4 6504.2 5093.8 6203.6 6334.8 6389.0 6391.0 6278.5 6288.6 6290.4 6297.3 6301.6 6154.9 6169.8 6192.6 6260.6 6280.3 6347.0 6362.4 6366.0 6367.3 6397.6 6279.9 6296.2 6304.2 6310.7 6322.3 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:54506.30 Median:33122.84 stddev:108441.31 (327.4%) stddev-sans-first:108670.18 03:35:15 INFO - PROCESS | 1652 | Values: 667.2 748.8 813.7 878.1 890.1 27927.7 39926.6 40374.8 40449.0 40571.4 41534.6 41606.0 41614.2 41653.2 41657.4 9222.1 9384.4 9393.3 9399.2 9448.1 6375.9 7268.9 7528.7 7540.5 7550.7 10837.7 11085.2 11183.8 11183.9 11191.3 10922.2 10951.0 10962.7 10966.4 10973.2 5563.4 10280.3 10874.5 10948.9 10949.2 27939.7 28106.0 28154.7 38494.0 39070.8 3804.5 3847.1 3859.6 3922.9 4031.8 26140.0 26605.9 26617.2 26826.6 28755.7 3138.3 3183.9 3188.9 3260.6 3287.0 355244.0 355909.0 356238.0 356336.2 359463.0 52228.5 52304.2 52354.5 52393.5 52401.0 54704.2 54734.7 54762.5 54766.6 54821.9 12254.0 14816.8 14938.7 14961.4 14994.9 12914.0 12935.2 12951.3 12957.9 12962.9 9212.4 10364.7 10574.5 12007.8 12131.3 4612.6 4779.9 5633.2 6014.4 6190.5 948.9 963.6 967.0 975.8 1006.3 27512.0 27675.2 27839.6 28126.4 28230.0 1038.8 1046.6 1082.5 1083.3 1091.5 14324.2 14391.6 14495.2 14577.6 14662.0 441206.8 443934.0 444255.0 444554.0 446146.0 55489.0 55581.4 55585.0 55684.0 55837.7 1421.4 1461.2 1464.1 1467.2 1471.4 26387.9 26741.7 26802.5 27565.3 27643.2 45050.0 45151.8 45235.3 45269.8 45329.4 420235.0 421212.0 421480.0 422668.0 423283.9 29176.7 29716.6 30828.5 30877.8 32146.0 38198.8 38908.8 39078.2 39384.2 39466.6 32268.4 32616.5 32665.2 33060.7 33608.3 32157.4 33235.7 33326.3 33548.2 33553.3 32122.0 32666.8 33077.2 33168.5 33209.3 27074.3 27691.9 29547.7 29969.0 29984.6 22641.3 22969.5 23005.2 23018.5 23109.8 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:41179.73 Median:26681.10 stddev:119043.25 (446.2%) stddev-sans-first:119337.79 03:35:15 INFO - PROCESS | 1652 | Values: 383.5 423.7 426.8 432.2 435.4 13153.3 16689.8 19904.0 21905.6 22130.2 21741.1 21975.0 22448.6 22733.0 22843.7 6803.6 6804.5 6813.8 6905.4 6914.6 6679.1 6790.9 6881.7 6883.4 6903.8 6608.4 6804.9 6880.5 6894.1 6906.0 6771.7 6800.6 6856.3 6931.1 6936.5 6702.9 6704.4 6711.0 6711.4 6717.2 26331.5 26390.0 26508.7 26853.5 26946.7 3344.4 3384.8 3424.4 3425.6 3429.1 15831.4 15929.5 15963.7 16005.0 16548.0 1988.5 1989.1 2049.4 2065.7 2068.6 111669.0 137732.0 139806.0 149441.5 152640.2 14858.5 15997.6 19881.2 19883.8 20292.9 29233.9 29271.0 29685.1 29820.6 29822.4 7230.6 8589.3 9684.4 10247.0 10357.9 7004.3 8605.6 8673.0 8754.5 8822.1 8505.2 8684.0 9255.7 9349.5 9469.3 3541.8 3594.8 3795.3 3871.4 3879.9 791.9 813.7 889.3 895.7 919.1 21306.0 21790.9 21854.8 21914.3 21933.3 898.6 909.0 920.8 926.8 931.6 11142.2 11321.9 11405.7 11416.8 11471.9 704797.0 713957.0 714266.0 721921.0 722696.4 109823.5 127182.4 135932.0 153723.2 164394.0 1177.9 1220.6 1235.7 1279.3 1285.2 19598.9 19869.9 20321.8 20329.2 20336.6 62945.7 63753.4 65258.0 65965.7 67563.7 86886.6 87620.5 88957.1 90103.0 90233.5 7670.3 10907.3 11284.4 11446.3 11806.0 12723.0 12776.8 12796.3 13076.7 13106.7 11028.6 11082.8 11363.5 11379.9 11499.4 9148.5 9437.6 10763.6 10770.4 10987.7 11245.0 11280.9 11542.7 11552.4 11673.0 11384.3 11407.9 11673.6 11745.0 11767.5 8538.9 10533.1 10985.7 11180.6 11324.2 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:6615.37 Median:2716.57 stddev:4193.41 (154.4%) stddev-sans-first:4187.92 03:35:15 INFO - PROCESS | 1652 | Values: 1553.2 1560.3 1561.2 1579.8 1592.1 10484.1 11046.7 11056.4 11059.0 11061.7 10686.4 10807.9 11038.9 11124.4 11135.4 2371.6 2413.5 2414.1 2415.6 2418.0 2353.0 2382.4 2383.2 2387.0 2388.8 2347.9 2360.7 2363.4 2372.6 2376.2 1792.3 2114.3 2131.4 2139.5 2141.1 1904.2 2375.7 2376.8 2377.8 2383.7 10883.2 10955.4 10974.5 10996.8 11029.2 4747.5 5744.6 5768.6 5776.5 5777.4 3015.2 3322.1 3451.7 3626.3 3651.8 1133.1 1161.6 1167.2 1182.0 1209.4 15130.0 15293.0 15412.9 15415.8 15477.7 3531.8 4522.2 4575.0 4649.3 4656.7 11446.3 11462.7 11480.0 11485.8 11495.8 5563.8 5567.1 5568.6 5571.0 5574.1 4991.1 5086.2 5115.0 5190.0 5190.1 3699.8 3771.1 3792.8 3828.0 3850.6 849.8 997.4 999.6 1006.1 1015.3 897.2 915.7 928.9 929.2 956.1 6351.2 6426.5 6427.4 6482.8 6515.0 808.5 933.3 973.5 985.9 1001.6 3955.2 4050.4 4065.6 4121.5 4182.0 10727.8 13700.7 13701.2 13744.8 13765.4 12003.9 12452.0 13445.2 13641.0 13691.5 7521.4 8911.0 10127.3 10192.4 10302.4 5094.4 6444.7 6448.7 6525.6 6654.3 11671.2 12178.6 12260.3 12307.5 12373.2 11954.2 12347.0 12377.9 12411.0 12433.3 9139.1 9183.9 9366.2 9376.7 9379.2 10175.5 10261.0 10270.0 10296.0 10307.9 8929.1 9107.0 9139.8 9184.4 9202.5 8876.0 8908.3 8964.8 8985.1 8995.2 7660.5 7724.0 7795.9 7804.9 7813.5 4826.3 5308.5 5679.3 5705.4 5850.7 5805.6 5860.6 5929.0 5939.4 6029.7 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4439.25 Median:4813.89 stddev:1258.65 (26.1%) stddev-sans-first:1223.55 03:35:15 INFO - PROCESS | 1652 | Values: 316.4 378.7 385.0 386.8 387.7 4395.0 4705.4 4767.2 5144.0 5248.3 4149.6 4373.8 4547.0 4795.9 5037.6 3290.8 3415.0 3908.3 4115.8 4226.6 3347.8 4068.9 4180.6 4181.5 4195.5 3816.5 4172.9 4181.5 4206.5 4217.1 3312.8 3983.4 4120.2 4171.5 4197.8 2997.2 3326.4 3403.9 3757.3 3758.9 4342.4 4473.3 4545.1 4762.3 5008.9 4501.6 4523.0 4651.9 4855.8 4892.0 4522.9 5096.5 5129.6 5255.9 5291.5 3827.0 4205.6 4259.7 4308.9 4346.0 4444.3 4580.3 5480.9 5636.0 5750.7 3643.5 3826.8 4129.5 4185.0 4312.8 4297.5 4434.9 4484.0 4508.0 4557.5 3713.8 4460.0 4801.4 4826.4 4872.4 4749.9 5313.6 5398.6 5442.5 5466.6 1331.9 1359.9 1372.8 1517.6 1530.8 1004.7 1139.3 1142.4 1145.0 1157.5 4563.8 4746.3 5031.8 5087.6 5093.9 4892.6 5209.8 5455.4 5573.1 5588.6 4868.8 4962.3 4971.3 5013.9 5047.6 2508.2 2730.3 2809.7 2830.2 2913.7 5280.9 5575.5 5731.7 5744.6 5832.9 4537.5 5329.7 5686.4 5687.6 5714.7 4899.1 4915.4 5595.8 5716.2 5727.7 5174.6 5306.8 5561.9 5671.7 5746.0 4942.0 4949.8 5071.9 5381.4 5480.0 4981.8 5134.7 5502.8 5649.6 5799.9 4648.4 4851.1 4874.9 4901.3 4923.2 4947.2 5431.9 5564.2 5580.4 5685.9 4551.0 4755.7 4838.7 5224.4 5450.0 4857.9 5264.2 5303.8 5349.4 5371.7 4556.5 4778.9 5026.0 5268.9 5400.0 4670.9 5247.4 5361.5 5446.3 5515.7 4521.1 4833.9 4994.4 5092.8 5354.5 03:35:15 INFO - PROCESS | 1652 | 03:35:15 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:19717.45 Median:3708.52 stddev:27690.94 (746.7%) stddev-sans-first:27731.83 03:35:15 INFO - PROCESS | 1652 | Values: 707.6 726.6 783.0 824.6 840.7 15306.8 15852.3 15852.3 15866.5 15888.3 14453.5 14479.8 14512.7 14615.3 14684.7 922.1 925.5 937.6 945.9 963.5 942.3 942.4 943.0 943.5 967.7 975.9 976.1 977.0 977.4 978.2 770.8 969.1 970.2 972.6 973.0 716.6 718.8 719.0 720.2 721.6 15323.7 15604.4 15772.7 15810.5 15891.0 14022.5 14125.5 14149.6 14180.3 14472.2 10600.7 11685.2 11883.4 11884.5 11910.8 3662.7 3673.8 3692.8 3724.2 3761.9 77858.0 100939.0 108704.0 117161.4 119329.8 11063.6 11069.7 11106.7 11380.5 11581.4 22482.3 22763.5 23032.7 23072.3 23179.0 7316.6 7584.3 7783.3 7819.6 8037.6 4251.0 4345.3 4355.7 4451.4 4523.9 3439.2 3519.6 3558.1 3558.5 3561.2 536.6 636.4 639.4 645.2 649.1 642.9 650.6 652.8 665.5 687.1 9749.2 9808.9 9988.4 10107.9 11208.9 518.5 609.0 610.3 647.9 712.0 4111.2 4517.9 5026.7 5045.2 5095.5 84042.7 99555.5 101069.0 103594.0 103858.5 38963.4 55999.0 63839.7 64362.7 67359.0 72413.0 83140.0 90231.5 90665.5 91343.2 10561.6 10935.0 11256.7 11292.2 11303.0 47285.1 47894.6 48063.0 49111.8 50299.7 62011.4 62119.7 63296.1 63941.4 64361.0 13808.1 14081.8 14132.6 14385.0 14569.0 14829.3 14873.2 14893.5 15117.5 15852.9 13618.3 13886.7 14227.4 14241.9 14248.6 13209.3 13269.0 13358.9 13659.5 14378.8 12845.4 13837.9 13913.2 13991.2 14095.2 10772.8 11093.7 11263.7 11340.8 11354.3 9969.5 11041.4 11175.3 11410.9 11437.4 03:35:15 INFO - PROCESS | 1652 | -------- Summary: end -------- 03:35:15 INFO - PROCESS | 1652 | 03:35:16 INFO - TEST-INFO | 1652: exit 0 03:35:16 INFO - TEST-OK | dromaeo_css | took 1121710ms 03:35:16 INFO - TEST-START | kraken 03:35:16 INFO - operating with platform_type : mac_ 03:35:16 INFO - Initialising browser for kraken test... 03:35:16 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmppXDVte/profile http://localhost:49249/getInfo.html) 03:35:18 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 03:35:18 INFO - PROCESS | 1683 | colorDepth:24 03:35:18 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 03:35:18 INFO - PROCESS | 1683 | __metrics 03:35:18 INFO - PROCESS | 1683 | 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:35:18 INFO - PROCESS | 1683 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:19 INFO - TEST-INFO | 1683: exit 0 03:35:19 INFO - Browser initialized. 03:35:19 INFO - Running cycle 1/1 for kraken test... 03:35:19 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmppXDVte/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:31 INFO - PROCESS | 1685 | RSS: Main: 214433792 03:35:31 INFO - PROCESS | 1685 | 03:35:34 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:35 INFO - PROCESS | 1685 | RSS: Main: 267358208 03:35:35 INFO - PROCESS | 1685 | 03:35:38 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 03:35:38 INFO - PROCESS | 1685 | RSS: Main: 277835776 03:35:38 INFO - PROCESS | 1685 | 03:35:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 03:35:42 INFO - PROCESS | 1685 | RSS: Main: 374276096 03:35:42 INFO - PROCESS | 1685 | 03:35:44 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 03:35:45 INFO - PROCESS | 1685 | RSS: Main: 277331968 03:35:45 INFO - PROCESS | 1685 | 03:35:47 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:48 INFO - PROCESS | 1685 | RSS: Main: 280186880 03:35:48 INFO - PROCESS | 1685 | 03:35:51 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:51 INFO - PROCESS | 1685 | RSS: Main: 320008192 03:35:51 INFO - PROCESS | 1685 | 03:35:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:55 INFO - PROCESS | 1685 | RSS: Main: 321359872 03:35:55 INFO - PROCESS | 1685 | 03:35:58 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 03:35:59 INFO - PROCESS | 1685 | RSS: Main: 317108224 03:35:59 INFO - PROCESS | 1685 | 03:36:00 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:01 INFO - PROCESS | 1685 | RSS: Main: 295567360 03:36:01 INFO - PROCESS | 1685 | 03:36:03 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:03 INFO - PROCESS | 1685 | RSS: Main: 296960000 03:36:03 INFO - PROCESS | 1685 | 03:36:06 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:06 INFO - PROCESS | 1685 | RSS: Main: 307916800 03:36:06 INFO - PROCESS | 1685 | 03:36:09 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:10 INFO - PROCESS | 1685 | RSS: Main: 320536576 03:36:10 INFO - PROCESS | 1685 | 03:36:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:14 INFO - PROCESS | 1685 | RSS: Main: 314871808 03:36:14 INFO - PROCESS | 1685 | 03:36:15 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 03:36:16 INFO - PROCESS | 1685 | RSS: Main: 359137280 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | __start_tp_report 03:36:16 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 03:36:16 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 03:36:16 INFO - PROCESS | 1685 | |i|pagename|runs| 03:36:16 INFO - PROCESS | 1685 | |0;ai-astar;116;116;121;94;159;172;165;114;115;116 03:36:16 INFO - PROCESS | 1685 | |1;audio-beat-detection;146;112;110;160;140;138;94;128;154;137 03:36:16 INFO - PROCESS | 1685 | |2;audio-dft;185;182;185;185;239;198;241;264;227;184 03:36:16 INFO - PROCESS | 1685 | |3;audio-fft;81;58;61;79;68;85;50;76;100;84 03:36:16 INFO - PROCESS | 1685 | |4;audio-oscillator;86;68;87;69;70;69;83;67;68;84 03:36:16 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;87;86;88;87;87;86;87;86;87;87 03:36:16 INFO - PROCESS | 1685 | |6;imaging-darkroom;94;94;95;100;137;94;95;95;94;94 03:36:16 INFO - PROCESS | 1685 | |7;imaging-desaturate;83;83;86;82;93;127;98;83;86;83 03:36:16 INFO - PROCESS | 1685 | |8;json-parse-financial;64;60;60;61;64;64;63;63;63;64 03:36:16 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;61;68;55;64;61;56;58;58;58;59 03:36:16 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;87;85;83;87;85;86;91;100;103;101 03:36:16 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;138;136;136;137;150;146;140;149;179;155 03:36:16 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;165;164;167;164;165;163;163;172;159;162 03:36:16 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;62;63;57;73;78;81;81;79;64;65 03:36:16 INFO - PROCESS | 1685 | __end_tp_report 03:36:16 INFO - PROCESS | 1685 | __start_cc_report 03:36:16 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,2098 03:36:16 INFO - PROCESS | 1685 | __end_cc_report 03:36:16 INFO - PROCESS | 1685 | __startTimestamp1489314976060__endTimestamp 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | ------- Summary: start ------- 03:36:16 INFO - PROCESS | 1685 | Number of tests: 14 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:128.80 Median:140.00 stddev:26.38 (18.8%) stddev-sans-first:27.57 03:36:16 INFO - PROCESS | 1685 | Values: 116.0 116.0 121.0 94.0 159.0 172.0 165.0 114.0 115.0 116.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:143.00 stddev:20.90 (14.6%) stddev-sans-first:21.54 03:36:16 INFO - PROCESS | 1685 | Values: 146.0 112.0 110.0 160.0 140.0 138.0 94.0 128.0 154.0 137.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:209.00 Median:212.50 stddev:30.69 (14.4%) stddev-sans-first:31.30 03:36:16 INFO - PROCESS | 1685 | Values: 185.0 182.0 185.0 185.0 239.0 198.0 241.0 264.0 227.0 184.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:74.20 Median:77.50 stddev:14.95 (19.3%) stddev-sans-first:15.65 03:36:16 INFO - PROCESS | 1685 | Values: 81.0 58.0 61.0 79.0 68.0 85.0 50.0 76.0 100.0 84.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.50 stddev:8.62 (11.3%) stddev-sans-first:8.19 03:36:16 INFO - PROCESS | 1685 | Values: 86.0 68.0 87.0 69.0 70.0 69.0 83.0 67.0 68.0 84.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:36:16 INFO - PROCESS | 1685 | Values: 87.0 86.0 88.0 87.0 87.0 86.0 87.0 86.0 87.0 87.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:94.00 stddev:13.41 (14.3%) stddev-sans-first:14.09 03:36:16 INFO - PROCESS | 1685 | Values: 94.0 94.0 95.0 100.0 137.0 94.0 95.0 95.0 94.0 94.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:90.40 Median:84.50 stddev:13.87 (16.4%) stddev-sans-first:14.45 03:36:16 INFO - PROCESS | 1685 | Values: 83.0 83.0 86.0 82.0 93.0 127.0 98.0 83.0 86.0 83.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.50 stddev:1.65 (2.6%) stddev-sans-first:1.67 03:36:16 INFO - PROCESS | 1685 | Values: 64.0 60.0 60.0 61.0 64.0 64.0 63.0 63.0 63.0 64.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:3.88 (6.5%) stddev-sans-first:4.09 03:36:16 INFO - PROCESS | 1685 | Values: 61.0 68.0 55.0 64.0 61.0 56.0 58.0 58.0 58.0 59.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:85.50 stddev:7.58 (8.9%) stddev-sans-first:7.92 03:36:16 INFO - PROCESS | 1685 | Values: 87.0 85.0 83.0 87.0 85.0 86.0 91.0 100.0 103.0 101.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:147.50 stddev:13.22 (9.0%) stddev-sans-first:13.65 03:36:16 INFO - PROCESS | 1685 | Values: 138.0 136.0 136.0 137.0 150.0 146.0 140.0 149.0 179.0 155.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.50 stddev:3.41 (2.1%) stddev-sans-first:3.61 03:36:16 INFO - PROCESS | 1685 | Values: 165.0 164.0 167.0 164.0 165.0 163.0 163.0 172.0 159.0 162.0 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:75.50 stddev:9.06 (12.0%) stddev-sans-first:9.09 03:36:16 INFO - PROCESS | 1685 | Values: 62.0 63.0 57.0 73.0 78.0 81.0 81.0 79.0 64.0 65.0 03:36:16 INFO - PROCESS | 1685 | -------- Summary: end -------- 03:36:16 INFO - PROCESS | 1685 | 03:36:16 INFO - TEST-INFO | 1685: exit 0 03:36:17 INFO - TEST-OK | kraken | took 60823ms 03:36:17 INFO - SUITE-END | took 1182s 03:36:17 INFO - Completed test suite (00:19:42) 03:36:17 INFO - javascript benchmark 03:36:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7573.840970415821, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.607550131734, 3419.145213696576, 3424.041268444835, 3439.0886415099985, 3476.235228249786, 5918.970405147974, 5923.081922302039, 5984.072468767348, 5995.880082398349, 6020.668863212527, 5974.8506287342725, 6038.456538911497, 6051.394860513947, 6070.301915279744, 6077.696115194233, 4524.253498172798, 5371.979323928451, 5377.435369286227, 5421.810236641718, 5471.863203419926, 5344.518993290603, 5348.572114230872, 5420.214068959998, 5440.347158340985, 5449.945500545004, 5417.83746487606, 5418.0, 5422.48486393792, 5424.945750542483, 5447.12845944649, 5430.972845135789, 5442.183672449125, 5442.591805614595, 5448.645838020536, 5451.127819548893, 5299.894002119936, 5387.568994480472, 5404.432534583891, 5411.56707463402, 5425.593080518976, 5993.550483713695, 6005.909911351289, 6010.639361638316, 6027.578069535134, 6035.517158627299, 6390.201224846895, 6404.4236018758065, 6408.871822563569, 6417.294097649255, 6420.293767685597, 6373.107764912916, 6374.553781235315, 6392.616443013434, 6398.424141827211, 6416.7754128605275, 6117.418845209698, 6129.846753831145, 6135.570510064297, 6137.508999280047, 6151.169592105053, 5005.524475174852, 6336.04959256106, 6362.268339141058, 6425.871482570323, 6482.805515834532, 5265.605079619044, 6142.529470848956, 6332.018537126753, 6340.3976622221735, 6341.778037768656, 4849.456693744066, 6355.777547785805, 6397.936020639734, 6409.647469389135, 6431.839204019843, 6355.968220158962, 6368.203974503187, 6384.170057892445, 6386.10594516768, 6423.357664233539, 6390.680465976682, 6423.518236132309, 6424.13274207976, 6432.839179020469, 6433.228012638513, 5040.697558146523, 5112.872178195575, 5116.718580478109, 5167.354080739908, 5182.274481572583, 3724.6647801697436, 4524.47968483622, 4529.230030894756, 4566.0, 4588.747618880993, 6053.0, 6063.818085457443, 6064.514838812973, 6071.150038994544, 6081.087836824423, 6340.365963403623, 6372.522060845455, 6385.616862988236, 6420.646864422408, 6495.805125846232, 6001.639901605918, 6001.7599296027665, 6112.755489780359, 6128.264608247039, 6138.815835524942, 5678.68767217807, 5692.402297758758, 5711.200431939532, 5714.2571465710025, 5716.1997320375185, 6642.368974947372, 6651.767188148391, 6682.9331706682315, 6692.130023096966, 6693.464522838161, 5342.9465705342445, 6313.873722525615, 6378.425941665272, 6397.616143031433, 6486.513511486752, 6504.512161587805, 6520.087187793618, 6521.217453905561, 6540.215174179129, 6553.082568440517, 6337.302896681454, 6379.77670781539, 6379.904301435575, 6413.0, 6430.164078669743, 6480.675966201766, 6485.967570162119, 6490.8052758417325, 6495.350464953467, 6504.219493660791, 5093.821716239914, 6203.565750397429, 6334.841628959313, 6389.009703495965, 6391.041343798467, 6278.466330361788, 6288.5598008138995, 6290.433860952537, 6297.307296197506, 6301.558890877778, 6154.938450615616, 6169.84575385601, 6192.628442293477, 6260.593061450991, 6280.277768056732, 6347.0, 6362.395572420613, 6366.0, 6367.299597044414, 6397.616143031247, 6279.937200628118, 6296.244450665949, 6304.211973503312, 6310.6529140895855, 6322.3045464997895], "value": 5885.064492468408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2393471442556, 748.827769612989, 813.6704634622976, 878.1043335797486, 890.0921060518276, 27927.72072279279, 39926.60073399265, 40374.79812600933, 40448.99999999996, 40571.391429128584, 41534.58465415345, 41606.0, 41614.16771664565, 41653.16693666133, 41657.37513937293, 9222.077792220774, 9384.436933783994, 9393.295502837314, 9399.154076133147, 9448.055194480532, 6375.936240637604, 7268.854622907539, 7528.698852045912, 7540.472166948316, 7550.735724249625, 10837.67486975392, 11085.168612354066, 11183.776324473505, 11183.888161118406, 11191.328520288767, 10922.18083643726, 10951.0, 10962.725931851688, 10966.396848173346, 10973.177011724112, 5563.36021357541, 10280.331778434453, 10874.45627718611, 10948.905109488987, 10949.178811589083, 27939.720602793914, 28106.0, 28154.718452815618, 38494.0, 39070.804645976874, 3804.5054142961517, 3847.1343947611845, 3859.6333348331864, 3922.882313530599, 4031.798410079514, 26140.0, 26605.86697066502, 26617.201483955512, 26826.597601036, 28755.712442875512, 3138.2938838761324, 3183.920401989969, 3188.9043328700177, 3260.576125103745, 3286.9506957395656, 355244.0, 355909.0, 356238.0, 356336.2183189119, 359463.0, 52228.47771522312, 52304.21543676848, 52354.47645523496, 52393.47606523962, 52401.0, 54704.17943730847, 54734.72632636891, 54762.45237547653, 54766.630834228665, 54821.903561929335, 12253.95841353477, 14816.777748333783, 14938.70122597542, 14961.40154393812, 14994.850051499345, 12914.0, 12935.223886566837, 12951.287679177736, 12957.870421295855, 12962.935185324202, 9212.447253164832, 10364.689059328231, 10574.471276436147, 12007.759844803055, 12131.332776697367, 4612.60792832613, 4779.942718489069, 5633.239712540907, 6014.398560143951, 6190.473809726223, 948.9335746497679, 963.6097380560884, 966.9951650241844, 975.8046393168312, 1006.2503434940869, 27512.0, 27675.169744907686, 27839.582406263922, 28126.43747125046, 28230.0, 1038.8337865941412, 1046.6441409920662, 1082.4641802307908, 1083.2525557365393, 1091.4597274349248, 14324.212168330634, 14391.568252952427, 14495.20276384788, 14577.562673119823, 14662.0, 441206.79396602814, 443934.0, 444255.0, 444554.0, 446146.0, 55489.0, 55581.44418555763, 55585.0, 55684.0, 55837.72081139568, 1421.3603878254826, 1461.189040082743, 1464.0556840837812, 1467.185711929889, 1471.3893734100443, 26387.868060659574, 26741.732582673925, 26802.463950721267, 27565.31086722848, 27643.170704878885, 45050.0, 45151.77424112859, 45235.32147017732, 45269.77365113153, 45329.41347052837, 420235.0, 421212.0, 421480.0, 422668.0, 423283.8835805801, 29176.687049083266, 29716.55425168581, 30828.53757193599, 30877.8456107718, 32146.0, 38198.80900595479, 38908.80545597367, 39078.24147913408, 39384.21231575295, 39466.605333946296, 32268.35463290674, 32616.510752339207, 32665.18337041593, 33060.66939330672, 33608.32783344271, 32157.35685286328, 33235.6705731768, 33326.33347333088, 33548.161295967795, 33553.32893342071, 32122.0, 32666.836665816518, 33077.17307067342, 33168.50247246341, 33209.33581328311, 27074.32314192161, 27691.892324306802, 29547.704522954496, 29969.0, 29984.61968680093, 22641.320760377213, 22969.540609188058, 23005.194818181284, 23018.53962920766, 23109.84450777488], "value": 18288.519704180755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.4746397435514, 423.6986905151208, 426.82500174928276, 432.20258622840845, 435.373062789583, 13153.342332883354, 16689.83310166898, 19904.004799760027, 21905.561888762255, 22130.225442109488, 21741.13035478579, 21975.0, 22448.55102897941, 22733.0, 22843.657345139796, 6803.55776874504, 6804.48966327525, 6813.761518346859, 6905.413039891615, 6914.55055421396, 6679.064930909676, 6790.898136527956, 6881.65591720412, 6883.414909732679, 6903.758368457105, 6608.405243528082, 6804.897926531081, 6880.483963702717, 6894.069300644424, 6905.965470172668, 6771.661416929183, 6800.557963732391, 6856.314368563154, 6931.064306318633, 6936.549124306929, 6702.899456508157, 6704.363085506869, 6710.966445167792, 6711.362420570038, 6717.227518835348, 26331.473370532483, 26390.0, 26508.73491265082, 26853.462930741473, 26946.730532694815, 3344.4481660525985, 3384.76306658534, 3424.4007298722872, 3425.6231814500384, 3429.091290807913, 15831.366745330173, 15929.522114336589, 15963.680726385523, 16005.0, 16548.0, 1988.5028742814297, 1989.1446677928484, 2049.3851844446754, 2065.710800487933, 2068.6483297839404, 111669.0, 137732.0, 139806.0, 149441.50558494384, 152640.23679881642, 14858.514148585054, 15997.60005999836, 19881.204751810055, 19883.801161988486, 20292.898535507524, 29233.85383073071, 29271.0, 29685.1094467162, 29820.552691709643, 29822.40355192884, 7230.602316872517, 8589.312854971588, 9684.41893486393, 10247.0, 10357.896421035844, 7004.299570042955, 8605.569721514024, 8673.04596494385, 8754.47473151613, 8822.117788221254, 8505.23452889243, 8684.044755076937, 9255.676051338305, 9349.502320179843, 9469.337146399686, 3541.831195705411, 3594.8185855518054, 3795.316842968237, 3871.3612253977776, 3879.922401551953, 791.9287264146254, 813.6818354266127, 889.3152272749946, 895.6865097215922, 919.0763282900775, 21306.0, 21790.89104554467, 21854.781452185274, 21914.342569722932, 21933.341999740034, 898.6270697660528, 908.9590968406437, 920.8342498350228, 926.8053708721109, 931.5854444772147, 11142.164337674707, 11321.94339028316, 11405.714857128638, 11416.771664566662, 11471.885281147082, 704797.0, 713957.0, 714266.0, 721921.0, 722696.3865180745, 109823.45088274508, 127182.36408817896, 135932.0, 153723.23138384236, 164394.0, 1177.8822117788325, 1220.6216073017392, 1235.7034311765112, 1279.2963869871533, 1285.2095960984113, 19598.902005489883, 19869.900650496656, 20321.79678203199, 20329.186832527124, 20336.59326813426, 62945.68527157335, 63753.36246637474, 65258.0, 65965.67017164883, 67563.66218169074, 86886.56556717175, 87620.5329694229, 88957.11042889488, 90103.0, 90233.54883225805, 7670.348020418327, 10907.345559266469, 11284.435778210893, 11446.255993360404, 11806.0, 12722.982161426879, 12776.808347874976, 12796.296203708513, 13076.673083172996, 13106.737865242832, 11028.613998510335, 11082.833757493805, 11363.54545818191, 11379.943100284445, 11499.425028748696, 9148.496832674267, 9437.57530911097, 10763.623273185402, 10770.353778773298, 10987.670369888916, 11245.0, 11280.943595281971, 11542.711432214262, 11552.364619945984, 11673.007794337576, 11384.316940983568, 11407.885921140682, 11673.649790506299, 11745.0, 11767.470463829319, 8538.892834262653, 10533.104686101768, 10985.68405328022, 11180.608678696206, 11324.150688698546], "value": 11336.007890078468, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.231150580462, 1560.258877033409, 1561.2037860691044, 1579.849914258145, 1592.1004632382699, 10484.108850747685, 11046.668599941995, 11056.447177641126, 11059.0, 11061.668149955494, 10686.412247326414, 10807.945960270208, 11038.944805275962, 11124.443777811117, 11135.387553684544, 2371.6323969784667, 2413.54142712884, 2414.0947144820693, 2415.5893498105274, 2417.9637305440433, 2352.9647055294186, 2382.4401265702545, 2383.1778036577352, 2387.0, 2388.8088952883727, 2347.9060837566476, 2360.681308023412, 2363.432776133724, 2372.632242002492, 2376.1683410806254, 1792.2741289777662, 2114.3339847948, 2131.403207102006, 2139.4544391180307, 2141.0900367343816, 1904.2478221102726, 2375.655529948148, 2376.7860892519584, 2377.8335516513853, 2383.7258715247794, 10883.18376121794, 10955.397453140075, 10974.506147223394, 10996.780064398667, 11029.172812039049, 4747.52524747526, 5744.626599271076, 5768.567357448208, 5776.537876969833, 5777.364489906107, 3015.1858998070616, 3322.103032181322, 3451.741119416054, 3626.3291291111227, 3651.7991510466913, 1133.104916937225, 1161.6456980620992, 1167.177140116216, 1182.043672984484, 1209.419478650244, 15130.0, 15293.0, 15412.922935385364, 15415.768763468557, 15477.690446191013, 3531.805750683686, 4522.163399770987, 4574.954250457453, 4649.349091127245, 4656.674032817738, 11446.313221206754, 11462.713432164262, 11480.0, 11485.770284594428, 11495.770084598262, 5563.777448902079, 5567.137093750475, 5568.554515638739, 5570.969370666439, 5574.052411090124, 4991.051700176955, 5086.237064440364, 5114.951434955825, 5189.974050129801, 5190.091733946544, 3699.79651119191, 3771.132639492932, 3792.791396473165, 3827.961720382816, 3850.557185923599, 849.8087930215776, 997.3666721631671, 999.5851721535481, 1006.0794373148633, 1015.3400289811682, 897.1970086772302, 915.720705184925, 928.8606708993569, 929.1730359979623, 956.1299217711849, 6351.237851457855, 6426.518011149089, 6427.389398007182, 6482.805515834532, 6514.957606782892, 808.4623725222662, 933.3373304953424, 973.5445508964144, 985.9014098590227, 1001.5843424978698, 3955.248502784462, 4050.41269015991, 4065.59344065597, 4121.464209652726, 4181.97909010453, 10727.785444291227, 13700.725985480234, 13701.246431446367, 13744.793828092586, 13765.449382024806, 12003.879961200451, 12452.003839692803, 13445.193288402726, 13641.0, 13691.520796772264, 7521.398288136936, 8910.955445222862, 10127.291089623655, 10192.439415832201, 10302.433366164933, 5094.363204599425, 6444.677766111582, 6448.742050317935, 6525.575837570543, 6654.3012983637955, 11671.183017188716, 12178.634640960785, 12260.26438413698, 12307.50769969227, 12373.195742276723, 11954.222975506913, 12347.012239020678, 12377.876221237673, 12411.0, 12433.254004759743, 9139.086091391073, 9183.908160918572, 9366.157045865904, 9376.67181648639, 9379.249660027044, 10175.491225438847, 10261.0, 10270.0, 10296.0, 10307.94846025765, 8929.10708929102, 9107.0, 9139.77150571241, 9184.448933064037, 9202.493862837608, 8876.0, 8908.331875109263, 8964.775880603038, 8985.146411090936, 8995.190432860813, 7660.502067365604, 7724.0, 7795.883061754192, 7804.8829267559895, 7813.492123012214, 4826.348442960156, 5308.54015145838, 5679.261695979496, 5705.37240903492, 5850.736716847667, 5805.622634528742, 5860.648361098348, 5928.970355148197, 5939.406059394026, 6029.698515074317], "value": 5012.921626439259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4241081232158, 378.7386703174809, 385.0450881813104, 386.8413950280384, 387.68791123145894, 4394.989152494928, 4705.411823522059, 4767.16574599445, 5144.0, 5248.291480650111, 4149.626533611974, 4373.759443230621, 4546.999660074778, 4795.880102997418, 5037.647364684473, 3290.8190049547266, 3414.965850341502, 3908.2965066288057, 4115.814788334517, 4226.640735537483, 3347.815870127142, 4068.942075060491, 4180.602842729951, 4181.540030596632, 4195.4545909031785, 3816.503854498911, 4172.874813755592, 4181.498220213579, 4206.455094667728, 4217.111278774049, 3312.7681062325646, 3983.40248962655, 4120.1553681495225, 4171.457710497631, 4197.811098500575, 2997.190758495216, 3326.3513614845115, 3403.863845446204, 3757.3236817372863, 3758.9436158457647, 4342.413774140482, 4473.2842745160615, 4545.0909818036525, 4762.261849413347, 5008.898042430659, 4501.649505148443, 4522.982328975987, 4651.88370290742, 4855.781489832966, 4891.9755401222765, 4522.88692782683, 5096.541311281965, 5129.589632829402, 5255.86860328491, 5291.5448251730695, 3826.9617303826885, 4205.60046795557, 4259.659227261812, 4308.9138217235795, 4345.956540434587, 4444.31113177458, 4580.290055041407, 5480.86143519261, 5635.957347890612, 5750.65496070233, 3643.508126402902, 3826.8086595670106, 4129.545749967501, 4184.979075104666, 4312.827486900552, 4297.462817147856, 4434.889127771767, 4484.0, 4508.039003033691, 4557.498675145731, 3713.7586056906216, 4460.03057279022, 4801.351817504662, 4826.420829500483, 4872.4153101628035, 4749.928751068736, 5313.57491400687, 5398.595105367113, 5442.510174084272, 5466.599387493026, 1331.8534961154264, 1359.9392473870396, 1372.75079677495, 1517.5523220649934, 1530.7677319757702, 1004.7139661233633, 1139.3334899083964, 1142.3945308986251, 1144.9942750286361, 1157.5472781658964, 4563.840265590688, 4746.264329029006, 5031.77357018935, 5087.592992560586, 5093.898122037613, 4892.633052521075, 5209.843704688866, 5455.372632147354, 5573.077288335518, 5588.608797384144, 4868.805247790048, 4962.305277261186, 4971.2543118531785, 5013.949860501421, 5047.60238886526, 2508.16903660329, 2730.276476733667, 2809.7049809770087, 2830.2216890354907, 2913.6794952555624, 5280.894382112337, 5575.52608028314, 5731.742071606787, 5744.597878148489, 5832.941670583325, 4537.546245375436, 5329.738904697703, 5686.431356864363, 5687.60186786921, 5714.657120572779, 4899.149841656734, 4915.43472500667, 5595.838351331485, 5716.199732037601, 5727.713614319267, 5174.560162386239, 5306.8407947761625, 5561.944380556142, 5671.716414179192, 5746.0, 4941.998490611309, 4949.777260023379, 5071.923921141112, 5381.408045115112, 5480.040777980005, 4981.800727970841, 5134.663728003824, 5502.835869375205, 5649.638465113251, 5799.884002320015, 4648.442186937589, 4851.102546028996, 4874.926876096791, 4901.3138160658245, 4923.15993525051, 4947.233178857283, 5431.864203394946, 5564.248826408383, 5580.414056524169, 5685.886282274414, 4551.0, 4755.738434386142, 4838.741927098909, 5224.399194092728, 5450.0, 4857.927131093107, 5264.236685680631, 5303.814366497154, 5349.358077030781, 5371.650842695212, 4556.450806725729, 4778.948631301108, 5026.0, 5268.894622107459, 5399.973000134974, 4670.859874203779, 5247.4490178530705, 5361.463853614608, 5446.264754258124, 5515.69663668486, 4521.118381915495, 4833.9033219334715, 4994.425641051325, 5092.8472145835685, 5354.518093371616], "value": 4074.171406709845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.6072779607322, 726.5931078595984, 783.0173132718437, 824.5671022713076, 840.6889450903167, 15306.846931530696, 15852.28664710088, 15852.28664710088, 15866.524004279876, 15888.285027173775, 14453.494127705533, 14479.78280325796, 14512.709745805105, 14615.269236538184, 14684.706305873902, 922.0548937339214, 925.5326060339519, 937.5593471068587, 945.9479728614923, 963.5326866469757, 942.2603256443693, 942.4109931292942, 943.0145497954619, 943.5188054092393, 967.685502211784, 975.9268054895875, 976.1312431935582, 976.9560369783377, 977.359829311802, 978.2125389061803, 770.7649167004062, 969.1035791892542, 970.1850445625673, 972.6304004478288, 972.9951350243274, 716.5521549031855, 718.795143384133, 719.022129903331, 720.1789959446236, 721.6247551273361, 15323.693526129415, 15604.375824966988, 15772.684546309125, 15810.525684229491, 15891.0, 14022.509212177525, 14125.505607303696, 14149.575512734635, 14180.290985450687, 14472.204028778413, 10600.681979540548, 11685.182037257395, 11883.40582970848, 11884.524619015228, 11910.761784764343, 3662.688671462929, 3673.7612055216327, 3692.7968961707097, 3724.236531511061, 3761.9435708464393, 77858.0, 100939.0, 108704.0, 117161.4141929285, 119329.80670193274, 11063.557457701601, 11069.72325691848, 11106.722331941604, 11380.54477820878, 11581.42092895352, 22482.32553023412, 22763.544729105324, 23032.65451018236, 23072.307830765105, 23179.0, 7316.56100633953, 7584.2794934481135, 7783.260590243918, 7819.648115834687, 8037.557934313669, 4250.978745106255, 4345.261305578059, 4355.67152018631, 4451.354553589711, 4523.864284071483, 3439.243366459375, 3519.63043880394, 3558.1104723819044, 3558.5373901393173, 3561.1809283864854, 536.610957056139, 636.4303947966544, 639.3638329861817, 645.2031740800109, 649.1463725201345, 642.877853207889, 650.5803756576981, 652.7780554611455, 665.4543274514851, 687.08274453604, 9749.220062394992, 9808.872698238321, 9988.350757200758, 10107.899425856294, 11208.887911120784, 518.4582111693289, 608.966506842128, 610.2981571193163, 647.9190101237346, 711.9608421536865, 4111.177764447122, 4517.932231016537, 5026.673266237683, 5045.167547354718, 5095.490450954949, 84042.73935890966, 99555.50222248987, 101069.0, 103593.96406035994, 103858.48070759598, 38963.41554876679, 55999.0, 63839.68080159569, 64362.6781866097, 67359.0, 72413.0, 83140.0, 90231.54884225538, 90665.54667226621, 91343.17313653689, 10561.63034293796, 10935.03799589136, 11256.662300131009, 11292.153088518558, 11303.0, 47285.05429891452, 47894.563163105166, 48063.0, 49111.75444122899, 50299.74850125726, 62011.41897229271, 62119.6894015527, 63296.05055924257, 63941.3605863954, 64361.03458448033, 13808.13233618955, 14081.786089493859, 14132.646683832576, 14384.952654289184, 14569.0, 14829.332680029209, 14873.18197499148, 14893.542982983452, 15117.54647360581, 15852.890297679052, 13618.319084045956, 13886.652833679238, 14227.430902764188, 14241.931855111116, 14248.572542823731, 13209.273489958145, 13269.0, 13358.86641133615, 13659.453621855015, 14378.784318235445, 12845.351284386032, 13837.930810345884, 13913.165210087427, 13991.16053036821, 14095.224762638154, 10772.838407423738, 11093.667189983991, 11263.718407039889, 11340.829887551528, 11354.26197297173, 9969.451680157661, 11041.44792760375, 11175.273607215506, 11410.94294528522, 11437.42812859337], "value": 7574.162079833743, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1489.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 121.0, 94.0, 159.0, 172.0, 165.0, 114.0, 115.0, 116.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 110.0, 160.0, 140.0, 138.0, 94.0, 128.0, 154.0, 137.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 185.0, 185.0, 239.0, 198.0, 241.0, 264.0, 227.0, 184.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 79.0, 68.0, 85.0, 50.0, 76.0, 100.0, 84.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 87.0, 69.0, 70.0, 69.0, 83.0, 67.0, 68.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 87.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 100.0, 137.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 82.0, 93.0, 127.0, 98.0, 83.0, 86.0, 83.0], "value": 90.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 61.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 68.0, 55.0, 64.0, 61.0, 56.0, 58.0, 58.0, 58.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 87.0, 85.0, 86.0, 91.0, 100.0, 103.0, 101.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 136.0, 137.0, 150.0, 146.0, 140.0, 149.0, 179.0, 155.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 164.0, 165.0, 163.0, 163.0, 172.0, 159.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 57.0, 73.0, 78.0, 81.0, 81.0, 79.0, 64.0, 65.0], "value": 70.3, "unit": "score"}]}]} 03:36:17 INFO - Return code: 0 03:36:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:17 ERROR - # TBPL SUCCESS # 03:36:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:36:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:36:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:36:17 INFO - 2017-03-12 03:36:17.393 screenresolution[1689:11792] starting screenresolution argv=screenresolution get 03:36:17 INFO - 2017-03-12 03:36:17.397 screenresolution[1689:11792] Display 0: 1600x1200x32@60 03:36:17 INFO - 2017-03-12 03:36:17.403 screenresolution[1690:11795] starting screenresolution argv=screenresolution list 03:36:17 INFO - Available Modes on Display 0 03:36:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:36:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:36:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:36:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:36:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:36:17 INFO - Intel Iris: 03:36:17 INFO - Chipset Model: Intel Iris 03:36:17 INFO - Type: GPU 03:36:17 INFO - Bus: Built-In 03:36:17 INFO - VRAM (Dynamic, Max): 1536 MB 03:36:17 INFO - Vendor: Intel (0x8086) 03:36:17 INFO - Device ID: 0x0a2e 03:36:17 INFO - Revision ID: 0x0009 03:36:17 INFO - Displays: 03:36:17 INFO - Display: 03:36:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:36:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:36:17 INFO - Display Serial Number: 1600x1200 60 03:36:17 INFO - Main Display: Yes 03:36:17 INFO - Mirror: Off 03:36:17 INFO - Online: Yes 03:36:17 INFO - Rotation: Supported 03:36:17 INFO - Return code: 0 03:36:17 INFO - Running post-action listener: _resource_record_post_action 03:36:17 INFO - [mozharness: 2017-03-12 10:36:17.637912Z] Finished run-tests step (success) 03:36:17 INFO - Running post-run listener: _resource_record_post_run 03:36:17 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32250880; Write bytes: 510346752; Read time: 199; Write time: 1592 03:36:17 INFO - TinderboxPrint: CPU usage
53.6% 03:36:17 INFO - TinderboxPrint: I/O read bytes / time
32,250,880 / 199 03:36:17 INFO - TinderboxPrint: I/O write bytes / time
510,346,752 / 1,592 03:36:17 INFO - TinderboxPrint: CPU idle
2,232.0 (46.4%) 03:36:17 INFO - TinderboxPrint: CPU system
959.7 (19.9%) 03:36:17 INFO - TinderboxPrint: CPU user
1,622.0 (33.7%) 03:36:17 INFO - TinderboxPrint: Swap in / out
236,810,240 / 0 03:36:17 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201980416; Write bytes: 202131456; Read time: 15649; Write time: 447 03:36:17 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 30465024; Write bytes: 297459200; Read time: 183; Write time: 1115 03:36:18 INFO - Running post-run listener: _upload_blobber_files 03:36:18 INFO - Blob upload gear active. 03:36:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:18 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 03:36:18 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'] 03:36:18 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 03:36:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:19 INFO - (blobuploader) - INFO - Done attempting. 03:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:20 INFO - (blobuploader) - INFO - Done attempting. 03:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:21 INFO - (blobuploader) - INFO - Done attempting. 03:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:23 INFO - (blobuploader) - INFO - Done attempting. 03:36:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:23 INFO - Return code: 0 03:36:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c308bad10a1263024a1059736b90869dd7707d2fdf255a861393497a9547e5d04cf94259b2266741231a300c22b93868bbbe6caddd5c6e5512b6fd27059ca3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5258b901ec039af2d8eeb1bf61510b31272db9c0a996f89d0b3e657956bf4d920a94765b5f83831a6a04a62dfa1c0a85845515a069df3814d8eb418298dd978f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3202167a5f00f906ba7248b80c4703cdc66a1387cfa0b8c060924b5d863ae8fa8f3a1728b2b2f31c470bc6aa7ca54c14cb39965a5c090d0f0a51568cd07de26b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c58ac696a8a57a918b1507d89dbf3b1d80ae69593bbea48a0cdc1800dfc1c36a8f6d160ec7dad73f28f05952e735011a928fd739ee17aa1dc12e9445ba91503c"} 03:36:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:23 INFO - Contents: 03:36:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c308bad10a1263024a1059736b90869dd7707d2fdf255a861393497a9547e5d04cf94259b2266741231a300c22b93868bbbe6caddd5c6e5512b6fd27059ca3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5258b901ec039af2d8eeb1bf61510b31272db9c0a996f89d0b3e657956bf4d920a94765b5f83831a6a04a62dfa1c0a85845515a069df3814d8eb418298dd978f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3202167a5f00f906ba7248b80c4703cdc66a1387cfa0b8c060924b5d863ae8fa8f3a1728b2b2f31c470bc6aa7ca54c14cb39965a5c090d0f0a51568cd07de26b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c58ac696a8a57a918b1507d89dbf3b1d80ae69593bbea48a0cdc1800dfc1c36a8f6d160ec7dad73f28f05952e735011a928fd739ee17aa1dc12e9445ba91503c"} 03:36:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:23 INFO - Copying logs to upload dir... 03:36:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.885780 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-03-12 03:36:23.492431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 03:36:23.495863) ========= 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.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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/4c308bad10a1263024a1059736b90869dd7707d2fdf255a861393497a9547e5d04cf94259b2266741231a300c22b93868bbbe6caddd5c6e5512b6fd27059ca3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5258b901ec039af2d8eeb1bf61510b31272db9c0a996f89d0b3e657956bf4d920a94765b5f83831a6a04a62dfa1c0a85845515a069df3814d8eb418298dd978f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3202167a5f00f906ba7248b80c4703cdc66a1387cfa0b8c060924b5d863ae8fa8f3a1728b2b2f31c470bc6aa7ca54c14cb39965a5c090d0f0a51568cd07de26b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c58ac696a8a57a918b1507d89dbf3b1d80ae69593bbea48a0cdc1800dfc1c36a8f6d160ec7dad73f28f05952e735011a928fd739ee17aa1dc12e9445ba91503c"} build_url:https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010876 build_url: 'https://queue.taskcluster.net/v1/task/ehW9hHCxTDK65L3vF3KLlA/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/4c308bad10a1263024a1059736b90869dd7707d2fdf255a861393497a9547e5d04cf94259b2266741231a300c22b93868bbbe6caddd5c6e5512b6fd27059ca3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5258b901ec039af2d8eeb1bf61510b31272db9c0a996f89d0b3e657956bf4d920a94765b5f83831a6a04a62dfa1c0a85845515a069df3814d8eb418298dd978f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3202167a5f00f906ba7248b80c4703cdc66a1387cfa0b8c060924b5d863ae8fa8f3a1728b2b2f31c470bc6aa7ca54c14cb39965a5c090d0f0a51568cd07de26b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c58ac696a8a57a918b1507d89dbf3b1d80ae69593bbea48a0cdc1800dfc1c36a8f6d160ec7dad73f28f05952e735011a928fd739ee17aa1dc12e9445ba91503c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-12 03:36:23.530075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:36:23.530443) ========= 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.whC1CxXfp9/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.3NqjVim4mc/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005232 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-12 03:36:23.580520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 03:36:23.580884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-12 03:36:23.581243) ========= ========= Total master_lag: 0.18 =========