builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0377 starttime: 1494282169.15 results: success (0) buildid: 20170508140042 builduid: 3d185743c5354e9ca1bdfe74d85acdbe revision: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.148484) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.148926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.149240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.177890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.178196) ========= 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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-05-08 15:22:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-05-08 15:22:49 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198468 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.791830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.792103) ========= 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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.027938 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:49.848989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:22:49.849351) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 --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-beta --rev 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-05-08 15:22:50,128 truncating revision to first 12 chars 2017-05-08 15:22:50,128 Setting DEBUG logging. 2017-05-08 15:22:50,129 attempt 1/10 2017-05-08 15:22:50,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/798ee0e6f73e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 15:22:51,702 unpacking tar archive at: mozilla-beta-798ee0e6f73e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.885035 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:22:51.761444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:51.761753) ========= script_repo_revision: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:51.762129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:51.762406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:51.782811) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-08 15:22:51.783194) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:22:52 INFO - MultiFileLogger online at 20170508 15:22:52 in /builds/slave/test 15:22:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:22:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:52 INFO - {'append_to_log': False, 15:22:52 INFO - 'base_work_dir': '/builds/slave/test', 15:22:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:22:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:52 INFO - 'branch': 'Mozilla-Beta', 15:22:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:52 INFO - 'config_files': ('talos/mac_config.py',), 15:22:52 INFO - 'default_actions': ('clobber', 15:22:52 INFO - 'read-buildbot-config', 15:22:52 INFO - 'download-and-extract', 15:22:52 INFO - 'populate-webroot', 15:22:52 INFO - 'create-virtualenv', 15:22:52 INFO - 'install', 15:22:52 INFO - 'run-tests'), 15:22:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:52 INFO - 'download_minidump_stackwalk': True, 15:22:52 INFO - 'download_symbols': 'ondemand', 15:22:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:52 INFO - 'gecko_profile': False, 15:22:52 INFO - 'gecko_profile_interval': 0, 15:22:52 INFO - 'installer_path': 'installer.exe', 15:22:52 INFO - 'log_level': 'info', 15:22:52 INFO - 'log_name': 'talos', 15:22:52 INFO - 'log_to_console': True, 15:22:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:22:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:22:52 INFO - 'opt_config_files': (), 15:22:52 INFO - 'pip_index': False, 15:22:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:52 INFO - 'cmd': ('bash', 15:22:52 INFO - '-c', 15:22:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:52 INFO - 'enabled': True, 15:22:52 INFO - 'halt_on_failure': False, 15:22:52 INFO - 'name': 'check_screen_resolution'},), 15:22:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:52 INFO - 'cmd': ('bash', 15:22:52 INFO - '-c', 15:22:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:52 INFO - 'enabled': True, 15:22:52 INFO - 'halt_on_failure': False, 15:22:52 INFO - 'name': 'check_screen_resolution'},), 15:22:52 INFO - 'run_cmd_checks_enabled': True, 15:22:52 INFO - 'suite': 'dromaeojs', 15:22:52 INFO - 'system_bits': '32', 15:22:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:52 INFO - 'title': 't-yosemite-r7-0377', 15:22:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:52 INFO - 'use_talos_json': True, 15:22:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:52 INFO - 'work_dir': 'build'} 15:22:52 INFO - [mozharness: 2017-05-08 22:22:52.172871Z] Running clobber step. 15:22:52 INFO - Running pre-action listener: _resource_record_pre_action 15:22:52 INFO - Running main action method: clobber 15:22:52 INFO - rmtree: /builds/slave/test/build 15:22:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:55 INFO - Running post-action listener: _resource_record_post_action 15:22:55 INFO - [mozharness: 2017-05-08 22:22:55.136984Z] Finished clobber step (success) 15:22:55 INFO - [mozharness: 2017-05-08 22:22:55.137148Z] Running read-buildbot-config step. 15:22:55 INFO - Running pre-action listener: _resource_record_pre_action 15:22:55 INFO - Running main action method: read_buildbot_config 15:22:55 INFO - Using buildbot properties: 15:22:55 INFO - { 15:22:55 INFO - "project": "", 15:22:55 INFO - "product": "firefox", 15:22:55 INFO - "script_repo_revision": "production", 15:22:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:22:55 INFO - "repository": "", 15:22:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:22:55 INFO - "buildid": "20170508140042", 15:22:55 INFO - "pgo_build": "False", 15:22:55 INFO - "basedir": "/builds/slave/test", 15:22:55 INFO - "buildnumber": 26, 15:22:55 INFO - "slavename": "t-yosemite-r7-0377", 15:22:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:22:55 INFO - "platform": "yosemite_r7", 15:22:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:22:55 INFO - "branch": "mozilla-beta", 15:22:55 INFO - "repo_path": "releases/mozilla-beta", 15:22:55 INFO - "revision": "798ee0e6f73eaed68e3f3968a20e9ae5c7a82718", 15:22:55 INFO - "stage_platform": "macosx64", 15:22:55 INFO - "builduid": "3d185743c5354e9ca1bdfe74d85acdbe", 15:22:55 INFO - "slavebuilddir": "test" 15:22:55 INFO - } 15:22:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 15:22:55 INFO - Running post-action listener: _resource_record_post_action 15:22:55 INFO - [mozharness: 2017-05-08 22:22:55.140441Z] Finished read-buildbot-config step (success) 15:22:55 INFO - [mozharness: 2017-05-08 22:22:55.140579Z] Running download-and-extract step. 15:22:55 INFO - Running pre-action listener: _resource_record_pre_action 15:22:55 INFO - Running main action method: download_and_extract 15:22:55 INFO - mkdir: /builds/slave/test/build/tests 15:22:55 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')]} 15:22:55 INFO - trying https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 15:22:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 15:22:56 INFO - Downloaded 1287 bytes. 15:22:56 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:22:56 INFO - Using the following test package requirements: 15:22:56 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 15:22:56 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:22:56 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 15:22:56 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 15:22:56 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:22:56 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 15:22:56 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:22:56 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 15:22:56 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 15:22:56 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 15:22:56 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:22:56 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 15:22:56 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 15:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:22:57 INFO - Expected file size: 51223527 15:22:57 INFO - Obtained file size: 51223527 15:23:13 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:23:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:23:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:23:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:23:15 INFO - Expected file size: 51223527 15:23:15 INFO - Obtained file size: 51223527 15:23:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 15:23:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 15:23:30 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 15:23:32 INFO - Expected file size: 14404449 15:23:32 INFO - Obtained file size: 14404449 15:23: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')]} 15:23:32 INFO - trying https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:32 INFO - Downloading https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 15:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 15:23:34 INFO - Downloaded 59569966 bytes. 15:23:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:34 INFO - mkdir: /builds/slave/test/properties 15:23:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:23:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:23:34 INFO - Contents: 15:23:34 INFO - build_url:https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:34 INFO - Running post-action listener: _resource_record_post_action 15:23:34 INFO - Running post-action listener: set_extra_try_arguments 15:23:34 INFO - [mozharness: 2017-05-08 22:23:34.908587Z] Finished download-and-extract step (success) 15:23:34 INFO - [mozharness: 2017-05-08 22:23:34.908746Z] Running populate-webroot step. 15:23:34 INFO - Running pre-action listener: _resource_record_pre_action 15:23:34 INFO - Running main action method: populate_webroot 15:23:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:34 INFO - '--tppagecycles', 15:23:34 INFO - '7'], 15:23:34 INFO - 'tests': ['tsvgm']}}, 15:23:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:23:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:23:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:23:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['damp', 'tps']}, 15:23:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'tests': ['damp', 'tps']}, 15:23:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['dromaeo_dom']}, 15:23:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['basic_compositor_video']}, 15:23:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:23:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['a11yr', 15:23:34 INFO - 'ts_paint', 15:23:34 INFO - 'tpaint', 15:23:34 INFO - 'sessionrestore', 15:23:34 INFO - 'sessionrestore_no_auto_restore', 15:23:34 INFO - 'tabpaint']}, 15:23:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['tsvgx', 15:23:34 INFO - 'tsvgr_opacity', 15:23:34 INFO - 'tart', 15:23:34 INFO - 'tscrollx', 15:23:34 INFO - 'cart', 15:23:34 INFO - 'tsvg_static']}, 15:23:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:23:34 INFO - 'tsvgr_opacity', 15:23:34 INFO - 'tart', 15:23:34 INFO - 'tscrollx', 15:23:34 INFO - 'cart', 15:23:34 INFO - 'tsvg_static']}, 15:23:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'talos_options': ['--disable-e10s'], 15:23:34 INFO - 'tests': ['tp5o']}, 15:23:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:23:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'talos_options': ['--disable-e10s', 15:23:34 INFO - '--xperf_path', 15:23:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:34 INFO - 'tests': ['tp5n']}, 15:23:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:23:34 INFO - 'talos_options': ['--xperf_path', 15:23:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:34 INFO - 'tests': ['tp5n']}}, 15:23:34 INFO - 'talos.zip': {'path': '', 15:23:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:34 INFO - Running post-action listener: _resource_record_post_action 15:23:34 INFO - [mozharness: 2017-05-08 22:23:34.927312Z] Finished populate-webroot step (success) 15:23:34 INFO - [mozharness: 2017-05-08 22:23:34.927415Z] Running create-virtualenv step. 15:23:34 INFO - Running pre-action listener: _resource_record_pre_action 15:23:34 INFO - Running main action method: create_virtualenv 15:23:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:23:34 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 15:23:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:23:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:35 INFO - Using real prefix '/tools/python27' 15:23:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:23:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:38 INFO - Installing pip.................done. 15:23:38 INFO - Return code: 0 15:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:23:39 INFO - Reading from file tmpfile_stdout 15:23:39 INFO - Output received: 15:23:39 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) 15:23:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:39 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:39 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 15:23:39 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 15:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:39 INFO - 'HOME': '/Users/cltbld', 15:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:39 INFO - 'LOGNAME': 'cltbld', 15:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:39 INFO - 'MOZ_NO_REMOTE': '1', 15:23:39 INFO - 'NO_EM_RESTART': '1', 15:23:39 INFO - 'PAGER': '/bin/cat', 15:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:39 INFO - 'PWD': '/builds/slave/test', 15:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:39 INFO - 'SHELL': '/bin/bash', 15:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:39 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:39 INFO - 'USER': 'cltbld', 15:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:39 INFO - 'XPC_FLAGS': '0x0', 15:23:39 INFO - 'XPC_SERVICE_NAME': '0', 15:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:40 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 15:23:40 INFO - Cleaning up... 15:23:40 INFO - Return code: 0 15:23:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:23:40 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')]} 15:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 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')]} 15:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:40 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 15:23:40 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 15:23:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:40 INFO - 'HOME': '/Users/cltbld', 15:23:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:40 INFO - 'LOGNAME': 'cltbld', 15:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:40 INFO - 'MOZ_NO_REMOTE': '1', 15:23:40 INFO - 'NO_EM_RESTART': '1', 15:23:40 INFO - 'PAGER': '/bin/cat', 15:23:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:40 INFO - 'PWD': '/builds/slave/test', 15:23:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:40 INFO - 'SHELL': '/bin/bash', 15:23:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:40 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:40 INFO - 'USER': 'cltbld', 15:23:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:40 INFO - 'XPC_FLAGS': '0x0', 15:23:40 INFO - 'XPC_SERVICE_NAME': '0', 15:23:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:40 INFO - Downloading/unpacking psutil>=3.1.1 15:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:42 INFO - Installing collected packages: psutil 15:23:42 INFO - Running setup.py install for psutil 15:23:43 INFO - building 'psutil._psutil_osx' extension 15:23:43 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 15:23:43 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 15:23:43 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 15:23:43 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 15:23:43 INFO - building 'psutil._psutil_posix' extension 15:23:43 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 15:23:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:23:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:23:43 INFO - ^ 15:23:43 INFO - 1 warning generated. 15:23:43 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 15:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:44 INFO - Successfully installed psutil 15:23:44 INFO - Cleaning up... 15:23:44 INFO - Return code: 0 15:23:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:44 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:44 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 15:23:44 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 15:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:44 INFO - 'HOME': '/Users/cltbld', 15:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:44 INFO - 'LOGNAME': 'cltbld', 15:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:44 INFO - 'MOZ_NO_REMOTE': '1', 15:23:44 INFO - 'NO_EM_RESTART': '1', 15:23:44 INFO - 'PAGER': '/bin/cat', 15:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:44 INFO - 'PWD': '/builds/slave/test', 15:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:44 INFO - 'SHELL': '/bin/bash', 15:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:44 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:44 INFO - 'USER': 'cltbld', 15:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:44 INFO - 'XPC_FLAGS': '0x0', 15:23:44 INFO - 'XPC_SERVICE_NAME': '0', 15:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:23:45 INFO - Installing collected packages: mozsystemmonitor 15:23:45 INFO - Running setup.py install for mozsystemmonitor 15:23:45 INFO - Successfully installed mozsystemmonitor 15:23:45 INFO - Cleaning up... 15:23:46 INFO - Return code: 0 15:23:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:46 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 15:23:46 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 15:23:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:46 INFO - 'HOME': '/Users/cltbld', 15:23:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:46 INFO - 'LOGNAME': 'cltbld', 15:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:46 INFO - 'MOZ_NO_REMOTE': '1', 15:23:46 INFO - 'NO_EM_RESTART': '1', 15:23:46 INFO - 'PAGER': '/bin/cat', 15:23:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:46 INFO - 'PWD': '/builds/slave/test', 15:23:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:46 INFO - 'SHELL': '/bin/bash', 15:23:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:46 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:46 INFO - 'USER': 'cltbld', 15:23:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:46 INFO - 'XPC_FLAGS': '0x0', 15:23:46 INFO - 'XPC_SERVICE_NAME': '0', 15:23:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:46 INFO - Downloading/unpacking jsonschema==2.5.1 15:23:46 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 15:23:46 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 15:23:46 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 15:23:46 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 15:23:46 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 15:23:46 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 15:23:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:23:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23:47 INFO - Downloading functools32-3.2.3-2.tar.gz 15:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:23:47 INFO - warning: no files found matching '*.txt' 15:23:47 INFO - no previously-included directories found matching 'build' 15:23:47 INFO - no previously-included directories found matching 'dist' 15:23:47 INFO - no previously-included directories found matching '.git*' 15:23:48 INFO - Installing collected packages: jsonschema, functools32 15:23:48 INFO - Running setup.py install for functools32 15:23:48 INFO - warning: no files found matching '*.txt' 15:23:48 INFO - no previously-included directories found matching 'build' 15:23:48 INFO - no previously-included directories found matching 'dist' 15:23:48 INFO - no previously-included directories found matching '.git*' 15:23:48 INFO - Successfully installed jsonschema functools32 15:23:48 INFO - Cleaning up... 15:23:48 INFO - Return code: 0 15:23:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:48 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:48 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 15:23:48 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 15:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:48 INFO - 'HOME': '/Users/cltbld', 15:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:48 INFO - 'LOGNAME': 'cltbld', 15:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:48 INFO - 'MOZ_NO_REMOTE': '1', 15:23:48 INFO - 'NO_EM_RESTART': '1', 15:23:48 INFO - 'PAGER': '/bin/cat', 15:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:48 INFO - 'PWD': '/builds/slave/test', 15:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:48 INFO - 'SHELL': '/bin/bash', 15:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:48 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:48 INFO - 'USER': 'cltbld', 15:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:48 INFO - 'XPC_FLAGS': '0x0', 15:23:48 INFO - 'XPC_SERVICE_NAME': '0', 15:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:23:48 INFO - Cleaning up... 15:23:48 INFO - Return code: 0 15:23:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:48 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:48 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 15:23:48 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 15:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:48 INFO - 'HOME': '/Users/cltbld', 15:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:48 INFO - 'LOGNAME': 'cltbld', 15:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:48 INFO - 'MOZ_NO_REMOTE': '1', 15:23:48 INFO - 'NO_EM_RESTART': '1', 15:23:48 INFO - 'PAGER': '/bin/cat', 15:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:48 INFO - 'PWD': '/builds/slave/test', 15:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:48 INFO - 'SHELL': '/bin/bash', 15:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:48 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:48 INFO - 'USER': 'cltbld', 15:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:48 INFO - 'XPC_FLAGS': '0x0', 15:23:48 INFO - 'XPC_SERVICE_NAME': '0', 15:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:48 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:50 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:23:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:51 INFO - Downloading docopt-0.6.1.tar.gz 15:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:51 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:51 INFO - Running setup.py install for blobuploader 15:23:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:23:51 INFO - Running setup.py install for requests 15:23:51 INFO - Running setup.py install for docopt 15:23:51 INFO - Successfully installed blobuploader requests docopt 15:23:51 INFO - Cleaning up... 15:23:52 INFO - Return code: 0 15:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:52 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:52 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 15:23:52 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 15:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:52 INFO - 'HOME': '/Users/cltbld', 15:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:52 INFO - 'LOGNAME': 'cltbld', 15:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:52 INFO - 'MOZ_NO_REMOTE': '1', 15:23:52 INFO - 'NO_EM_RESTART': '1', 15:23:52 INFO - 'PAGER': '/bin/cat', 15:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:52 INFO - 'PWD': '/builds/slave/test', 15:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:52 INFO - 'SHELL': '/bin/bash', 15:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:52 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:52 INFO - 'USER': 'cltbld', 15:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:52 INFO - 'XPC_FLAGS': '0x0', 15:23:52 INFO - 'XPC_SERVICE_NAME': '0', 15:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-wqxyZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-faLrLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-kIg11R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-0gFwBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-cVnGX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BlRsS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:52 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-l7z9vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bDliYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-6bdU4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YTTkkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-hC7JZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-iECeZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-VmAVYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-b9MyEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-nSz_HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5udiX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:53 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-PWGKtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:54 INFO - Running setup.py install for manifestparser 15:23:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:23:54 INFO - Running setup.py install for mozcrash 15:23:54 INFO - Running setup.py install for mozdebug 15:23:54 INFO - Running setup.py install for mozdevice 15:23:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:23:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:23:54 INFO - Running setup.py install for mozfile 15:23:54 INFO - Running setup.py install for mozhttpd 15:23:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:23:54 INFO - Running setup.py install for mozinfo 15:23:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozInstall 15:23:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozleak 15:23:55 INFO - Running setup.py install for mozlog 15:23:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for moznetwork 15:23:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozprocess 15:23:55 INFO - Running setup.py install for mozprofile 15:23:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for mozrunner 15:23:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for mozscreenshot 15:23:56 INFO - Running setup.py install for moztest 15:23:56 INFO - Running setup.py install for mozversion 15:23:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:56 INFO - Cleaning up... 15:23:56 INFO - Return code: 0 15:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:56 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:23:56 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 15:23:56 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 15:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:56 INFO - 'HOME': '/Users/cltbld', 15:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:56 INFO - 'LOGNAME': 'cltbld', 15:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:56 INFO - 'MOZ_NO_REMOTE': '1', 15:23:56 INFO - 'NO_EM_RESTART': '1', 15:23:56 INFO - 'PAGER': '/bin/cat', 15:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:56 INFO - 'PWD': '/builds/slave/test', 15:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:56 INFO - 'SHELL': '/bin/bash', 15:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:23:56 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:56 INFO - 'USER': 'cltbld', 15:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:56 INFO - 'XPC_FLAGS': '0x0', 15:23:56 INFO - 'XPC_SERVICE_NAME': '0', 15:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:56 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-CufYFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KlOb14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-xVxvdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-jSWl_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-kJjoYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-D2K_sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-O35m1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-XEb3gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Nz9WvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:57 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-2YG1Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-aCLTrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-j5GeVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-2PpFH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BkDolg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bM1yMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-fx0e4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:58 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-yOBxwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:24:00 INFO - Downloading blessings-1.6.tar.gz 15:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:00 INFO - Installing collected packages: blessings 15:24:00 INFO - Running setup.py install for blessings 15:24:00 INFO - Successfully installed blessings 15:24:00 INFO - Cleaning up... 15:24:00 INFO - Return code: 0 15:24:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:00 INFO - Reading from file tmpfile_stdout 15:24:00 INFO - Current package versions: 15:24:00 INFO - blessings == 1.6 15:24:00 INFO - blobuploader == 1.2.4 15:24:00 INFO - docopt == 0.6.1 15:24:00 INFO - functools32 == 3.2.3-2 15:24:00 INFO - jsonschema == 2.5.1 15:24:00 INFO - manifestparser == 1.1 15:24:00 INFO - mozInstall == 1.12 15:24:00 INFO - mozcrash == 1.0 15:24:00 INFO - mozdebug == 0.1 15:24:00 INFO - mozdevice == 0.49 15:24:00 INFO - mozfile == 1.2 15:24:00 INFO - mozhttpd == 0.7 15:24:00 INFO - mozinfo == 0.9 15:24:00 INFO - mozleak == 0.1 15:24:00 INFO - mozlog == 3.4 15:24:00 INFO - moznetwork == 0.27 15:24:00 INFO - mozprocess == 0.25 15:24:00 INFO - mozprofile == 0.28 15:24:00 INFO - mozrunner == 6.13 15:24:00 INFO - mozscreenshot == 0.1 15:24:00 INFO - mozsystemmonitor == 0.3 15:24:00 INFO - moztest == 0.8 15:24:00 INFO - mozversion == 1.4 15:24:00 INFO - psutil == 3.1.1 15:24:00 INFO - requests == 1.2.3 15:24:00 INFO - wsgiref == 0.1.2 15:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:00 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')]} 15:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 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')]} 15:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:24:00 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 15:24:00 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 15:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:00 INFO - 'HOME': '/Users/cltbld', 15:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:00 INFO - 'LOGNAME': 'cltbld', 15:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:00 INFO - 'MOZ_NO_REMOTE': '1', 15:24:00 INFO - 'NO_EM_RESTART': '1', 15:24:00 INFO - 'PAGER': '/bin/cat', 15:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:00 INFO - 'PWD': '/builds/slave/test', 15:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:00 INFO - 'SHELL': '/bin/bash', 15:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:24:00 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:00 INFO - 'USER': 'cltbld', 15:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:00 INFO - 'XPC_FLAGS': '0x0', 15:24:00 INFO - 'XPC_SERVICE_NAME': '0', 15:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 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)) 15:24:01 INFO - Cleaning up... 15:24:01 INFO - Return code: 0 15:24:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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')]} 15:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:01 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 0x10ab44b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab47768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd50b58a0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, '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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 15:24:01 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 15:24:01 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 15:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:01 INFO - 'HOME': '/Users/cltbld', 15:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:01 INFO - 'LOGNAME': 'cltbld', 15:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:01 INFO - 'MOZ_NO_REMOTE': '1', 15:24:01 INFO - 'NO_EM_RESTART': '1', 15:24:01 INFO - 'PAGER': '/bin/cat', 15:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:01 INFO - 'PWD': '/builds/slave/test', 15:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:01 INFO - 'SHELL': '/bin/bash', 15:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:24:01 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:01 INFO - 'USER': 'cltbld', 15:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:01 INFO - 'XPC_FLAGS': '0x0', 15:24:01 INFO - 'XPC_SERVICE_NAME': '0', 15:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:01 INFO - Cleaning up... 15:24:01 INFO - Return code: 0 15:24:01 INFO - Running post-action listener: _resource_record_post_action 15:24:01 INFO - Running post-action listener: _start_resource_monitoring 15:24:01 INFO - Starting resource monitoring. 15:24:01 INFO - [mozharness: 2017-05-08 22:24:01.356127Z] Finished create-virtualenv step (success) 15:24:01 INFO - [mozharness: 2017-05-08 22:24:01.357112Z] Running install step. 15:24:01 INFO - Running pre-action listener: _resource_record_pre_action 15:24:01 INFO - Running main action method: install 15:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:01 INFO - Reading from file tmpfile_stdout 15:24:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:01 INFO - Reading from file tmpfile_stdout 15:24:01 INFO - Output received: 15:24:01 INFO - Usage: mozinstall [options] installer 15:24:01 INFO - Options: 15:24:01 INFO - -h, --help show this help message and exit 15:24:01 INFO - -d DEST, --destination=DEST 15:24:01 INFO - Directory to install application into. [default: 15:24:01 INFO - "/builds/slave/test"] 15:24:01 INFO - --app=APP Application being installed. [default: firefox] 15:24:01 INFO - mkdir: /builds/slave/test/build/application 15:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:24:16 INFO - Reading from file tmpfile_stdout 15:24:16 INFO - Output received: 15:24:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:24:16 INFO - Running post-action listener: _resource_record_post_action 15:24:16 INFO - [mozharness: 2017-05-08 22:24:16.553683Z] Finished install step (success) 15:24:16 INFO - [mozharness: 2017-05-08 22:24:16.553828Z] Running run-tests step. 15:24:16 INFO - Running pre-action listener: _resource_record_pre_action 15:24:16 INFO - Running main action method: run_tests 15:24:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:24:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:24:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:24:16 INFO - 2017-05-08 15:24:16.568 screenresolution[1626:7637] starting screenresolution argv=screenresolution get 15:24:16 INFO - 2017-05-08 15:24:16.571 screenresolution[1626:7637] Display 0: 1600x1200x32@60 15:24:16 INFO - 2017-05-08 15:24:16.577 screenresolution[1627:7639] starting screenresolution argv=screenresolution list 15:24:16 INFO - Available Modes on Display 0 15:24:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:24:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:24:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:24:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:24:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:24:16 INFO - Intel Iris: 15:24:16 INFO - Chipset Model: Intel Iris 15:24:16 INFO - Type: GPU 15:24:16 INFO - Bus: Built-In 15:24:16 INFO - VRAM (Dynamic, Max): 1536 MB 15:24:16 INFO - Vendor: Intel (0x8086) 15:24:16 INFO - Device ID: 0x0a2e 15:24:16 INFO - Revision ID: 0x0009 15:24:16 INFO - Displays: 15:24:16 INFO - Display: 15:24:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:24:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:24:16 INFO - Display Serial Number: 1600x1200 60 15:24:16 INFO - Main Display: Yes 15:24:16 INFO - Mirror: Off 15:24:16 INFO - Online: Yes 15:24:16 INFO - Rotation: Supported 15:24:16 INFO - Return code: 0 15:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:16 INFO - Python 2.7.3 15:24:16 INFO - Return code: 0 15:24:16 INFO - grabbing minidump binary from tooltool 15:24:16 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')]} 15:24:16 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 0x10a922d30>, '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 0x10a849db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a917be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:16 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 15:24:16 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 15:24:16 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 15:24:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:16 INFO - Return code: 0 15:24:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:24:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:16 INFO - ENV: RUST_BACKTRACE is now 1 15:24:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:24:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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 15:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4hxlTKyuqk/Render', 15:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:16 INFO - 'HOME': '/Users/cltbld', 15:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:16 INFO - 'LOGNAME': 'cltbld', 15:24:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:16 INFO - 'MOZ_NO_REMOTE': '1', 15:24:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:16 INFO - 'NO_EM_RESTART': '1', 15:24:16 INFO - 'PAGER': '/bin/cat', 15:24:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:16 INFO - 'PWD': '/builds/slave/test', 15:24:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:16 INFO - 'RUST_BACKTRACE': '1', 15:24:16 INFO - 'SHELL': '/bin/bash', 15:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZAjAm6YDTK/Listeners', 15:24:16 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:16 INFO - 'USER': 'cltbld', 15:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:16 INFO - 'XPC_FLAGS': '0x0', 15:24:16 INFO - 'XPC_SERVICE_NAME': '0', 15:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:24:17 INFO - mozversion application_buildid: 20170508140042 15:24:17 INFO - mozversion application_changeset: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 15:24:17 INFO - mozversion application_display_name: Firefox 15:24:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:17 INFO - mozversion application_name: Firefox 15:24:17 INFO - mozversion application_remotingname: firefox 15:24:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:24:17 INFO - mozversion application_vendor: Mozilla 15:24:17 INFO - mozversion application_version: 54.0 15:24:17 INFO - mozversion platform_buildid: 20170508140042 15:24:17 INFO - mozversion platform_changeset: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 15:24:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:24:17 INFO - mozversion platform_version: 54.0 15:24:17 INFO - using testdate: 1494282257 15:24:17 INFO - actual date: 1494282257 15:24:17 INFO - starting webserver on 'localhost:49241' 15:24:17 INFO - SUITE-START | Running 2 tests 15:24:17 INFO - TEST-START | dromaeo_css 15:24:17 INFO - operating with platform_type : mac_ 15:24:17 INFO - Initialising browser for dromaeo_css test... 15:24:17 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpGjIBFT/profile http://localhost:49241/getInfo.html) 15:24:19 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 15:24:19 INFO - PROCESS | 1637 | colorDepth:24 15:24:19 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 15:24:19 INFO - PROCESS | 1637 | __metrics 15:24:19 INFO - PROCESS | 1637 | 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" 15:24:19 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:20 INFO - TEST-INFO | 1637: exit 0 15:24:20 INFO - Browser initialized. 15:24:20 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:20 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpGjIBFT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:32 INFO - PROCESS | 1640 | RSS: Main: 165146624 15:24:32 INFO - PROCESS | 1640 | 15:27:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:27:38 INFO - PROCESS | 1640 | RSS: Main: 307617792 15:27:38 INFO - PROCESS | 1640 | 15:30:40 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:30:41 INFO - PROCESS | 1640 | RSS: Main: 305471488 15:30:41 INFO - PROCESS | 1640 | 15:33:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:33:44 INFO - PROCESS | 1640 | RSS: Main: 273387520 15:33:44 INFO - PROCESS | 1640 | 15:36:46 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:36:47 INFO - PROCESS | 1640 | RSS: Main: 267218944 15:36:47 INFO - PROCESS | 1640 | 15:39:50 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:39:51 INFO - PROCESS | 1640 | RSS: Main: 268050432 15:39:51 INFO - PROCESS | 1640 | 15:42:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:42:55 INFO - PROCESS | 1640 | RSS: Main: 314249216 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | __start_tp_report 15:42:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 15:42:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 15:42:55 INFO - PROCESS | 1640 | |i|pagename|runs| 15:42:55 INFO - PROCESS | 1640 | |0;dojo.html;3549.5208146900163;3590.551181102362;3602.135487483003;3604.6034936157016;3638.6361363863602;5279.868003299919;6069.423404776545;6162.025493556654;6236.656983865897;6269.216347956505;6186.536009799272;6242.438180563749;6261.843453913654;6263.248410190783;6291.402316779899;5481.643693159942;5504.80733174339;5522.861928451781;5525.557955363562;5627.662340259598;5384.865378365533;5410.404855465896;5478.150886612581;5500.80747173849;5611.831645050655;5578.2748242728385;5595.21666966625;5597.692126933017;5598.328200615932;5605.579581531381;5030.547250747451;5591.384947655754;5598.44015598441;5604.8038318658655;5606.831795046155;5301.946980530184;5428.212909128194;5493.2034854945805;5508.91736623951;5529.253550770634;6122.7438261917805;6134.375358695292;6140.8771824563255;6169.29053158888;6221.346758590374;6557.803265901983;6569.737210511574;6580.638064906429;6582.210134783809;6584.078229047937;6580.374864387875;6610.239822420435;6646.966765166191;6669.733210671568;6670.566413183127;6059.878802424015;6137.052516990508;6200.224971878515;6342;6347.365263473662;6662.400383965466;6728.3271672832325;6754.594724316458;6757.797266082025;6823.420009299265;6474.0612611172055;6485;6496.805095847132;6501.804945851632;6512.902306465407;6308.211473565804;6396.552241343062;6645.966770166118;6663.933360666429;6668.299828518033;6400.967995159995;6477.060826180272;6485.513586480938;6548.443382312462;6561;6428.903566446507;6575.210974683068;6583.0454584086;6583.80248592543;6592.43964263043;5305.257263982969;5327.254184414185;5329.813456529003;5360.383555891044;5360.927814437128;4615.746133962597;4665.393498845128;4681.765911704401;4709.458412282563;4744.478107408182;6337.8732425352155;6342.651154186564;6346.492280617539;6348.333424990309;6351.523635727246;6656.134702488645;6656.96671516649;6665.900011499832;6670.999350097524;6692.297308782605;6124.142620033199;6176.227971503562;6272.435480806749;6294.181756371734;6342.619442833445;5766.855828604234;5804.158397032406;5862.179294898718;5891.440313170242;5919.141724449931;6889.965550172217;6909.067275917687;6911.274316196827;6914.757983470555;6934.4452443804375;6561.639109849004;6659.433948114271;6674.466042716668;6692.130023097161;6721.93278067213;6520.413162815369;6633.502487313374;6709;6807.795766127024;6884.173899132136;6292.339304372975;6556.442702370161;6566.343365663586;6576.013597960345;6589.835254118685;5353.812616558402;6413.42279194856;6444.001179817136;6457.644829534421;6641.070250164884;6498.675066246574;6498.772542960974;6506.284308725942;6509.283978762238;6513.4463570595135;5227.686338819683;6273.905891411541;6330.49356051524;6341.936580634135;6496.935030649633;6326.620402775849;6342.112104305494;6360.872782544416;6368.52236082305;6373.840653983502;6472.417482426604;6491;6491.156149700509;6503.707333169924;6505.934940650723;6188.81433556994;6231.875362492634;6256.280527739368;6301.873962520815;6333.2716737575765 15:42:55 INFO - PROCESS | 1640 | |1;ext.html;787.5865170785337;823.6375994562392;839.7690635075352;922.9030951750062;928.6888892221106;30694;42942;43240.918977025554;43366.56633433665;43460.78269608648;42863;43100.35349469753;43154;45040;45172;8076.152004039579;9816.509174541263;9986.750331241705;9998.25013124015;10009.899901001007;7986.440949133534;11826.29042257463;11932.74706155854;12293.631191064238;12360.567380141696;11998.460069296903;12063.879361206407;12119.878801211964;12124.878751212464;12162.966147877441;12038.458269377856;12041.397930103547;12047.277163370181;12054.698632534257;12059.698507537294;11657.242279251821;11712.063034957268;11714.824277635842;11726.765464690743;11737.119716021332;42378.57621423777;42542.14915701668;42590.57409425897;42705.145897081886;42706;4019.356902895552;4023.517177938637;4066.0241542029994;4081.4081958115908;4101.938470922939;29071.273218169503;29651.110466686034;31284.843575781975;31380.529292060637;31708.207294817814;3325.3681800457834;3349.045522026235;3387.220939183977;3418.2138108234994;3436.9312613747584;356703;359242;360110;360987.195064023;360988.9999999974;55719.721401393545;55895;55955;56111;56173;57849;57851;57936;57957;57977;15812.446564370422;15894.284757185724;15900.52298431049;15917.442889498812;15952.042877427391;12248.81626775599;12359.876401236052;13280.933595332155;13308.467661293633;13320.666983325495;11708.063354931584;13266.602001939957;13518.864811351761;13547.86452135466;13680.93159534196;5810;5880.500157486576;5885.47030767233;5900.468957793819;5913.526917846562;953.4755884263627;977.6040703515088;986.3194395866828;1029.6190409548515;1030.845373194027;30028.24929376783;30154.643041063206;30271.091867244017;30785.2303692405;31064.534031989086;933.7945651956559;1060.1095080132725;1061.570064124031;1106.6292791914798;1116.3636727065496;15659.686806263811;15716;15810.972286801321;16138.596535086483;16143;434421;435304;435467;435718;436903;61177;61355.693221533606;61392.77214455686;61477.38522614806;61495.77008459895;1470.4485817818318;1483.3769816677238;1541.3064121145305;1543.4906480861289;1556.2141118734967;26923.057692980652;27519.761610727965;28433;29891.252718682208;29906.10281691553;47995.52004479911;49091.50908490869;50292;51029;51032.74483627558;449907;453088;454179.7291013524;455247;456155;31720.682793172695;31909.6809031916;31980.520292196103;32531;33239.83380083084;41738.95652608587;41773.79113104415;42047;42432.5756742441;42828.78585607052;28923;29091.83632654755;29462.41075178527;29640.703592963793;30221.848890755406;29315.70684293215;29332.12003639894;30085.3982920336;30250.336231507477;30522.08433746991;35613.82193089018;35805.87356893977;35995;36075.458868116475;36204.09489762777;29317.560236596895;29335.119946401643;29653.110406687832;29931;30669.926552571447;22240.999155037738;23622.52754944926;23795.64306535438;24025.51948961046;24197.879010604833 15:42:55 INFO - PROCESS | 1640 | |2;jquery.html;389.1069994362937;438.4804007251406;438.73456558781936;448.8810465226715;454.5091301394492;19593.804061959378;21703.240386586473;22591.435214119654;22724.65913011306;22980.195693150745;23494;23557.528849423;24274.635880461807;24399.75600243997;24738;5559.444055594428;6672.3409279877205;7126.78619641409;7197.89203161953;7199.964000180018;6824.69288881999;6966.756163534277;7042.507024508286;7128.714851405964;7130.465215108861;7135.036770036057;7139.071920650308;7147.285271472837;7149.177844547891;7149.928500715005;6954.930450695479;7040.943858421252;7066.646667666648;7078.079849619568;7131;6016.909746353808;6971.093757811503;6982.581045137308;6986.755463558751;7282.344588987016;26997.325066873287;27041.45917081667;27124.1862744116;27136.91452341904;27404.177874663794;2997.985010074936;3005.8046226995175;3102.37952409519;3125.343677827659;3147.1817327494787;15838.604034899105;16160.111193884331;16163.83836161635;16192.190390480546;17208.39770608035;2123.7982391672767;2149.6560550311874;2161.135545781684;2182.6835108909117;2241.7758224177614;151922;154417;156052;157658;160554;14183.383164840065;15963.840361596467;19179.136938837786;20030.599388012448;20440.488987775425;29269.829206831913;30681.69318306833;32591.51112733311;32745.181370465452;32745.34509309848;10698.090662293793;10797.29817561856;10858.891411085946;10867.29362591429;11062.22564420483;9225.492597907045;9239.260859131253;9257.398269112486;9397.342186046912;9423.293253005915;9139.862902056475;9373.390729602554;9458.810823783624;9498.192653624381;9499.952500237454;3405.6934875861293;3988.487253030572;4180.372944058416;4194.475690538683;4206.41110244566;1033.3644808442905;1056.8203405421098;1081.567373050786;1094.4746521669642;1140.0708422635525;22877.428064298194;23303.300900972998;23393.41516462102;23400.297991060295;23470.530589388458;947.4078700811992;991.1971303244395;1109.2401704832216;1155.1509640414288;1159.7796418680423;10136.341137826164;10308.845367319496;10971.902809719124;11889.346085965182;11969.341686207343;529567;584069;590367;686146;765999;161468;161517.38482615259;162412;169102;174778;1236.715555422258;1291.922484650924;1323.4639970811645;1329.2224048931485;1329.8736620021082;15166;19495.707564386263;19749.60500790005;21132.260370886946;21142.78857211408;63807.680961594895;63975.360246396944;64034;64043.35956640374;64594.67702661457;88269;88741;90567;91110.54444727734;91319.54340228256;11633.941830290794;11807.468663909973;12183;12183.390830458264;12190.329531875832;11132.554697811996;12231.87768122343;13079.215247085205;13338.533151339656;13393.866061339651;6138.07928810682;9727.464989425649;11418.029467495357;11771.941140294586;11868.525258989544;10579.735506612396;10736.838947415952;10775.838362424412;11041.39272339997;11097.556097756;7588.658510366937;11129.554817807197;11770.411479425824;11793.705157371134;11833.763324733629;11912.404379780803;12110.636680899586;12170.904618584369;12216.083793715328;12269.141160118706;11477.598284060017;11503.654890353302;11578;11801.704957376134;11897.524099036287 15:42:55 INFO - PROCESS | 1640 | |3;mootools.html;1595.2900959073218;1626.7641192027156;1653.1816750708397;1657.6601796631692;1669.8163202047776;10949.233553651238;11576.305421674706;11600.477978490968;11615.825762613567;11628.534858605657;11212.495437705302;11286.153538484605;11559.711007224823;11583;11591.884081159185;2333.5099629077913;2386.4033991502124;2399.6640470334078;2405.218304051182;2415;2327.94180145496;2389.976100238993;2391.234804862445;2394.38943069517;2410.915617953372;2325.6046472099783;2350.71791385034;2354.446705024318;2407.325948734357;2419.9395015124674;2312.5143719818857;2371.490129622131;2375.2874137758604;2375.6199008158783;2396.4488167721347;2003.869748466345;2357.728861180969;2370.561446132471;2378.4410663494064;2378.988929704886;11146.275492092987;11364.715882102932;11372.431378431045;11381.2033157679;11384.430778461045;5601.971990140064;5786.537077033827;5828.912566311508;5835.737391817378;5853.941460585383;2909.3599408130176;2992.8054676446177;3413.368526822546;3482.1990942083207;3537.1510837399096;1101.4657890922897;1256.9622911312674;1266.5440441441074;1311.5606271898926;1311.61307414313;14188.57434276963;14524.564263072125;15009.324580393908;15501.844981550154;15913;4737.786799593958;4747.525247475225;4823.204171311764;4920.975395123001;4937.827176048893;13327.933360333136;13469.932650336686;13471.865281347062;13476.191428514321;13499.527516536875;5816.1566572846705;5823.126531020381;5833.445822646841;5862.70686465675;5877.500412464989;5130.79476820923;5162.5095615916425;5215.55667768244;5258.316418865523;5322.0154271459905;4034.8386064557676;4071.1043570414463;4125.876223713293;4144.8134833932545;4147.81334839933;1078.358376765823;1089.6567581211893;1096.681962230944;1108.4956344863067;1113.6436340371004;923.5797712041006;934.7663084228943;957.7701351675547;959.6689142245914;1017.8218811708069;6675.899861502081;6706.765263215764;6801.149856267966;6919;6929.653517324114;997.187292356727;1009.2380252909154;1014.4319181258519;1022.1311884897926;1035.233926894108;4101.179764047143;4145.461090058273;4186.016286172747;4233.280342341748;4316.935245971313;13390.665233369244;13982.720345593234;13983.510577129751;13984.230867302396;13991.23048232357;13078.869211307956;13620.591382258548;13855.03014788955;13886.513972010931;13889.79165312521;8604.526751028754;10095;10212.489375531342;10300.896991030144;10355.068043876086;5688.63023903445;6756.290589488033;7037.401820845081;7142.035825163536;7207.73864573708;9911.405315680793;11962.222455540363;12447.190932589352;12701.237925724487;12720.809187862375;12575.245485270912;12590.496380144692;12628.494860205488;12915.677108071997;12982.026348023746;9167.587458564247;9357.298202634693;9543.28425368114;9552.42685438876;9571.042895710652;10586.735331616772;10764.677059688222;10911.727206819893;10916.399598022184;10972.890271097505;9005.594748236475;9024.458532488072;9072.228860546664;9267.119623635745;9279.443233406017;8791.296696264155;8833.911660883308;8849.026607073345;8927.821443571222;8971.955140224258;8278.668853245803;8299.128591498047;8321.459105158388;8402.87395689053;8405.117462666576;5923.555733319932;6069.084577262575;6157;6186.319504854372;6238.986426784944;6060.060690592965;6085.908711369421;6129.111278864629;6258.874822503433;6352.047192921099 15:42:55 INFO - PROCESS | 1640 | |4;prototype.html;386.18129565321516;387.78477944740655;390.16115351993227;393.986210482633;395.7229939042669;4402.669799765018;5160.741962901859;5204.843854684356;5220.26916231727;5232.895342093156;4768.690035147713;5007.424146223177;5042.755973591753;5115.800205911457;5128.871778205546;4161.230172418097;4240.279152544075;4268.463353192848;4290.399344091829;4296;4208.421841809321;4263.850765223217;4269.188854117708;4280.250956082688;4301.827926882921;3769.6795772359383;4011.313452091494;4259.360146343664;4262.829486820523;4279.75312960695;3886.300465916148;3942.107788261636;4221.501367014727;4226.23181815908;4290.313549832012;3203.3593281343824;3459.7405194610506;3519.944016794977;3952.32810422226;3952.505936757905;4807.951920480786;5022.397312322508;5030.471800460936;5030.723310217936;5041.110123180509;4629.564834901192;4845.27320901864;4918.581920536759;4935.925961110586;4982.975085124587;4879.999200327884;4930.359053323081;5431.511163995259;5462.918056229159;5500.734830988855;3776.848926042955;4139.606737359946;4202.789860506962;4372.1692878353015;4402.955970440319;5432.728363581805;5738.512226460756;5741.741621627037;5790.131480277992;5937.614055086406;4053.148838743838;4474.919162589412;4492.910141797146;4506.932396014063;4546.795394207203;4395.296752519582;4655.837045703452;4688.578027977498;4714.457837348748;4730.385049943486;4341.305391137403;4709.762862640218;4849.830255941025;4937.654364194472;5025.497450254945;4444.577765112309;4728.784426589952;4850.708957462563;5086.415062267813;5398.597624057257;1363.863613638648;1567.6159340961538;1577.3532851531047;1580.6127498762876;1593.7450007998664;1012.5747186181821;1069.8395240713799;1084.728817795551;1161.0305394995105;1211.7818792617413;4422.071365013319;5055.8988820223385;5177.741112944338;5179.689218646893;5180.9740951295;4709.67032307742;5054.137200847;5294.9410117975785;5377.7311134443125;5578.577462746974;4831.879203019953;4941.022476906053;4946.802127914843;4958.975205123951;5176.637635365489;2577.4716183182404;2596.091368021215;2873.080614203435;2938.180365524809;2960.955585666217;5091.741285577234;5825.1941898011755;5881.676507792027;5906.725910524393;5915.526757859361;4923.547553471734;4951.455339912607;5051.857476868932;5499.615026948155;5645.830625081254;5671.319441667027;5840.8026354597205;5922.2597175353085;5933.842900634508;5938.851528711817;4899.387576552931;5693.100226344967;5720.8283751487525;5749.655020698771;5769.769209231584;5450.618456707993;5553.745767564101;5564.801903248275;5639.407862174577;5649.971750141223;5111.769970351417;5544.972275138599;5712.71573794247;5889.49939255151;5934.43622855828;4426.3803067569925;4745.691530050535;4927.753612319441;5008.974955125201;5011.072951503984;5123.180291153398;5309.575233981195;5684.971575142098;5696.515796157373;5696.715164241688;4618.56123668251;5101.69389836611;5552.444755524415;5580.274564306615;5581.711498285846;4950.579200767831;5203.661761985459;5540.778368865362;5554.666719996813;5563.108543095367;4814;5281.366236051698;5435.918461223006;5463.825277565343;5536.667799932017;5190.506901844319;5501.899620076081;5567.582431317586;5583.385827559046;5585.134304182858;4689.718616882998;5054.775898604602;5146.614003949644;5354.598405119709;5470.452954704498 15:42:55 INFO - PROCESS | 1640 | |5;yui.html;777.4829738224081;811.7443005453285;848.9939421785189;897.7441429192681;900.5182227508283;15599.220038998048;17129.65740685187;17156.914215428922;17164.82835171648;17178.570535736613;13616.523421680244;15627;15796.842031579681;16100.75848862268;16234.269457874394;796.5857753967919;975.790205105902;976.2921881635792;976.8192884316425;977.1645243316968;969.8205831921082;970.0687340153426;970.873786407766;971.1065819446092;1000.1298869983088;1057.5981127171665;1067.5356220044305;1068.7808999155193;1087.983680244797;1090.8581884355024;1083.5449111373202;1083.6748975307455;1084.2464487181412;1084.5499117866116;1084.614961688605;795.7970717467009;796.1441450440799;796.1680044353665;797.4059325802257;798.0064819300009;17714.468565942912;17935.3722619709;18208.817911820977;18222.453326400228;18376.724349134773;14630.634234144125;14880.330385132695;14901.478448254367;14925.70148597022;15238.161901095435;11790.364809745473;12079;12117.33354665493;12286.324252166127;12518.937405312916;3855.1904100139004;3878.534575850916;3936.3308237599676;4106.7125301228925;4116.629503344683;121566.3921680386;122072.38963805213;122649;123667;124536;11301.830472542919;11563.76872462546;11628.94185529067;11781.587644432575;11826.76346473083;19780.40658780239;24129.396765081012;24159.879200603886;24160.275191744277;24186.516269674506;7737.535747855034;8110.46758157607;8191.672333106728;8294.502329860228;8490.23587877094;4462.776861156929;4602.33953089817;4630.629549636021;4675.485696573374;4808.663393562417;3545.3972824619877;3598;3612;3648.8175591220865;3654.2874139543064;579.1341943794055;586.3696526234315;591.3642833953517;594.2779522879722;594.6194435561245;684.5960883079007;688.2498077095989;704.0143798681784;729.2925861913935;740.1229542991572;10052.74868128288;10751;11004.449777511092;11317.207795454238;11372.431378431045;676.1750664189681;721.3832173491589;725.1008749151121;729.6661405128527;750.9249075092556;5137;5163.8192663256605;5246.449122842047;5254.264402983586;5258.395284542326;72698.27301727021;86222.27555448856;99023;102689;104989.47505262577;66708;69083.30916690869;82021.35957280821;84591.77041148041;87010.56494717486;77858.61070694723;79754.01844861658;79983;81656.59171704104;82760.58619706983;10512.474376281003;10547.787004494581;11014.173936954921;11272.985431311221;11474;48282.03435931192;48611.75694121507;48789.75605121952;49772.751136244086;50022.749886250334;64186;64200;64397.67801160964;64518;64901;13167;13257.86742132605;13425.395857186255;13561.79657305161;13957.371918263905;14191.290435478391;14612.415503379745;15431.768523472381;15603.063816171067;15800.209989500709;13881.791773123614;14318.427262909367;14439.278036097943;14490.420383184555;14817.989713328523;13499.730005400033;14327.140371577738;14336.211508366723;14359.641008974859;14362.281885905453;13115.934420327838;13938.860611393757;14005.759078547384;14119.308856150847;14542.41830326775;9218.585163667785;9681.70954871355;9697.224222062077;9737.07497787709;9912.306138570231;9357.39176953496;11333.943330283295;11603.767924641628;11614.825777613512;11643.650690479299 15:42:55 INFO - PROCESS | 1640 | __end_tp_report 15:42:55 INFO - PROCESS | 1640 | __start_cc_report 15:42:55 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1525 15:42:55 INFO - PROCESS | 1640 | __end_cc_report 15:42:55 INFO - PROCESS | 1640 | __startTimestamp1494283375278__endTimestamp 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | ------- Summary: start ------- 15:42:55 INFO - PROCESS | 1640 | Number of tests: 6 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:6113.29 Median:6342.11 stddev:686.17 (10.8%) stddev-sans-first:658.14 15:42:55 INFO - PROCESS | 1640 | Values: 3549.5 3590.6 3602.1 3604.6 3638.6 5279.9 6069.4 6162.0 6236.7 6269.2 6186.5 6242.4 6261.8 6263.2 6291.4 5481.6 5504.8 5522.9 5525.6 5627.7 5384.9 5410.4 5478.2 5500.8 5611.8 5578.3 5595.2 5597.7 5598.3 5605.6 5030.5 5591.4 5598.4 5604.8 5606.8 5301.9 5428.2 5493.2 5508.9 5529.3 6122.7 6134.4 6140.9 6169.3 6221.3 6557.8 6569.7 6580.6 6582.2 6584.1 6580.4 6610.2 6647.0 6669.7 6670.6 6059.9 6137.1 6200.2 6342.0 6347.4 6662.4 6728.3 6754.6 6757.8 6823.4 6474.1 6485.0 6496.8 6501.8 6512.9 6308.2 6396.6 6646.0 6663.9 6668.3 6401.0 6477.1 6485.5 6548.4 6561.0 6428.9 6575.2 6583.0 6583.8 6592.4 5305.3 5327.3 5329.8 5360.4 5360.9 4615.7 4665.4 4681.8 4709.5 4744.5 6337.9 6342.7 6346.5 6348.3 6351.5 6656.1 6657.0 6665.9 6671.0 6692.3 6124.1 6176.2 6272.4 6294.2 6342.6 5766.9 5804.2 5862.2 5891.4 5919.1 6890.0 6909.1 6911.3 6914.8 6934.4 6561.6 6659.4 6674.5 6692.1 6721.9 6520.4 6633.5 6709.0 6807.8 6884.2 6292.3 6556.4 6566.3 6576.0 6589.8 5353.8 6413.4 6444.0 6457.6 6641.1 6498.7 6498.8 6506.3 6509.3 6513.4 5227.7 6273.9 6330.5 6341.9 6496.9 6326.6 6342.1 6360.9 6368.5 6373.8 6472.4 6491.0 6491.2 6503.7 6505.9 6188.8 6231.9 6256.3 6301.9 6333.3 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:56840.17 Median:32885.42 stddev:110650.75 (336.5%) stddev-sans-first:110881.13 15:42:55 INFO - PROCESS | 1640 | Values: 787.6 823.6 839.8 922.9 928.7 30694.0 42942.0 43240.9 43366.6 43460.8 42863.0 43100.4 43154.0 45040.0 45172.0 8076.2 9816.5 9986.8 9998.3 10009.9 7986.4 11826.3 11932.7 12293.6 12360.6 11998.5 12063.9 12119.9 12124.9 12163.0 12038.5 12041.4 12047.3 12054.7 12059.7 11657.2 11712.1 11714.8 11726.8 11737.1 42378.6 42542.1 42590.6 42705.1 42706.0 4019.4 4023.5 4066.0 4081.4 4101.9 29071.3 29651.1 31284.8 31380.5 31708.2 3325.4 3349.0 3387.2 3418.2 3436.9 356703.0 359242.0 360110.0 360987.2 360989.0 55719.7 55895.0 55955.0 56111.0 56173.0 57849.0 57851.0 57936.0 57957.0 57977.0 15812.4 15894.3 15900.5 15917.4 15952.0 12248.8 12359.9 13280.9 13308.5 13320.7 11708.1 13266.6 13518.9 13547.9 13680.9 5810.0 5880.5 5885.5 5900.5 5913.5 953.5 977.6 986.3 1029.6 1030.8 30028.2 30154.6 30271.1 30785.2 31064.5 933.8 1060.1 1061.6 1106.6 1116.4 15659.7 15716.0 15811.0 16138.6 16143.0 434421.0 435304.0 435467.0 435718.0 436903.0 61177.0 61355.7 61392.8 61477.4 61495.8 1470.4 1483.4 1541.3 1543.5 1556.2 26923.1 27519.8 28433.0 29891.3 29906.1 47995.5 49091.5 50292.0 51029.0 51032.7 449907.0 453088.0 454179.7 455247.0 456155.0 31720.7 31909.7 31980.5 32531.0 33239.8 41739.0 41773.8 42047.0 42432.6 42828.8 28923.0 29091.8 29462.4 29640.7 30221.8 29315.7 29332.1 30085.4 30250.3 30522.1 35613.8 35805.9 35995.0 36075.5 36204.1 29317.6 29335.1 29653.1 29931.0 30669.9 22241.0 23622.5 23795.6 24025.5 24197.9 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:40494.32 Median:23141.75 stddev:107870.53 (466.1%) stddev-sans-first:108131.11 15:42:55 INFO - PROCESS | 1640 | Values: 389.1 438.5 438.7 448.9 454.5 19593.8 21703.2 22591.4 22724.7 22980.2 23494.0 23557.5 24274.6 24399.8 24738.0 5559.4 6672.3 7126.8 7197.9 7200.0 6824.7 6966.8 7042.5 7128.7 7130.5 7135.0 7139.1 7147.3 7149.2 7149.9 6954.9 7040.9 7066.6 7078.1 7131.0 6016.9 6971.1 6982.6 6986.8 7282.3 26997.3 27041.5 27124.2 27136.9 27404.2 2998.0 3005.8 3102.4 3125.3 3147.2 15838.6 16160.1 16163.8 16192.2 17208.4 2123.8 2149.7 2161.1 2182.7 2241.8 151922.0 154417.0 156052.0 157658.0 160554.0 14183.4 15963.8 19179.1 20030.6 20440.5 29269.8 30681.7 32591.5 32745.2 32745.3 10698.1 10797.3 10858.9 10867.3 11062.2 9225.5 9239.3 9257.4 9397.3 9423.3 9139.9 9373.4 9458.8 9498.2 9500.0 3405.7 3988.5 4180.4 4194.5 4206.4 1033.4 1056.8 1081.6 1094.5 1140.1 22877.4 23303.3 23393.4 23400.3 23470.5 947.4 991.2 1109.2 1155.2 1159.8 10136.3 10308.8 10971.9 11889.3 11969.3 529567.0 584069.0 590367.0 686146.0 765999.0 161468.0 161517.4 162412.0 169102.0 174778.0 1236.7 1291.9 1323.5 1329.2 1329.9 15166.0 19495.7 19749.6 21132.3 21142.8 63807.7 63975.4 64034.0 64043.4 64594.7 88269.0 88741.0 90567.0 91110.5 91319.5 11633.9 11807.5 12183.0 12183.4 12190.3 11132.6 12231.9 13079.2 13338.5 13393.9 6138.1 9727.5 11418.0 11771.9 11868.5 10579.7 10736.8 10775.8 11041.4 11097.6 7588.7 11129.6 11770.4 11793.7 11833.8 11912.4 12110.6 12170.9 12216.1 12269.1 11477.6 11503.7 11578.0 11801.7 11897.5 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6898.68 Median:2395.42 stddev:4338.65 (181.1%) stddev-sans-first:4332.52 15:42:55 INFO - PROCESS | 1640 | Values: 1595.3 1626.8 1653.2 1657.7 1669.8 10949.2 11576.3 11600.5 11615.8 11628.5 11212.5 11286.2 11559.7 11583.0 11591.9 2333.5 2386.4 2399.7 2405.2 2415.0 2327.9 2390.0 2391.2 2394.4 2410.9 2325.6 2350.7 2354.4 2407.3 2419.9 2312.5 2371.5 2375.3 2375.6 2396.4 2003.9 2357.7 2370.6 2378.4 2379.0 11146.3 11364.7 11372.4 11381.2 11384.4 5602.0 5786.5 5828.9 5835.7 5853.9 2909.4 2992.8 3413.4 3482.2 3537.2 1101.5 1257.0 1266.5 1311.6 1311.6 14188.6 14524.6 15009.3 15501.8 15913.0 4737.8 4747.5 4823.2 4921.0 4937.8 13327.9 13469.9 13471.9 13476.2 13499.5 5816.2 5823.1 5833.4 5862.7 5877.5 5130.8 5162.5 5215.6 5258.3 5322.0 4034.8 4071.1 4125.9 4144.8 4147.8 1078.4 1089.7 1096.7 1108.5 1113.6 923.6 934.8 957.8 959.7 1017.8 6675.9 6706.8 6801.1 6919.0 6929.7 997.2 1009.2 1014.4 1022.1 1035.2 4101.2 4145.5 4186.0 4233.3 4316.9 13390.7 13982.7 13983.5 13984.2 13991.2 13078.9 13620.6 13855.0 13886.5 13889.8 8604.5 10095.0 10212.5 10300.9 10355.1 5688.6 6756.3 7037.4 7142.0 7207.7 9911.4 11962.2 12447.2 12701.2 12720.8 12575.2 12590.5 12628.5 12915.7 12982.0 9167.6 9357.3 9543.3 9552.4 9571.0 10586.7 10764.7 10911.7 10916.4 10972.9 9005.6 9024.5 9072.2 9267.1 9279.4 8791.3 8833.9 8849.0 8927.8 8972.0 8278.7 8299.1 8321.5 8402.9 8405.1 5923.6 6069.1 6157.0 6186.3 6239.0 6060.1 6085.9 6129.1 6258.9 6352.0 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4600.94 Median:4955.22 stddev:1283.48 (25.9%) stddev-sans-first:1247.48 15:42:55 INFO - PROCESS | 1640 | Values: 386.2 387.8 390.2 394.0 395.7 4402.7 5160.7 5204.8 5220.3 5232.9 4768.7 5007.4 5042.8 5115.8 5128.9 4161.2 4240.3 4268.5 4290.4 4296.0 4208.4 4263.9 4269.2 4280.3 4301.8 3769.7 4011.3 4259.4 4262.8 4279.8 3886.3 3942.1 4221.5 4226.2 4290.3 3203.4 3459.7 3519.9 3952.3 3952.5 4808.0 5022.4 5030.5 5030.7 5041.1 4629.6 4845.3 4918.6 4935.9 4983.0 4880.0 4930.4 5431.5 5462.9 5500.7 3776.8 4139.6 4202.8 4372.2 4403.0 5432.7 5738.5 5741.7 5790.1 5937.6 4053.1 4474.9 4492.9 4506.9 4546.8 4395.3 4655.8 4688.6 4714.5 4730.4 4341.3 4709.8 4849.8 4937.7 5025.5 4444.6 4728.8 4850.7 5086.4 5398.6 1363.9 1567.6 1577.4 1580.6 1593.7 1012.6 1069.8 1084.7 1161.0 1211.8 4422.1 5055.9 5177.7 5179.7 5181.0 4709.7 5054.1 5294.9 5377.7 5578.6 4831.9 4941.0 4946.8 4959.0 5176.6 2577.5 2596.1 2873.1 2938.2 2961.0 5091.7 5825.2 5881.7 5906.7 5915.5 4923.5 4951.5 5051.9 5499.6 5645.8 5671.3 5840.8 5922.3 5933.8 5938.9 4899.4 5693.1 5720.8 5749.7 5769.8 5450.6 5553.7 5564.8 5639.4 5650.0 5111.8 5545.0 5712.7 5889.5 5934.4 4426.4 4745.7 4927.8 5009.0 5011.1 5123.2 5309.6 5685.0 5696.5 5696.7 4618.6 5101.7 5552.4 5580.3 5581.7 4950.6 5203.7 5540.8 5554.7 5563.1 4814.0 5281.4 5435.9 5463.8 5536.7 5190.5 5501.9 5567.6 5583.4 5585.1 4689.7 5054.8 5146.6 5354.6 5470.5 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20758.69 Median:24173.40 stddev:29474.42 (121.9%) stddev-sans-first:29518.92 15:42:55 INFO - PROCESS | 1640 | Values: 777.5 811.7 849.0 897.7 900.5 15599.2 17129.7 17156.9 17164.8 17178.6 13616.5 15627.0 15796.8 16100.8 16234.3 796.6 975.8 976.3 976.8 977.2 969.8 970.1 970.9 971.1 1000.1 1057.6 1067.5 1068.8 1088.0 1090.9 1083.5 1083.7 1084.2 1084.5 1084.6 795.8 796.1 796.2 797.4 798.0 17714.5 17935.4 18208.8 18222.5 18376.7 14630.6 14880.3 14901.5 14925.7 15238.2 11790.4 12079.0 12117.3 12286.3 12518.9 3855.2 3878.5 3936.3 4106.7 4116.6 121566.4 122072.4 122649.0 123667.0 124536.0 11301.8 11563.8 11628.9 11781.6 11826.8 19780.4 24129.4 24159.9 24160.3 24186.5 7737.5 8110.5 8191.7 8294.5 8490.2 4462.8 4602.3 4630.6 4675.5 4808.7 3545.4 3598.0 3612.0 3648.8 3654.3 579.1 586.4 591.4 594.3 594.6 684.6 688.2 704.0 729.3 740.1 10052.7 10751.0 11004.4 11317.2 11372.4 676.2 721.4 725.1 729.7 750.9 5137.0 5163.8 5246.4 5254.3 5258.4 72698.3 86222.3 99023.0 102689.0 104989.5 66708.0 69083.3 82021.4 84591.8 87010.6 77858.6 79754.0 79983.0 81656.6 82760.6 10512.5 10547.8 11014.2 11273.0 11474.0 48282.0 48611.8 48789.8 49772.8 50022.7 64186.0 64200.0 64397.7 64518.0 64901.0 13167.0 13257.9 13425.4 13561.8 13957.4 14191.3 14612.4 15431.8 15603.1 15800.2 13881.8 14318.4 14439.3 14490.4 14818.0 13499.7 14327.1 14336.2 14359.6 14362.3 13115.9 13938.9 14005.8 14119.3 14542.4 9218.6 9681.7 9697.2 9737.1 9912.3 9357.4 11333.9 11603.8 11614.8 11643.7 15:42:55 INFO - PROCESS | 1640 | -------- Summary: end -------- 15:42:55 INFO - PROCESS | 1640 | 15:42:55 INFO - TEST-INFO | 1640: exit 0 15:42:55 INFO - TEST-OK | dromaeo_css | took 1118686ms 15:42:55 INFO - TEST-START | kraken 15:42:55 INFO - operating with platform_type : mac_ 15:42:55 INFO - Initialising browser for kraken test... 15:42:55 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpOc_qo2/profile http://localhost:49241/getInfo.html) 15:42:58 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 15:42:58 INFO - PROCESS | 1651 | colorDepth:24 15:42:58 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 15:42:58 INFO - PROCESS | 1651 | __metrics 15:42:58 INFO - PROCESS | 1651 | 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" 15:42:58 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:58 INFO - TEST-INFO | 1651: exit 0 15:42:58 INFO - Browser initialized. 15:42:58 INFO - Running cycle 1/1 for kraken test... 15:42:58 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpOc_qo2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:10 INFO - PROCESS | 1653 | RSS: Main: 165036032 15:43:10 INFO - PROCESS | 1653 | 15:43:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:14 INFO - PROCESS | 1653 | RSS: Main: 216551424 15:43:14 INFO - PROCESS | 1653 | 15:43:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:43:17 INFO - PROCESS | 1653 | RSS: Main: 231874560 15:43:17 INFO - PROCESS | 1653 | 15:43:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:43:21 INFO - PROCESS | 1653 | RSS: Main: 329277440 15:43:21 INFO - PROCESS | 1653 | 15:43:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:43:24 INFO - PROCESS | 1653 | RSS: Main: 229629952 15:43:24 INFO - PROCESS | 1653 | 15:43:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:26 INFO - PROCESS | 1653 | RSS: Main: 231120896 15:43:26 INFO - PROCESS | 1653 | 15:43:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:30 INFO - PROCESS | 1653 | RSS: Main: 271151104 15:43:30 INFO - PROCESS | 1653 | 15:43:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:33 INFO - PROCESS | 1653 | RSS: Main: 272080896 15:43:33 INFO - PROCESS | 1653 | 15:43:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:43:37 INFO - PROCESS | 1653 | RSS: Main: 269811712 15:43:37 INFO - PROCESS | 1653 | 15:43:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:39 INFO - PROCESS | 1653 | RSS: Main: 246845440 15:43:39 INFO - PROCESS | 1653 | 15:43:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:42 INFO - PROCESS | 1653 | RSS: Main: 250404864 15:43:42 INFO - PROCESS | 1653 | 15:43:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:44 INFO - PROCESS | 1653 | RSS: Main: 256131072 15:43:44 INFO - PROCESS | 1653 | 15:43:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:48 INFO - PROCESS | 1653 | RSS: Main: 264945664 15:43:48 INFO - PROCESS | 1653 | 15:43:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:51 INFO - PROCESS | 1653 | RSS: Main: 266391552 15:43:51 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:43:53 INFO - PROCESS | 1653 | RSS: Main: 310755328 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | __start_tp_report 15:43:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 15:43:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 15:43:53 INFO - PROCESS | 1653 | |i|pagename|runs| 15:43:53 INFO - PROCESS | 1653 | |0;ai-astar;104;115;114;113;114;116;114;117;163;171 15:43:53 INFO - PROCESS | 1653 | |1;audio-beat-detection;151;128;134;168;109;107;107;107;126;104 15:43:53 INFO - PROCESS | 1653 | |2;audio-dft;183;186;185;183;184;182;183;184;186;184 15:43:53 INFO - PROCESS | 1653 | |3;audio-fft;80;59;61;92;60;60;76;83;99;68 15:43:53 INFO - PROCESS | 1653 | |4;audio-oscillator;85;69;87;68;69;68;103;78;67;82 15:43:53 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;86;86;86;87;86;86;86;86;87;132 15:43:53 INFO - PROCESS | 1653 | |6;imaging-darkroom;93;94;94;95;93;93;95;96;94;93 15:43:53 INFO - PROCESS | 1653 | |7;imaging-desaturate;83;85;84;84;85;83;84;83;82;82 15:43:53 INFO - PROCESS | 1653 | |8;json-parse-financial;62;61;60;60;64;64;63;63;63;64 15:43:53 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;54;54;66;63;63;58;58;56;57;57 15:43:53 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;83;84;82;83;80;78;84;85;103 15:43:53 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;134;137;141;125;133;126;139;173;158;136 15:43:53 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;161;162;160;163;160;162;161;161;159;165 15:43:53 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;63;63;63;64;64;62;65;62;62;64 15:43:53 INFO - PROCESS | 1653 | __end_tp_report 15:43:53 INFO - PROCESS | 1653 | __start_cc_report 15:43:53 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1993 15:43:53 INFO - PROCESS | 1653 | __end_cc_report 15:43:53 INFO - PROCESS | 1653 | __startTimestamp1494283433718__endTimestamp 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | ------- Summary: start ------- 15:43:53 INFO - PROCESS | 1653 | Number of tests: 14 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:124.10 Median:115.50 stddev:22.96 (19.9%) stddev-sans-first:23.17 15:43:53 INFO - PROCESS | 1653 | Values: 104.0 115.0 114.0 113.0 114.0 116.0 114.0 117.0 163.0 171.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:127.00 stddev:21.80 (17.2%) stddev-sans-first:20.84 15:43:53 INFO - PROCESS | 1653 | Values: 151.0 128.0 134.0 168.0 109.0 107.0 107.0 107.0 126.0 104.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.33 (0.7%) stddev-sans-first:1.36 15:43:53 INFO - PROCESS | 1653 | Values: 183.0 186.0 185.0 183.0 184.0 182.0 183.0 184.0 186.0 184.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.80 Median:78.00 stddev:14.50 (18.6%) stddev-sans-first:15.20 15:43:53 INFO - PROCESS | 1653 | Values: 80.0 59.0 61.0 92.0 60.0 60.0 76.0 83.0 99.0 68.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:73.50 stddev:11.80 (16.0%) stddev-sans-first:12.20 15:43:53 INFO - PROCESS | 1653 | Values: 85.0 69.0 87.0 68.0 69.0 68.0 103.0 78.0 67.0 82.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:86.00 stddev:14.48 (16.8%) stddev-sans-first:15.26 15:43:53 INFO - PROCESS | 1653 | Values: 86.0 86.0 86.0 87.0 86.0 86.0 86.0 86.0 87.0 132.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:1.05 (1.1%) stddev-sans-first:1.05 15:43:53 INFO - PROCESS | 1653 | Values: 93.0 94.0 94.0 95.0 93.0 93.0 95.0 96.0 94.0 93.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 15:43:53 INFO - PROCESS | 1653 | Values: 83.0 85.0 84.0 84.0 85.0 83.0 84.0 83.0 82.0 82.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 15:43:53 INFO - PROCESS | 1653 | Values: 62.0 61.0 60.0 60.0 64.0 64.0 63.0 63.0 63.0 64.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:4.06 (7.0%) stddev-sans-first:3.95 15:43:53 INFO - PROCESS | 1653 | Values: 54.0 54.0 66.0 63.0 63.0 58.0 58.0 56.0 57.0 57.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:6.80 (8.1%) stddev-sans-first:7.21 15:43:53 INFO - PROCESS | 1653 | Values: 85.0 83.0 84.0 82.0 83.0 80.0 78.0 84.0 85.0 103.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:138.00 stddev:14.70 (10.7%) stddev-sans-first:15.42 15:43:53 INFO - PROCESS | 1653 | Values: 134.0 137.0 141.0 125.0 133.0 126.0 139.0 173.0 158.0 136.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:1.71 (1.1%) stddev-sans-first:1.81 15:43:53 INFO - PROCESS | 1653 | Values: 161.0 162.0 160.0 163.0 160.0 162.0 161.0 161.0 159.0 165.0 15:43:53 INFO - PROCESS | 1653 | 15:43:53 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 15:43:53 INFO - PROCESS | 1653 | Values: 63.0 63.0 63.0 64.0 64.0 62.0 65.0 62.0 62.0 64.0 15:43:53 INFO - PROCESS | 1653 | -------- Summary: end -------- 15:43:53 INFO - PROCESS | 1653 | 15:43:54 INFO - TEST-INFO | 1653: exit 0 15:43:54 INFO - TEST-OK | kraken | took 58735ms 15:43:54 INFO - SUITE-END | took 1177s 15:43:54 INFO - Completed test suite (00:19:37) 15:43:54 INFO - javascript benchmark 15:43:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7929.130150908353, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3549.5208146900163, 3590.551181102362, 3602.135487483003, 3604.6034936157016, 3638.6361363863602, 5279.868003299919, 6069.423404776545, 6162.025493556654, 6236.656983865897, 6269.216347956505, 6186.536009799272, 6242.438180563749, 6261.843453913654, 6263.248410190783, 6291.402316779899, 5481.643693159942, 5504.80733174339, 5522.861928451781, 5525.557955363562, 5627.662340259598, 5384.865378365533, 5410.404855465896, 5478.150886612581, 5500.80747173849, 5611.831645050655, 5578.2748242728385, 5595.21666966625, 5597.692126933017, 5598.328200615932, 5605.579581531381, 5030.547250747451, 5591.384947655754, 5598.44015598441, 5604.8038318658655, 5606.831795046155, 5301.946980530184, 5428.212909128194, 5493.2034854945805, 5508.91736623951, 5529.253550770634, 6122.7438261917805, 6134.375358695292, 6140.8771824563255, 6169.29053158888, 6221.346758590374, 6557.803265901983, 6569.737210511574, 6580.638064906429, 6582.210134783809, 6584.078229047937, 6580.374864387875, 6610.239822420435, 6646.966765166191, 6669.733210671568, 6670.566413183127, 6059.878802424015, 6137.052516990508, 6200.224971878515, 6342.0, 6347.365263473662, 6662.400383965466, 6728.3271672832325, 6754.594724316458, 6757.797266082025, 6823.420009299265, 6474.0612611172055, 6485.0, 6496.805095847132, 6501.804945851632, 6512.902306465407, 6308.211473565804, 6396.552241343062, 6645.966770166118, 6663.933360666429, 6668.299828518033, 6400.967995159995, 6477.060826180272, 6485.513586480938, 6548.443382312462, 6561.0, 6428.903566446507, 6575.210974683068, 6583.0454584086, 6583.80248592543, 6592.43964263043, 5305.257263982969, 5327.254184414185, 5329.813456529003, 5360.383555891044, 5360.927814437128, 4615.746133962597, 4665.393498845128, 4681.765911704401, 4709.458412282563, 4744.478107408182, 6337.8732425352155, 6342.651154186564, 6346.492280617539, 6348.333424990309, 6351.523635727246, 6656.134702488645, 6656.96671516649, 6665.900011499832, 6670.999350097524, 6692.297308782605, 6124.142620033199, 6176.227971503562, 6272.435480806749, 6294.181756371734, 6342.619442833445, 5766.855828604234, 5804.158397032406, 5862.179294898718, 5891.440313170242, 5919.141724449931, 6889.965550172217, 6909.067275917687, 6911.274316196827, 6914.757983470555, 6934.4452443804375, 6561.639109849004, 6659.433948114271, 6674.466042716668, 6692.130023097161, 6721.93278067213, 6520.413162815369, 6633.502487313374, 6709.0, 6807.795766127024, 6884.173899132136, 6292.339304372975, 6556.442702370161, 6566.343365663586, 6576.013597960345, 6589.835254118685, 5353.812616558402, 6413.42279194856, 6444.001179817136, 6457.644829534421, 6641.070250164884, 6498.675066246574, 6498.772542960974, 6506.284308725942, 6509.283978762238, 6513.4463570595135, 5227.686338819683, 6273.905891411541, 6330.49356051524, 6341.936580634135, 6496.935030649633, 6326.620402775849, 6342.112104305494, 6360.872782544416, 6368.52236082305, 6373.840653983502, 6472.417482426604, 6491.0, 6491.156149700509, 6503.707333169924, 6505.934940650723, 6188.81433556994, 6231.875362492634, 6256.280527739368, 6301.873962520815, 6333.2716737575765], "value": 6069.750153158775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.5865170785337, 823.6375994562392, 839.7690635075352, 922.9030951750062, 928.6888892221106, 30694.0, 42942.0, 43240.918977025554, 43366.56633433665, 43460.78269608648, 42863.0, 43100.35349469753, 43154.0, 45040.0, 45172.0, 8076.152004039579, 9816.509174541263, 9986.750331241705, 9998.25013124015, 10009.899901001007, 7986.440949133534, 11826.29042257463, 11932.74706155854, 12293.631191064238, 12360.567380141696, 11998.460069296903, 12063.879361206407, 12119.878801211964, 12124.878751212464, 12162.966147877441, 12038.458269377856, 12041.397930103547, 12047.277163370181, 12054.698632534257, 12059.698507537294, 11657.242279251821, 11712.063034957268, 11714.824277635842, 11726.765464690743, 11737.119716021332, 42378.57621423777, 42542.14915701668, 42590.57409425897, 42705.145897081886, 42706.0, 4019.356902895552, 4023.517177938637, 4066.0241542029994, 4081.4081958115908, 4101.938470922939, 29071.273218169503, 29651.110466686034, 31284.843575781975, 31380.529292060637, 31708.207294817814, 3325.3681800457834, 3349.045522026235, 3387.220939183977, 3418.2138108234994, 3436.9312613747584, 356703.0, 359242.0, 360110.0, 360987.195064023, 360988.9999999974, 55719.721401393545, 55895.0, 55955.0, 56111.0, 56173.0, 57849.0, 57851.0, 57936.0, 57957.0, 57977.0, 15812.446564370422, 15894.284757185724, 15900.52298431049, 15917.442889498812, 15952.042877427391, 12248.81626775599, 12359.876401236052, 13280.933595332155, 13308.467661293633, 13320.666983325495, 11708.063354931584, 13266.602001939957, 13518.864811351761, 13547.86452135466, 13680.93159534196, 5810.0, 5880.500157486576, 5885.47030767233, 5900.468957793819, 5913.526917846562, 953.4755884263627, 977.6040703515088, 986.3194395866828, 1029.6190409548515, 1030.845373194027, 30028.24929376783, 30154.643041063206, 30271.091867244017, 30785.2303692405, 31064.534031989086, 933.7945651956559, 1060.1095080132725, 1061.570064124031, 1106.6292791914798, 1116.3636727065496, 15659.686806263811, 15716.0, 15810.972286801321, 16138.596535086483, 16143.0, 434421.0, 435304.0, 435467.0, 435718.0, 436903.0, 61177.0, 61355.693221533606, 61392.77214455686, 61477.38522614806, 61495.77008459895, 1470.4485817818318, 1483.3769816677238, 1541.3064121145305, 1543.4906480861289, 1556.2141118734967, 26923.057692980652, 27519.761610727965, 28433.0, 29891.252718682208, 29906.10281691553, 47995.52004479911, 49091.50908490869, 50292.0, 51029.0, 51032.74483627558, 449907.0, 453088.0, 454179.7291013524, 455247.0, 456155.0, 31720.682793172695, 31909.6809031916, 31980.520292196103, 32531.0, 33239.83380083084, 41738.95652608587, 41773.79113104415, 42047.0, 42432.5756742441, 42828.78585607052, 28923.0, 29091.83632654755, 29462.41075178527, 29640.703592963793, 30221.848890755406, 29315.70684293215, 29332.12003639894, 30085.3982920336, 30250.336231507477, 30522.08433746991, 35613.82193089018, 35805.87356893977, 35995.0, 36075.458868116475, 36204.09489762777, 29317.560236596895, 29335.119946401643, 29653.110406687832, 29931.0, 30669.926552571447, 22240.999155037738, 23622.52754944926, 23795.64306535438, 24025.51948961046, 24197.879010604833], "value": 19673.673321290655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.1069994362937, 438.4804007251406, 438.73456558781936, 448.8810465226715, 454.5091301394492, 19593.804061959378, 21703.240386586473, 22591.435214119654, 22724.65913011306, 22980.195693150745, 23494.0, 23557.528849423, 24274.635880461807, 24399.75600243997, 24738.0, 5559.444055594428, 6672.3409279877205, 7126.78619641409, 7197.89203161953, 7199.964000180018, 6824.69288881999, 6966.756163534277, 7042.507024508286, 7128.714851405964, 7130.465215108861, 7135.036770036057, 7139.071920650308, 7147.285271472837, 7149.177844547891, 7149.928500715005, 6954.930450695479, 7040.943858421252, 7066.646667666648, 7078.079849619568, 7131.0, 6016.909746353808, 6971.093757811503, 6982.581045137308, 6986.755463558751, 7282.344588987016, 26997.325066873287, 27041.45917081667, 27124.1862744116, 27136.91452341904, 27404.177874663794, 2997.985010074936, 3005.8046226995175, 3102.37952409519, 3125.343677827659, 3147.1817327494787, 15838.604034899105, 16160.111193884331, 16163.83836161635, 16192.190390480546, 17208.39770608035, 2123.7982391672767, 2149.6560550311874, 2161.135545781684, 2182.6835108909117, 2241.7758224177614, 151922.0, 154417.0, 156052.0, 157658.0, 160554.0, 14183.383164840065, 15963.840361596467, 19179.136938837786, 20030.599388012448, 20440.488987775425, 29269.829206831913, 30681.69318306833, 32591.51112733311, 32745.181370465452, 32745.34509309848, 10698.090662293793, 10797.29817561856, 10858.891411085946, 10867.29362591429, 11062.22564420483, 9225.492597907045, 9239.260859131253, 9257.398269112486, 9397.342186046912, 9423.293253005915, 9139.862902056475, 9373.390729602554, 9458.810823783624, 9498.192653624381, 9499.952500237454, 3405.6934875861293, 3988.487253030572, 4180.372944058416, 4194.475690538683, 4206.41110244566, 1033.3644808442905, 1056.8203405421098, 1081.567373050786, 1094.4746521669642, 1140.0708422635525, 22877.428064298194, 23303.300900972998, 23393.41516462102, 23400.297991060295, 23470.530589388458, 947.4078700811992, 991.1971303244395, 1109.2401704832216, 1155.1509640414288, 1159.7796418680423, 10136.341137826164, 10308.845367319496, 10971.902809719124, 11889.346085965182, 11969.341686207343, 529567.0, 584069.0, 590367.0, 686146.0, 765999.0, 161468.0, 161517.38482615259, 162412.0, 169102.0, 174778.0, 1236.715555422258, 1291.922484650924, 1323.4639970811645, 1329.2224048931485, 1329.8736620021082, 15166.0, 19495.707564386263, 19749.60500790005, 21132.260370886946, 21142.78857211408, 63807.680961594895, 63975.360246396944, 64034.0, 64043.35956640374, 64594.67702661457, 88269.0, 88741.0, 90567.0, 91110.54444727734, 91319.54340228256, 11633.941830290794, 11807.468663909973, 12183.0, 12183.390830458264, 12190.329531875832, 11132.554697811996, 12231.87768122343, 13079.215247085205, 13338.533151339656, 13393.866061339651, 6138.07928810682, 9727.464989425649, 11418.029467495357, 11771.941140294586, 11868.525258989544, 10579.735506612396, 10736.838947415952, 10775.838362424412, 11041.39272339997, 11097.556097756, 7588.658510366937, 11129.554817807197, 11770.411479425824, 11793.705157371134, 11833.763324733629, 11912.404379780803, 12110.636680899586, 12170.904618584369, 12216.083793715328, 12269.141160118706, 11477.598284060017, 11503.654890353302, 11578.0, 11801.704957376134, 11897.524099036287], "value": 11838.936801364105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1595.2900959073218, 1626.7641192027156, 1653.1816750708397, 1657.6601796631692, 1669.8163202047776, 10949.233553651238, 11576.305421674706, 11600.477978490968, 11615.825762613567, 11628.534858605657, 11212.495437705302, 11286.153538484605, 11559.711007224823, 11583.0, 11591.884081159185, 2333.5099629077913, 2386.4033991502124, 2399.6640470334078, 2405.218304051182, 2415.0, 2327.94180145496, 2389.976100238993, 2391.234804862445, 2394.38943069517, 2410.915617953372, 2325.6046472099783, 2350.71791385034, 2354.446705024318, 2407.325948734357, 2419.9395015124674, 2312.5143719818857, 2371.490129622131, 2375.2874137758604, 2375.6199008158783, 2396.4488167721347, 2003.869748466345, 2357.728861180969, 2370.561446132471, 2378.4410663494064, 2378.988929704886, 11146.275492092987, 11364.715882102932, 11372.431378431045, 11381.2033157679, 11384.430778461045, 5601.971990140064, 5786.537077033827, 5828.912566311508, 5835.737391817378, 5853.941460585383, 2909.3599408130176, 2992.8054676446177, 3413.368526822546, 3482.1990942083207, 3537.1510837399096, 1101.4657890922897, 1256.9622911312674, 1266.5440441441074, 1311.5606271898926, 1311.61307414313, 14188.57434276963, 14524.564263072125, 15009.324580393908, 15501.844981550154, 15913.0, 4737.786799593958, 4747.525247475225, 4823.204171311764, 4920.975395123001, 4937.827176048893, 13327.933360333136, 13469.932650336686, 13471.865281347062, 13476.191428514321, 13499.527516536875, 5816.1566572846705, 5823.126531020381, 5833.445822646841, 5862.70686465675, 5877.500412464989, 5130.79476820923, 5162.5095615916425, 5215.55667768244, 5258.316418865523, 5322.0154271459905, 4034.8386064557676, 4071.1043570414463, 4125.876223713293, 4144.8134833932545, 4147.81334839933, 1078.358376765823, 1089.6567581211893, 1096.681962230944, 1108.4956344863067, 1113.6436340371004, 923.5797712041006, 934.7663084228943, 957.7701351675547, 959.6689142245914, 1017.8218811708069, 6675.899861502081, 6706.765263215764, 6801.149856267966, 6919.0, 6929.653517324114, 997.187292356727, 1009.2380252909154, 1014.4319181258519, 1022.1311884897926, 1035.233926894108, 4101.179764047143, 4145.461090058273, 4186.016286172747, 4233.280342341748, 4316.935245971313, 13390.665233369244, 13982.720345593234, 13983.510577129751, 13984.230867302396, 13991.23048232357, 13078.869211307956, 13620.591382258548, 13855.03014788955, 13886.513972010931, 13889.79165312521, 8604.526751028754, 10095.0, 10212.489375531342, 10300.896991030144, 10355.068043876086, 5688.63023903445, 6756.290589488033, 7037.401820845081, 7142.035825163536, 7207.73864573708, 9911.405315680793, 11962.222455540363, 12447.190932589352, 12701.237925724487, 12720.809187862375, 12575.245485270912, 12590.496380144692, 12628.494860205488, 12915.677108071997, 12982.026348023746, 9167.587458564247, 9357.298202634693, 9543.28425368114, 9552.42685438876, 9571.042895710652, 10586.735331616772, 10764.677059688222, 10911.727206819893, 10916.399598022184, 10972.890271097505, 9005.594748236475, 9024.458532488072, 9072.228860546664, 9267.119623635745, 9279.443233406017, 8791.296696264155, 8833.911660883308, 8849.026607073345, 8927.821443571222, 8971.955140224258, 8278.668853245803, 8299.128591498047, 8321.459105158388, 8402.87395689053, 8405.117462666576, 5923.555733319932, 6069.084577262575, 6157.0, 6186.319504854372, 6238.986426784944, 6060.060690592965, 6085.908711369421, 6129.111278864629, 6258.874822503433, 6352.047192921099], "value": 5242.220376770909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.18129565321516, 387.78477944740655, 390.16115351993227, 393.986210482633, 395.7229939042669, 4402.669799765018, 5160.741962901859, 5204.843854684356, 5220.26916231727, 5232.895342093156, 4768.690035147713, 5007.424146223177, 5042.755973591753, 5115.800205911457, 5128.871778205546, 4161.230172418097, 4240.279152544075, 4268.463353192848, 4290.399344091829, 4296.0, 4208.421841809321, 4263.850765223217, 4269.188854117708, 4280.250956082688, 4301.827926882921, 3769.6795772359383, 4011.313452091494, 4259.360146343664, 4262.829486820523, 4279.75312960695, 3886.300465916148, 3942.107788261636, 4221.501367014727, 4226.23181815908, 4290.313549832012, 3203.3593281343824, 3459.7405194610506, 3519.944016794977, 3952.32810422226, 3952.505936757905, 4807.951920480786, 5022.397312322508, 5030.471800460936, 5030.723310217936, 5041.110123180509, 4629.564834901192, 4845.27320901864, 4918.581920536759, 4935.925961110586, 4982.975085124587, 4879.999200327884, 4930.359053323081, 5431.511163995259, 5462.918056229159, 5500.734830988855, 3776.848926042955, 4139.606737359946, 4202.789860506962, 4372.1692878353015, 4402.955970440319, 5432.728363581805, 5738.512226460756, 5741.741621627037, 5790.131480277992, 5937.614055086406, 4053.148838743838, 4474.919162589412, 4492.910141797146, 4506.932396014063, 4546.795394207203, 4395.296752519582, 4655.837045703452, 4688.578027977498, 4714.457837348748, 4730.385049943486, 4341.305391137403, 4709.762862640218, 4849.830255941025, 4937.654364194472, 5025.497450254945, 4444.577765112309, 4728.784426589952, 4850.708957462563, 5086.415062267813, 5398.597624057257, 1363.863613638648, 1567.6159340961538, 1577.3532851531047, 1580.6127498762876, 1593.7450007998664, 1012.5747186181821, 1069.8395240713799, 1084.728817795551, 1161.0305394995105, 1211.7818792617413, 4422.071365013319, 5055.8988820223385, 5177.741112944338, 5179.689218646893, 5180.9740951295, 4709.67032307742, 5054.137200847, 5294.9410117975785, 5377.7311134443125, 5578.577462746974, 4831.879203019953, 4941.022476906053, 4946.802127914843, 4958.975205123951, 5176.637635365489, 2577.4716183182404, 2596.091368021215, 2873.080614203435, 2938.180365524809, 2960.955585666217, 5091.741285577234, 5825.1941898011755, 5881.676507792027, 5906.725910524393, 5915.526757859361, 4923.547553471734, 4951.455339912607, 5051.857476868932, 5499.615026948155, 5645.830625081254, 5671.319441667027, 5840.8026354597205, 5922.2597175353085, 5933.842900634508, 5938.851528711817, 4899.387576552931, 5693.100226344967, 5720.8283751487525, 5749.655020698771, 5769.769209231584, 5450.618456707993, 5553.745767564101, 5564.801903248275, 5639.407862174577, 5649.971750141223, 5111.769970351417, 5544.972275138599, 5712.71573794247, 5889.49939255151, 5934.43622855828, 4426.3803067569925, 4745.691530050535, 4927.753612319441, 5008.974955125201, 5011.072951503984, 5123.180291153398, 5309.575233981195, 5684.971575142098, 5696.515796157373, 5696.715164241688, 4618.56123668251, 5101.69389836611, 5552.444755524415, 5580.274564306615, 5581.711498285846, 4950.579200767831, 5203.661761985459, 5540.778368865362, 5554.666719996813, 5563.108543095367, 4814.0, 5281.366236051698, 5435.918461223006, 5463.825277565343, 5536.667799932017, 5190.506901844319, 5501.899620076081, 5567.582431317586, 5583.385827559046, 5585.134304182858, 4689.718616882998, 5054.775898604602, 5146.614003949644, 5354.598405119709, 5470.452954704498], "value": 4225.290304086565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.4829738224081, 811.7443005453285, 848.9939421785189, 897.7441429192681, 900.5182227508283, 15599.220038998048, 17129.65740685187, 17156.914215428922, 17164.82835171648, 17178.570535736613, 13616.523421680244, 15627.0, 15796.842031579681, 16100.75848862268, 16234.269457874394, 796.5857753967919, 975.790205105902, 976.2921881635792, 976.8192884316425, 977.1645243316968, 969.8205831921082, 970.0687340153426, 970.873786407766, 971.1065819446092, 1000.1298869983088, 1057.5981127171665, 1067.5356220044305, 1068.7808999155193, 1087.983680244797, 1090.8581884355024, 1083.5449111373202, 1083.6748975307455, 1084.2464487181412, 1084.5499117866116, 1084.614961688605, 795.7970717467009, 796.1441450440799, 796.1680044353665, 797.4059325802257, 798.0064819300009, 17714.468565942912, 17935.3722619709, 18208.817911820977, 18222.453326400228, 18376.724349134773, 14630.634234144125, 14880.330385132695, 14901.478448254367, 14925.70148597022, 15238.161901095435, 11790.364809745473, 12079.0, 12117.33354665493, 12286.324252166127, 12518.937405312916, 3855.1904100139004, 3878.534575850916, 3936.3308237599676, 4106.7125301228925, 4116.629503344683, 121566.3921680386, 122072.38963805213, 122649.0, 123667.0, 124536.0, 11301.830472542919, 11563.76872462546, 11628.94185529067, 11781.587644432575, 11826.76346473083, 19780.40658780239, 24129.396765081012, 24159.879200603886, 24160.275191744277, 24186.516269674506, 7737.535747855034, 8110.46758157607, 8191.672333106728, 8294.502329860228, 8490.23587877094, 4462.776861156929, 4602.33953089817, 4630.629549636021, 4675.485696573374, 4808.663393562417, 3545.3972824619877, 3598.0, 3612.0, 3648.8175591220865, 3654.2874139543064, 579.1341943794055, 586.3696526234315, 591.3642833953517, 594.2779522879722, 594.6194435561245, 684.5960883079007, 688.2498077095989, 704.0143798681784, 729.2925861913935, 740.1229542991572, 10052.74868128288, 10751.0, 11004.449777511092, 11317.207795454238, 11372.431378431045, 676.1750664189681, 721.3832173491589, 725.1008749151121, 729.6661405128527, 750.9249075092556, 5137.0, 5163.8192663256605, 5246.449122842047, 5254.264402983586, 5258.395284542326, 72698.27301727021, 86222.27555448856, 99023.0, 102689.0, 104989.47505262577, 66708.0, 69083.30916690869, 82021.35957280821, 84591.77041148041, 87010.56494717486, 77858.61070694723, 79754.01844861658, 79983.0, 81656.59171704104, 82760.58619706983, 10512.474376281003, 10547.787004494581, 11014.173936954921, 11272.985431311221, 11474.0, 48282.03435931192, 48611.75694121507, 48789.75605121952, 49772.751136244086, 50022.749886250334, 64186.0, 64200.0, 64397.67801160964, 64518.0, 64901.0, 13167.0, 13257.86742132605, 13425.395857186255, 13561.79657305161, 13957.371918263905, 14191.290435478391, 14612.415503379745, 15431.768523472381, 15603.063816171067, 15800.209989500709, 13881.791773123614, 14318.427262909367, 14439.278036097943, 14490.420383184555, 14817.989713328523, 13499.730005400033, 14327.140371577738, 14336.211508366723, 14359.641008974859, 14362.281885905453, 13115.934420327838, 13938.860611393757, 14005.759078547384, 14119.308856150847, 14542.41830326775, 9218.585163667785, 9681.70954871355, 9697.224222062077, 9737.07497787709, 9912.306138570231, 9357.39176953496, 11333.943330283295, 11603.767924641628, 11614.825777613512, 11643.650690479299], "value": 7935.4298075872475, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1422.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 113.0, 114.0, 116.0, 114.0, 117.0, 163.0, 171.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 134.0, 168.0, 109.0, 107.0, 107.0, 107.0, 126.0, 104.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 185.0, 183.0, 184.0, 182.0, 183.0, 184.0, 186.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 92.0, 60.0, 60.0, 76.0, 83.0, 99.0, 68.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 87.0, 68.0, 69.0, 68.0, 103.0, 78.0, 67.0, 82.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 87.0, 132.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 93.0, 93.0, 95.0, 96.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 84.0, 85.0, 83.0, 84.0, 83.0, 82.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 66.0, 63.0, 63.0, 58.0, 58.0, 56.0, 57.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 82.0, 83.0, 80.0, 78.0, 84.0, 85.0, 103.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 141.0, 125.0, 133.0, 126.0, 139.0, 173.0, 158.0, 136.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 163.0, 160.0, 162.0, 161.0, 161.0, 159.0, 165.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 62.0, 65.0, 62.0, 62.0, 64.0], "value": 63.2, "unit": "score"}]}]} 15:43:54 INFO - Return code: 0 15:43:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:43:55 INFO - # TBPL SUCCESS # 15:43:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:55 INFO - 2017-05-08 15:43:55.054 screenresolution[1657:10192] starting screenresolution argv=screenresolution get 15:43:55 INFO - 2017-05-08 15:43:55.056 screenresolution[1657:10192] Display 0: 1600x1200x32@60 15:43:55 INFO - 2017-05-08 15:43:55.062 screenresolution[1658:10195] starting screenresolution argv=screenresolution list 15:43:55 INFO - Available Modes on Display 0 15:43:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:55 INFO - Intel Iris: 15:43:55 INFO - Chipset Model: Intel Iris 15:43:55 INFO - Type: GPU 15:43:55 INFO - Bus: Built-In 15:43:55 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:55 INFO - Vendor: Intel (0x8086) 15:43:55 INFO - Device ID: 0x0a2e 15:43:55 INFO - Revision ID: 0x0009 15:43:55 INFO - Displays: 15:43:55 INFO - Display: 15:43:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:55 INFO - Display Serial Number: 1600x1200 60 15:43:55 INFO - Main Display: Yes 15:43:55 INFO - Mirror: Off 15:43:55 INFO - Online: Yes 15:43:55 INFO - Rotation: Supported 15:43:55 INFO - Return code: 0 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - [mozharness: 2017-05-08 22:43:55.305541Z] Finished run-tests step (success) 15:43:55 INFO - Running post-run listener: _resource_record_post_run 15:43:55 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 39482368; Write bytes: 424929280; Read time: 256; Write time: 1386 15:43:55 INFO - TinderboxPrint: CPU usage
53.7% 15:43:55 INFO - TinderboxPrint: I/O read bytes / time
39,482,368 / 256 15:43:55 INFO - TinderboxPrint: I/O write bytes / time
424,929,280 / 1,386 15:43:55 INFO - TinderboxPrint: CPU idle
2,209.1 (46.3%) 15:43:55 INFO - TinderboxPrint: CPU system
946.2 (19.8%) 15:43:55 INFO - TinderboxPrint: CPU user
1,618.4 (33.9%) 15:43:55 INFO - TinderboxPrint: Swap in / out
160,542,720 / 0 15:43:55 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121807360; Write bytes: 115636224; Read time: 11073; Write time: 250 15:43:55 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36144128; Write bytes: 299147264; Read time: 231; Write time: 1101 15:43:55 INFO - Running post-run listener: _upload_blobber_files 15:43:55 INFO - Blob upload gear active. 15:43:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:43:55 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 15:43:55 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:43:55 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:43:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:43:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:43:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:43:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:57 INFO - (blobuploader) - INFO - Done attempting. 15:43:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:43:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:59 INFO - (blobuploader) - INFO - Done attempting. 15:43:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:43:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:00 INFO - (blobuploader) - INFO - Done attempting. 15:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:02 INFO - (blobuploader) - INFO - Done attempting. 15:44:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:02 INFO - Return code: 0 15:44:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92c2718cdd81e332b1c3892430a467533652a137cbdd272e78b275679ea8416c80644445b0f24b6c3d56d9e7a5e03d821ac10296319754fba71fbb09b7c1bfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e838e11111bbeb35497581bd04a4b06adac4f561bc0b81eb380081f0088c6ddd85ed925bc7a288bfa9586a98799daebaff1adffbdd6e6f222500f0104eab95f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9815949601349eda05ef421f85d03ff1fe156e89a6b2199e616af3843c34a620b548c19d5c0bf9f896f39bfa5d46424979379b82ae3a074b2c9ff76d4046dd17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b981caea7c8ce0e437537e3a5e136a72dd6d94e4320259b08f4e14e5e0a21f60a00a92702c4a9966e4e672d0a8cc0cacff18af7a89fdfe6a57780701b57e99ba"} 15:44:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:02 INFO - Contents: 15:44:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92c2718cdd81e332b1c3892430a467533652a137cbdd272e78b275679ea8416c80644445b0f24b6c3d56d9e7a5e03d821ac10296319754fba71fbb09b7c1bfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e838e11111bbeb35497581bd04a4b06adac4f561bc0b81eb380081f0088c6ddd85ed925bc7a288bfa9586a98799daebaff1adffbdd6e6f222500f0104eab95f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9815949601349eda05ef421f85d03ff1fe156e89a6b2199e616af3843c34a620b548c19d5c0bf9f896f39bfa5d46424979379b82ae3a074b2c9ff76d4046dd17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b981caea7c8ce0e437537e3a5e136a72dd6d94e4320259b08f4e14e5e0a21f60a00a92702c4a9966e4e672d0a8cc0cacff18af7a89fdfe6a57780701b57e99ba"} 15:44:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:02 INFO - Copying logs to upload dir... 15:44:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.279137 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-08 15:44:02.534247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:02.538462) ========= 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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-Beta/sha512/92c2718cdd81e332b1c3892430a467533652a137cbdd272e78b275679ea8416c80644445b0f24b6c3d56d9e7a5e03d821ac10296319754fba71fbb09b7c1bfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e838e11111bbeb35497581bd04a4b06adac4f561bc0b81eb380081f0088c6ddd85ed925bc7a288bfa9586a98799daebaff1adffbdd6e6f222500f0104eab95f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9815949601349eda05ef421f85d03ff1fe156e89a6b2199e616af3843c34a620b548c19d5c0bf9f896f39bfa5d46424979379b82ae3a074b2c9ff76d4046dd17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b981caea7c8ce0e437537e3a5e136a72dd6d94e4320259b08f4e14e5e0a21f60a00a92702c4a9966e4e672d0a8cc0cacff18af7a89fdfe6a57780701b57e99ba"} build_url:https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011577 build_url: 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92c2718cdd81e332b1c3892430a467533652a137cbdd272e78b275679ea8416c80644445b0f24b6c3d56d9e7a5e03d821ac10296319754fba71fbb09b7c1bfda", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e838e11111bbeb35497581bd04a4b06adac4f561bc0b81eb380081f0088c6ddd85ed925bc7a288bfa9586a98799daebaff1adffbdd6e6f222500f0104eab95f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9815949601349eda05ef421f85d03ff1fe156e89a6b2199e616af3843c34a620b548c19d5c0bf9f896f39bfa5d46424979379b82ae3a074b2c9ff76d4046dd17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b981caea7c8ce0e437537e3a5e136a72dd6d94e4320259b08f4e14e5e0a21f60a00a92702c4a9966e4e672d0a8cc0cacff18af7a89fdfe6a57780701b57e99ba"}' ========= master_lag: 0.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:03.445218) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-05-08 15:44:03.445714) ========= 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.4hxlTKyuqk/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.ZAjAm6YDTK/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.004905 ========= master_lag: 4.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-05-08 15:44:08.059843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:44:08.064753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:44:08.091298) ========= ========= Total master_lag: 6.45 =========