builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1482396872.31 results: success (0) buildid: 20161221224352 builduid: 83443e2ff80245bf98347182a8f0aca3 revision: 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.305896) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.306703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.307297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.333784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.334477) ========= 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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 --2016-12-22 00:54:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.34M=0.001s 2016-12-22 00:54:32 (8.34 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.308270 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.672497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.672924) ========= 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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.021943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:32.726821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 00:54:32.727217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 --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 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 2016-12-22 00:54:32,812 truncating revision to first 12 chars 2016-12-22 00:54:32,812 Setting DEBUG logging. 2016-12-22 00:54:32,812 attempt 1/10 2016-12-22 00:54:32,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9fc3b4f4d2f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 00:54:34,201 unpacking tar archive at: mozilla-beta-9fc3b4f4d2f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.680233 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 00:54:34.433952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:34.434667) ========= script_repo_revision: 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:34.435459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:34.436056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 00:54:34.457021) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-22 00:54:34.457358) ========= /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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:54:34 INFO - MultiFileLogger online at 20161222 00:54:34 in /builds/slave/test 00:54:34 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 00:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:54:34 INFO - {'append_to_log': False, 00:54:34 INFO - 'base_work_dir': '/builds/slave/test', 00:54:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:54:34 INFO - 'branch': 'Mozilla-Beta', 00:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:34 INFO - 'config_files': ('talos/mac_config.py',), 00:54:34 INFO - 'default_actions': ('clobber', 00:54:34 INFO - 'read-buildbot-config', 00:54:34 INFO - 'download-and-extract', 00:54:34 INFO - 'populate-webroot', 00:54:34 INFO - 'create-virtualenv', 00:54:34 INFO - 'install', 00:54:34 INFO - 'run-tests'), 00:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:34 INFO - 'download_minidump_stackwalk': True, 00:54:34 INFO - 'download_symbols': 'ondemand', 00:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 00:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 00:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:34 INFO - 'installer_path': 'installer.exe', 00:54:34 INFO - 'log_level': 'info', 00:54:34 INFO - 'log_name': 'talos', 00:54:34 INFO - 'log_to_console': True, 00:54:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:54:34 INFO - 'opt_config_files': (), 00:54:34 INFO - 'pip_index': False, 00:54:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:54:34 INFO - 'cmd': ('bash', 00:54:34 INFO - '-c', 00:54:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:54:34 INFO - 'enabled': True, 00:54:34 INFO - 'halt_on_failure': False, 00:54:34 INFO - 'name': 'check_screen_resolution'},), 00:54:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:54:34 INFO - 'cmd': ('bash', 00:54:34 INFO - '-c', 00:54:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:54:34 INFO - 'enabled': True, 00:54:34 INFO - 'halt_on_failure': False, 00:54:34 INFO - 'name': 'check_screen_resolution'},), 00:54:34 INFO - 'run_cmd_checks_enabled': True, 00:54:34 INFO - 'sps_profile': False, 00:54:34 INFO - 'sps_profile_interval': 0, 00:54:34 INFO - 'suite': 'dromaeojs', 00:54:34 INFO - 'system_bits': '32', 00:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:34 INFO - 'title': 't-yosemite-r7-0022', 00:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:34 INFO - 'use_talos_json': True, 00:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:34 INFO - 'work_dir': 'build'} 00:54:34 INFO - [mozharness: 2016-12-22 08:54:34.652565Z] Running clobber step. 00:54:34 INFO - Running pre-action listener: _resource_record_pre_action 00:54:34 INFO - Running main action method: clobber 00:54:34 INFO - rmtree: /builds/slave/test/build 00:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:54:35 INFO - Running post-action listener: _resource_record_post_action 00:54:35 INFO - [mozharness: 2016-12-22 08:54:35.662417Z] Finished clobber step (success) 00:54:35 INFO - [mozharness: 2016-12-22 08:54:35.662676Z] Running read-buildbot-config step. 00:54:35 INFO - Running pre-action listener: _resource_record_pre_action 00:54:35 INFO - Running main action method: read_buildbot_config 00:54:35 INFO - Using buildbot properties: 00:54:35 INFO - { 00:54:35 INFO - "project": "", 00:54:35 INFO - "product": "firefox", 00:54:35 INFO - "script_repo_revision": "production", 00:54:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 00:54:35 INFO - "repository": "", 00:54:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 00:54:35 INFO - "buildid": "20161221224352", 00:54:35 INFO - "pgo_build": "False", 00:54:35 INFO - "basedir": "/builds/slave/test", 00:54:35 INFO - "buildnumber": 12, 00:54:35 INFO - "slavename": "t-yosemite-r7-0022", 00:54:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:54:35 INFO - "platform": "yosemite_r7", 00:54:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:54:35 INFO - "branch": "mozilla-beta", 00:54:35 INFO - "repo_path": "releases/mozilla-beta", 00:54:35 INFO - "revision": "9fc3b4f4d2f111a0726e58c8aa56738dc8872449", 00:54:35 INFO - "stage_platform": "macosx64", 00:54:35 INFO - "builduid": "83443e2ff80245bf98347182a8f0aca3", 00:54:35 INFO - "slavebuilddir": "test" 00:54:35 INFO - } 00:54:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 00:54:35 INFO - Running post-action listener: _resource_record_post_action 00:54:35 INFO - [mozharness: 2016-12-22 08:54:35.668174Z] Finished read-buildbot-config step (success) 00:54:35 INFO - [mozharness: 2016-12-22 08:54:35.668367Z] Running download-and-extract step. 00:54:35 INFO - Running pre-action listener: _resource_record_pre_action 00:54:35 INFO - Running main action method: download_and_extract 00:54:35 INFO - mkdir: /builds/slave/test/build/tests 00:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:35 INFO - trying https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 00:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 00:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 00:54:36 INFO - Downloaded 1165 bytes. 00:54:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 00:54:36 INFO - Using the following test package requirements: 00:54:36 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 00:54:36 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 00:54:36 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 00:54:36 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:54:36 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 00:54:36 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 00:54:36 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 00:54:36 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 00:54:36 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 00:54:36 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:54:36 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 00:54:36 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 00:54:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 00:54:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 00:54:36 INFO - Fetch https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 00:54:37 INFO - Expected file size: 16232602 00:54:44 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:54:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 00:54:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 00:54:44 INFO - Fetch https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 00:54:45 INFO - Expected file size: 16232602 00:54:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 00:54:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 00:54:51 INFO - Fetch https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 00:54:52 INFO - Expected file size: 14414089 00:54:53 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')]} 00:54:53 INFO - trying https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 00:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 00:54:56 INFO - Downloaded 86049515 bytes. 00:54:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:54:56 INFO - mkdir: /builds/slave/test/properties 00:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:54:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:54:56 INFO - Contents: 00:54:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:54:56 INFO - Running post-action listener: _resource_record_post_action 00:54:56 INFO - Running post-action listener: set_extra_try_arguments 00:54:56 INFO - [mozharness: 2016-12-22 08:54:56.926858Z] Finished download-and-extract step (success) 00:54:56 INFO - [mozharness: 2016-12-22 08:54:56.926995Z] Running populate-webroot step. 00:54:56 INFO - Running pre-action listener: _resource_record_pre_action 00:54:56 INFO - Running main action method: populate_webroot 00:54:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:54:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:54:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:54:56 INFO - '--tppagecycles', 00:54:56 INFO - '7'], 00:54:56 INFO - 'tests': ['tsvgm']}}, 00:54:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:54:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:54:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:54:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:54:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['damp', 'tps']}, 00:54:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'tests': ['damp', 'tps']}, 00:54:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['dromaeo_dom']}, 00:54:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:54:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['basic_compositor_video']}, 00:54:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:54:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'other-e10s': {'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['a11yr', 00:54:56 INFO - 'ts_paint', 00:54:56 INFO - 'tpaint', 00:54:56 INFO - 'sessionrestore', 00:54:56 INFO - 'sessionrestore_no_auto_restore', 00:54:56 INFO - 'tabpaint']}, 00:54:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['tsvgx', 00:54:56 INFO - 'tsvgr_opacity', 00:54:56 INFO - 'tart', 00:54:56 INFO - 'tscrollx', 00:54:56 INFO - 'cart']}, 00:54:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:54:56 INFO - 'tsvgr_opacity', 00:54:56 INFO - 'tart', 00:54:56 INFO - 'tscrollx', 00:54:56 INFO - 'cart']}, 00:54:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'talos_options': ['--disable-e10s'], 00:54:56 INFO - 'tests': ['tp5o']}, 00:54:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'tests': ['tp5o']}, 00:54:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'talos_options': ['--disable-e10s', 00:54:56 INFO - '--xperf_path', 00:54:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:56 INFO - 'tests': ['tp5n']}, 00:54:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:54:56 INFO - 'talos_options': ['--xperf_path', 00:54:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:56 INFO - 'tests': ['tp5n']}}, 00:54:56 INFO - 'talos.zip': {'path': '', 00:54:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:54:56 INFO - Running post-action listener: _resource_record_post_action 00:54:56 INFO - [mozharness: 2016-12-22 08:54:56.945572Z] Finished populate-webroot step (success) 00:54:56 INFO - [mozharness: 2016-12-22 08:54:56.945704Z] Running create-virtualenv step. 00:54:56 INFO - Running pre-action listener: _resource_record_pre_action 00:54:56 INFO - Running main action method: create_virtualenv 00:54:56 INFO - Creating virtualenv /builds/slave/test/build/venv 00:54:56 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 00:54:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:54:57 INFO - Using real prefix '/tools/python27' 00:54:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:54:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:55:00 INFO - Installing pip.................done. 00:55:00 INFO - Return code: 0 00:55:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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')]} 00:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:00 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:00 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 00:55:00 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 00:55:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:00 INFO - 'HOME': '/Users/cltbld', 00:55:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:00 INFO - 'LOGNAME': 'cltbld', 00:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:00 INFO - 'MOZ_NO_REMOTE': '1', 00:55:00 INFO - 'NO_EM_RESTART': '1', 00:55:00 INFO - 'PAGER': '/bin/cat', 00:55:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:00 INFO - 'PWD': '/builds/slave/test', 00:55:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:00 INFO - 'SHELL': '/bin/bash', 00:55:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:00 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:00 INFO - 'USER': 'cltbld', 00:55:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:00 INFO - 'XPC_FLAGS': '0x0', 00:55:00 INFO - 'XPC_SERVICE_NAME': '0', 00:55:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:01 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 00:55:01 INFO - Cleaning up... 00:55:01 INFO - Return code: 0 00:55:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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')]} 00:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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', '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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 00:55: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 psutil>=3.1.1 00:55:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:01 INFO - 'HOME': '/Users/cltbld', 00:55:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:01 INFO - 'LOGNAME': 'cltbld', 00:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:01 INFO - 'MOZ_NO_REMOTE': '1', 00:55:01 INFO - 'NO_EM_RESTART': '1', 00:55:01 INFO - 'PAGER': '/bin/cat', 00:55:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:01 INFO - 'PWD': '/builds/slave/test', 00:55:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:01 INFO - 'SHELL': '/bin/bash', 00:55:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:01 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:01 INFO - 'USER': 'cltbld', 00:55:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:01 INFO - 'XPC_FLAGS': '0x0', 00:55:01 INFO - 'XPC_SERVICE_NAME': '0', 00:55:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:01 INFO - Downloading/unpacking psutil>=3.1.1 00:55:01 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 00:55:01 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 00:55:01 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 00:55:01 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 00:55:01 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 00:55:01 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 00:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:55:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:04 INFO - Installing collected packages: psutil 00:55:04 INFO - Running setup.py install for psutil 00:55:04 INFO - building 'psutil._psutil_osx' extension 00:55:04 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 00:55:04 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 00:55:04 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 00:55:05 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 00:55:05 INFO - building 'psutil._psutil_posix' extension 00:55:05 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 00:55:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:55:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:55:05 INFO - ^ 00:55:05 INFO - 1 warning generated. 00:55:05 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 00:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:05 INFO - Successfully installed psutil 00:55:05 INFO - Cleaning up... 00:55:05 INFO - Return code: 0 00:55:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:55:05 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')]} 00:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:05 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')]} 00:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:05 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:05 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 00:55:05 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 00:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:05 INFO - 'HOME': '/Users/cltbld', 00:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:05 INFO - 'LOGNAME': 'cltbld', 00:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:05 INFO - 'MOZ_NO_REMOTE': '1', 00:55:05 INFO - 'NO_EM_RESTART': '1', 00:55:05 INFO - 'PAGER': '/bin/cat', 00:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:05 INFO - 'PWD': '/builds/slave/test', 00:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:05 INFO - 'SHELL': '/bin/bash', 00:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:05 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:05 INFO - 'USER': 'cltbld', 00:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:05 INFO - 'XPC_FLAGS': '0x0', 00:55:05 INFO - 'XPC_SERVICE_NAME': '0', 00:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:55:05 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 00:55:05 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 00:55:05 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 00:55:05 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 00:55:05 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 00:55:05 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 00:55:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:55:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:55:08 INFO - Installing collected packages: mozsystemmonitor 00:55:08 INFO - Running setup.py install for mozsystemmonitor 00:55:08 INFO - Successfully installed mozsystemmonitor 00:55:08 INFO - Cleaning up... 00:55:08 INFO - Return code: 0 00:55:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:55:08 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')]} 00:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:08 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')]} 00:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:08 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:08 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 00:55:08 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 00:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:08 INFO - 'HOME': '/Users/cltbld', 00:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:08 INFO - 'LOGNAME': 'cltbld', 00:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:08 INFO - 'MOZ_NO_REMOTE': '1', 00:55:08 INFO - 'NO_EM_RESTART': '1', 00:55:08 INFO - 'PAGER': '/bin/cat', 00:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:08 INFO - 'PWD': '/builds/slave/test', 00:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:08 INFO - 'SHELL': '/bin/bash', 00:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:08 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:08 INFO - 'USER': 'cltbld', 00:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:08 INFO - 'XPC_FLAGS': '0x0', 00:55:08 INFO - 'XPC_SERVICE_NAME': '0', 00:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:08 INFO - Downloading/unpacking jsonschema==2.5.1 00:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:55:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:55:11 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 00:55:11 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 00:55:11 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 00:55:11 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 00:55:11 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 00:55:11 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 00:55:11 INFO - Downloading functools32-3.2.3-2.tar.gz 00:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:55:11 INFO - warning: no files found matching '*.txt' 00:55:11 INFO - no previously-included directories found matching 'build' 00:55:11 INFO - no previously-included directories found matching 'dist' 00:55:11 INFO - no previously-included directories found matching '.git*' 00:55:11 INFO - Installing collected packages: jsonschema, functools32 00:55:12 INFO - Running setup.py install for functools32 00:55:12 INFO - warning: no files found matching '*.txt' 00:55:12 INFO - no previously-included directories found matching 'build' 00:55:12 INFO - no previously-included directories found matching 'dist' 00:55:12 INFO - no previously-included directories found matching '.git*' 00:55:12 INFO - Successfully installed jsonschema functools32 00:55:12 INFO - Cleaning up... 00:55:12 INFO - Return code: 0 00:55:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:12 INFO - 'HOME': '/Users/cltbld', 00:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:12 INFO - 'LOGNAME': 'cltbld', 00:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:12 INFO - 'MOZ_NO_REMOTE': '1', 00:55:12 INFO - 'NO_EM_RESTART': '1', 00:55:12 INFO - 'PAGER': '/bin/cat', 00:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:12 INFO - 'PWD': '/builds/slave/test', 00:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:12 INFO - 'SHELL': '/bin/bash', 00:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:12 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:12 INFO - 'USER': 'cltbld', 00:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:12 INFO - 'XPC_FLAGS': '0x0', 00:55:12 INFO - 'XPC_SERVICE_NAME': '0', 00:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:55:12 INFO - Cleaning up... 00:55:12 INFO - Return code: 0 00:55:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:12 INFO - 'HOME': '/Users/cltbld', 00:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:12 INFO - 'LOGNAME': 'cltbld', 00:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:12 INFO - 'MOZ_NO_REMOTE': '1', 00:55:12 INFO - 'NO_EM_RESTART': '1', 00:55:12 INFO - 'PAGER': '/bin/cat', 00:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:12 INFO - 'PWD': '/builds/slave/test', 00:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:12 INFO - 'SHELL': '/bin/bash', 00:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:12 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:12 INFO - 'USER': 'cltbld', 00:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:12 INFO - 'XPC_FLAGS': '0x0', 00:55:12 INFO - 'XPC_SERVICE_NAME': '0', 00:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:12 INFO - Downloading/unpacking blobuploader==1.2.4 00:55:12 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 00:55:12 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 00:55:12 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 00:55:12 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 00:55:12 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 00:55:12 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 00:55:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:55:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:55:15 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 00:55:15 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 00:55:15 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 00:55:15 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 00:55:15 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 00:55:15 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 00:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:55:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:55:16 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 00:55:16 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 00:55:16 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 00:55:16 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 00:55:16 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 00:55:16 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 00:55:16 INFO - Downloading docopt-0.6.1.tar.gz 00:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:55:16 INFO - Installing collected packages: blobuploader, requests, docopt 00:55:16 INFO - Running setup.py install for blobuploader 00:55:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:55:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:55:16 INFO - Running setup.py install for requests 00:55:17 INFO - Running setup.py install for docopt 00:55:17 INFO - Successfully installed blobuploader requests docopt 00:55:17 INFO - Cleaning up... 00:55:17 INFO - Return code: 0 00:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:17 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:17 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 00:55:17 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 00:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:17 INFO - 'HOME': '/Users/cltbld', 00:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:17 INFO - 'LOGNAME': 'cltbld', 00:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:17 INFO - 'MOZ_NO_REMOTE': '1', 00:55:17 INFO - 'NO_EM_RESTART': '1', 00:55:17 INFO - 'PAGER': '/bin/cat', 00:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:17 INFO - 'PWD': '/builds/slave/test', 00:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:17 INFO - 'SHELL': '/bin/bash', 00:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:17 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:17 INFO - 'USER': 'cltbld', 00:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:17 INFO - 'XPC_FLAGS': '0x0', 00:55:17 INFO - 'XPC_SERVICE_NAME': '0', 00:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:17 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-sySK38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-wgC0HK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-K1r8t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-oG7roi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-LlXkJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-fwjw6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-xeAcLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-7_Kzo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-aOzca3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-WgeASD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-b7h5Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-6CsjDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-4DITex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-xX8pQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-iuCV05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-GPpwB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MpABvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:55:19 INFO - Running setup.py install for manifestparser 00:55:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:55:19 INFO - Running setup.py install for mozcrash 00:55:19 INFO - Running setup.py install for mozdebug 00:55:20 INFO - Running setup.py install for mozdevice 00:55:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Running setup.py install for mozfile 00:55:20 INFO - Running setup.py install for mozhttpd 00:55:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Running setup.py install for mozinfo 00:55:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Running setup.py install for mozInstall 00:55:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:55:20 INFO - Running setup.py install for mozleak 00:55:20 INFO - Running setup.py install for mozlog 00:55:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Running setup.py install for moznetwork 00:55:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Running setup.py install for mozprocess 00:55:21 INFO - Running setup.py install for mozprofile 00:55:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Running setup.py install for mozrunner 00:55:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:55:21 INFO - Running setup.py install for mozscreenshot 00:55:21 INFO - Running setup.py install for moztest 00:55:22 INFO - Running setup.py install for mozversion 00:55:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:55:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:55:22 INFO - Cleaning up... 00:55:22 INFO - Return code: 0 00:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:22 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:22 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 00:55:22 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 00:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:22 INFO - 'HOME': '/Users/cltbld', 00:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:22 INFO - 'LOGNAME': 'cltbld', 00:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:22 INFO - 'MOZ_NO_REMOTE': '1', 00:55:22 INFO - 'NO_EM_RESTART': '1', 00:55:22 INFO - 'PAGER': '/bin/cat', 00:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:22 INFO - 'PWD': '/builds/slave/test', 00:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:22 INFO - 'SHELL': '/bin/bash', 00:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:22 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:22 INFO - 'USER': 'cltbld', 00:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:22 INFO - 'XPC_FLAGS': '0x0', 00:55:22 INFO - 'XPC_SERVICE_NAME': '0', 00:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-yzCHCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:22 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)) 00:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-wUtnAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 00:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Cm7c7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:22 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)) 00:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-U4PD6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 00:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-NDQIF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0f5ZFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-6ERV_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-OucU04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-DH1Y36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-vojmfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-k4SriN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-g1UtKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-xBMHuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:23 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)) 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:23 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-mWf4vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-rMCe2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:24 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)) 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eyMyos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:24 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-_iWwPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:24 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)) 00:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:55:24 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)) 00:55:24 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:55:24 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:55:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:55:24 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 00:55:24 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 00:55:24 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 00:55:24 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 00:55:24 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 00:55:24 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 00:55:26 INFO - Downloading blessings-1.6.tar.gz 00:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:55:27 INFO - Installing collected packages: blessings 00:55:27 INFO - Running setup.py install for blessings 00:55:27 INFO - Successfully installed blessings 00:55:27 INFO - Cleaning up... 00:55:27 INFO - Return code: 0 00:55:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:55:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:27 INFO - Reading from file tmpfile_stdout 00:55:27 INFO - Current package versions: 00:55:27 INFO - blessings == 1.6 00:55:27 INFO - blobuploader == 1.2.4 00:55:27 INFO - docopt == 0.6.1 00:55:27 INFO - functools32 == 3.2.3-2 00:55:27 INFO - jsonschema == 2.5.1 00:55:27 INFO - manifestparser == 1.1 00:55:27 INFO - mozInstall == 1.12 00:55:27 INFO - mozcrash == 0.17 00:55:27 INFO - mozdebug == 0.1 00:55:27 INFO - mozdevice == 0.48 00:55:27 INFO - mozfile == 1.2 00:55:27 INFO - mozhttpd == 0.7 00:55:27 INFO - mozinfo == 0.9 00:55:27 INFO - mozleak == 0.1 00:55:27 INFO - mozlog == 3.4 00:55:27 INFO - moznetwork == 0.27 00:55:27 INFO - mozprocess == 0.23 00:55:27 INFO - mozprofile == 0.28 00:55:27 INFO - mozrunner == 6.12 00:55:27 INFO - mozscreenshot == 0.1 00:55:27 INFO - mozsystemmonitor == 0.3 00:55:27 INFO - moztest == 0.7 00:55:27 INFO - mozversion == 1.4 00:55:27 INFO - psutil == 3.1.1 00:55:27 INFO - requests == 1.2.3 00:55:27 INFO - wsgiref == 0.1.2 00:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:27 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 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:27 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 00:55:27 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 00:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:27 INFO - 'HOME': '/Users/cltbld', 00:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:27 INFO - 'LOGNAME': 'cltbld', 00:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:27 INFO - 'MOZ_NO_REMOTE': '1', 00:55:27 INFO - 'NO_EM_RESTART': '1', 00:55:27 INFO - 'PAGER': '/bin/cat', 00:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:27 INFO - 'PWD': '/builds/slave/test', 00:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:27 INFO - 'SHELL': '/bin/bash', 00:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:27 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:27 INFO - 'USER': 'cltbld', 00:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:27 INFO - 'XPC_FLAGS': '0x0', 00:55:27 INFO - 'XPC_SERVICE_NAME': '0', 00:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 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)) 00:55:28 INFO - Cleaning up... 00:55:28 INFO - Return code: 0 00:55:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100921570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc632d94b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, '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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 00:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:28 INFO - 'HOME': '/Users/cltbld', 00:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:28 INFO - 'LOGNAME': 'cltbld', 00:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:28 INFO - 'MOZ_NO_REMOTE': '1', 00:55:28 INFO - 'NO_EM_RESTART': '1', 00:55:28 INFO - 'PAGER': '/bin/cat', 00:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:28 INFO - 'PWD': '/builds/slave/test', 00:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:28 INFO - 'SHELL': '/bin/bash', 00:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:28 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:28 INFO - 'USER': 'cltbld', 00:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:28 INFO - 'XPC_FLAGS': '0x0', 00:55:28 INFO - 'XPC_SERVICE_NAME': '0', 00:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:55:28 INFO - Cleaning up... 00:55:28 INFO - Return code: 0 00:55:28 INFO - Running post-action listener: _resource_record_post_action 00:55:28 INFO - Running post-action listener: _start_resource_monitoring 00:55:28 INFO - Starting resource monitoring. 00:55:28 INFO - [mozharness: 2016-12-22 08:55:28.496761Z] Finished create-virtualenv step (success) 00:55:28 INFO - [mozharness: 2016-12-22 08:55:28.497856Z] Running install step. 00:55:28 INFO - Running pre-action listener: _resource_record_pre_action 00:55:28 INFO - Running main action method: install 00:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:28 INFO - Reading from file tmpfile_stdout 00:55:28 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:55:28 INFO - Reading from file tmpfile_stdout 00:55:28 INFO - Output received: 00:55:28 INFO - Usage: mozinstall [options] installer 00:55:28 INFO - Options: 00:55:28 INFO - -h, --help show this help message and exit 00:55:28 INFO - -d DEST, --destination=DEST 00:55:28 INFO - Directory to install application into. [default: 00:55:28 INFO - "/builds/slave/test"] 00:55:28 INFO - --app=APP Application being installed. [default: firefox] 00:55:28 INFO - mkdir: /builds/slave/test/build/application 00:55:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:55:50 INFO - Reading from file tmpfile_stdout 00:55:50 INFO - Output received: 00:55:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:55:50 INFO - Running post-action listener: _resource_record_post_action 00:55:50 INFO - [mozharness: 2016-12-22 08:55:50.491134Z] Finished install step (success) 00:55:50 INFO - [mozharness: 2016-12-22 08:55:50.491272Z] Running run-tests step. 00:55:50 INFO - Running pre-action listener: _resource_record_pre_action 00:55:50 INFO - Running main action method: run_tests 00:55:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:55:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:55:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:55:50 INFO - 2016-12-22 00:55:50.506 screenresolution[2593:298584] starting screenresolution argv=screenresolution get 00:55:50 INFO - 2016-12-22 00:55:50.509 screenresolution[2593:298584] Display 0: 1600x1200x32@60 00:55:50 INFO - 2016-12-22 00:55:50.515 screenresolution[2594:298586] starting screenresolution argv=screenresolution list 00:55:50 INFO - Available Modes on Display 0 00:55:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:55:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:55:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:55:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:55:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:55:50 INFO - Intel Iris: 00:55:50 INFO - Chipset Model: Intel Iris 00:55:50 INFO - Type: GPU 00:55:50 INFO - Bus: Built-In 00:55:50 INFO - VRAM (Dynamic, Max): 1536 MB 00:55:50 INFO - Vendor: Intel (0x8086) 00:55:50 INFO - Device ID: 0x0a2e 00:55:50 INFO - Revision ID: 0x0009 00:55:50 INFO - Displays: 00:55:50 INFO - Display: 00:55:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:55:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:55:50 INFO - Display Serial Number: 1600x1200 60 00:55:50 INFO - Main Display: Yes 00:55:50 INFO - Mirror: Off 00:55:50 INFO - Online: Yes 00:55:50 INFO - Rotation: Supported 00:55:50 INFO - Return code: 0 00:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:55:50 INFO - Python 2.7.3 00:55:50 INFO - Return code: 0 00:55:50 INFO - grabbing minidump binary from tooltool 00:55:50 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')]} 00:55:50 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 0x1007bfd30>, '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 0x100625db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1007b7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:55:50 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 00:55:50 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 00:55:50 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 00:55:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:50 INFO - Return code: 0 00:55:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:55:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:55:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:55:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:55:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:55:50 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/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 00:55:50 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/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 00:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5c4TTJgVDb/Render', 00:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:55:50 INFO - 'HOME': '/Users/cltbld', 00:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:55:50 INFO - 'LOGNAME': 'cltbld', 00:55:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:50 INFO - 'MOZ_NO_REMOTE': '1', 00:55:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:50 INFO - 'NO_EM_RESTART': '1', 00:55:50 INFO - 'PAGER': '/bin/cat', 00:55:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:50 INFO - 'PWD': '/builds/slave/test', 00:55:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:55:50 INFO - 'SHELL': '/bin/bash', 00:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gk4BpSkdrf/Listeners', 00:55:50 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 00:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:55:50 INFO - 'USER': 'cltbld', 00:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:50 INFO - 'XPC_FLAGS': '0x0', 00:55:50 INFO - 'XPC_SERVICE_NAME': '0', 00:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:55:50 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/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 00:55:51 INFO - mozversion application_buildid: 20161221224352 00:55:51 INFO - mozversion application_changeset: 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 00:55:51 INFO - mozversion application_display_name: Firefox 00:55:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:51 INFO - mozversion application_name: Firefox 00:55:51 INFO - mozversion application_remotingname: firefox 00:55:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:55:51 INFO - mozversion application_vendor: Mozilla 00:55:51 INFO - mozversion application_version: 51.0 00:55:51 INFO - mozversion platform_buildid: 20161221224352 00:55:51 INFO - mozversion platform_changeset: 9fc3b4f4d2f111a0726e58c8aa56738dc8872449 00:55:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:55:51 INFO - mozversion platform_version: 51.0 00:55:51 INFO - using testdate: 1482396951 00:55:51 INFO - actual date: 1482396951 00:55:51 INFO - starting webserver on 'localhost:58295' 00:55:51 INFO - SUITE-START | Running 2 tests 00:55:51 INFO - TEST-START | dromaeo_css 00:55:51 INFO - operating with platform_type : mac_ 00:55:51 INFO - Initialising browser for dromaeo_css test... 00:55:51 INFO - TEST-INFO | started process 2604 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpLKcBV1/profile http://localhost:58295/getInfo.html) 00:55:53 INFO - PROCESS | 2604 | __metrics Screen width/height:1600/1200 00:55:53 INFO - PROCESS | 2604 | colorDepth:24 00:55:53 INFO - PROCESS | 2604 | Browser inner width/height: 1024/689 00:55:53 INFO - PROCESS | 2604 | __metrics 00:55:53 INFO - PROCESS | 2604 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:55:53 INFO - PROCESS | 2604 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:55:53 INFO - TEST-INFO | 2604: exit 0 00:55:53 INFO - Browser initialized. 00:55:53 INFO - Running cycle 1/1 for dromaeo_css test... 00:55:53 INFO - TEST-INFO | started process 2607 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpLKcBV1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:56:05 INFO - PROCESS | 2607 | RSS: Main: 168062976 00:56:05 INFO - PROCESS | 2607 | 00:56:57 INFO - PROCESS | 2607 | 1482397017470 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:59:07 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58295/tests/dromaeo/cssquery-ext.html) 00:59:09 INFO - PROCESS | 2607 | RSS: Main: 304750592 00:59:09 INFO - PROCESS | 2607 | 01:02:12 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-ext.html (next: http://localhost:58295/tests/dromaeo/cssquery-jquery.html) 01:02:12 INFO - PROCESS | 2607 | RSS: Main: 300957696 01:02:12 INFO - PROCESS | 2607 | 01:05:15 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58295/tests/dromaeo/cssquery-mootools.html) 01:05:15 INFO - PROCESS | 2607 | RSS: Main: 299819008 01:05:15 INFO - PROCESS | 2607 | 01:08:17 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58295/tests/dromaeo/cssquery-prototype.html) 01:08:18 INFO - PROCESS | 2607 | RSS: Main: 270745600 01:08:18 INFO - PROCESS | 2607 | 01:11:21 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58295/tests/dromaeo/cssquery-yui.html) 01:11:22 INFO - PROCESS | 2607 | RSS: Main: 262541312 01:11:22 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:58295/tests/dromaeo/cssquery-yui.html (next: http://localhost:58295/tests/dromaeo/cssquery-dojo.html) 01:14:25 INFO - PROCESS | 2607 | RSS: Main: 311930880 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | __start_tp_report 01:14:25 INFO - PROCESS | 2607 | _x_x_mozilla_page_load 01:14:25 INFO - PROCESS | 2607 | _x_x_mozilla_page_load_details 01:14:25 INFO - PROCESS | 2607 | |i|pagename|runs| 01:14:25 INFO - PROCESS | 2607 | |0;dojo.html;3380.0704806178296;3390.4914262860575;3418.008777454537;3434.6565343465672;3458.8789392371255;5778.508826749726;5846.473817356447;5854.941450585493;5888.764449422023;5940.64356138632;5797.130430435437;5878.970605146979;5881.000229960906;5885.11723241514;5894.852628684285;5242.501962313574;5257.789688412459;5321.547668448186;5327.174287985368;5341.43914888935;5213.218017297417;5226.372835259755;5226.817061402851;5368.785248590052;5384.057789886774;5262.842114736545;5317.069512835258;5367.463253674621;5376.596755243353;5390.703511306877;5283.8150664726745;5359.410464848864;5364.302640656729;5369.24830523727;5371.973140134274;5184.429712731597;5308.761105750251;5318.601104917147;5363.490468405495;5377.085895397791;5640.153976903456;5681.659100453986;5683.8010669626365;5707.942920570783;5837.153612726131;6208.192934918477;6274.247090349188;6293.496520278367;6305.148804911324;6307.8738425231695;6331.33520980295;6357.4914006879335;6360.58656187351;6375.521835862282;6378.649174295412;5745.195672605797;5765.077587585966;5778.942210577925;5859.150423188614;5865.501432378253;6256.655883926337;6293.96853015732;6301.369863013662;6333.20834895638;6348.174737284216;6181.196444462191;6231.096491008779;6260.40526150015;6265.216847894013;6265.937340626535;6349.619022858643;6358.1734374531015;6370.235571731422;6376.202974628171;6382.5851319665;6108.031519550537;6116.938830611726;6149.169862068564;6201.906971395432;6312.589681670676;6262.937370626327;6357.11000459936;6358.968205159037;6363.236411630634;6363.9181339172455;4986.650934434555;5033.370828646419;5044.646874718735;5050.393952725696;5066.16408292635;4424.75663838492;4480.843170489083;4509.954900451019;4515.5484451554585;4538.546145385435;4919.803207871645;5898.852528686817;5945.989181839098;5966.224390829165;6058.969705151534;6339.144215530937;6350.460210882126;6368.936310636927;6370.58591191571;6402.263739669997;5956.374580668968;5972.790952316648;5990.400959903975;5991.310999235056;5993.790217342459;5381.973090134603;5383.623146379794;5415;5427.185922111715;5495.505404513613;6261.906071408933;6380.266269379081;6384.361563843579;6392.808215753535;6400.967995159995;6293.559450838397;6312.179416675986;6312.337204593635;6333.556651034383;6350.555461117678;6247.781327653511;6256.968715156395;6354.968225158845;6367.235931688042;6397.26431460388;6145.40219542931;6159.538034647329;6195.721192546256;6205.565610407228;6320.778772743116;6324.367563243639;6324.841878953063;6334.493240540838;6344.777932772331;6356.872862542631;6107.816765497042;6240.095186198067;6247.187865577446;6261.780837670842;6264.749410023548;4808.302796094476;6061.030235162353;6105.09585775316;6130.386961303834;6142.539309551712;6100.908486372619;6103.908441373294;6107.4197951194565;6121.84695382619;6131.693415329127;6181.53638477125;6191.25704915395;6195.783147589813;6206.100115483139;6223.595466294857;5894.793682221101;5949.25634295713;5990.64056156632;6004.42957918997;6048.4858787003595 01:14:25 INFO - PROCESS | 2607 | |1;ext.html;492.6994533334665;503.23508267433493;513.5070332480818;532.7442827442825;533.2800719029311;27807.860960695194;32454.18864528388;41646;42881.785591072075;43060.92347691309;41312.79343603278;44253.8936526587;44294.557054429446;44350.33474497885;44416.88957776057;10018.148457381114;10212.64255751049;10219.94890025549;10221.437820919846;10228.386296822177;9315.301352398563;9481.194098501635;12247.755044899097;12489.313087780169;12510.3744812759;12466.563670271542;12531.624051278477;12551.937240313786;12553.435095420728;12554.309512976783;12489.875101249008;12598.748025039447;12600.054995875254;12603.558875439361;12610.68473288166;12300.569480068154;12381.319027453486;12390.31853248071;12390.876091239152;12411.875881241253;40467.190656187006;41532.79233603843;41745.582544174475;41796.37305440421;41885;3034.863431145604;3535.646435356444;3614.2952124335766;3940.271049855757;4074.1444296697728;30299.848500757576;31429;31838.681613183802;32729.181770455692;33191.83404082988;3376.7129793967542;3391.2369716813764;3396.626371099177;3412.84642191102;3426.1605906552804;366569.16715416254;366583;366730;366940;367420;34086;59373.703131484064;59643.403565964654;59704.70147649234;59817.40182598205;35184;36110.277794443966;36573.26853462916;36626.81686591604;36661.63338366582;15621.375144994301;15868.44460443902;15886;15896.046237225804;15897.125658088686;12286.508539658313;12488;13334.466621335232;13383.996200285017;13408.329583520785;7887.290143886963;8071.4753541019645;8093.716719914774;8098.75703728889;8168.7957801055445;3322.4882678381277;3386.0519054664733;3389.4237979543536;3394.983025084908;3413.7781044232047;997.2969056814928;998.3710262534556;1006.7634105985088;1072.158355690779;1145.9838430180773;25573.8721306396;30369.24076898095;30548.54177187344;30660.69339306623;30997.69002309993;1100.3178029621686;1103.365564800243;1105.4141305108305;1139.5384869128015;1158.362900404791;13779.448822047207;15834.28745706446;16062.43781467643;16128.032318060954;16296;722103;731493;732694.028768696;734525;736349.6365036388;59102;59587.999999999134;59634.70182649059;59636.70181649064;59673.70163149157;1197.9940100299443;1288.368699337318;1319.4919955816888;1342.3221273256943;1423.046558805582;25670.101546445785;30215.395692085596;30995.380092397576;31227.84386078055;32743.672563274064;49163.75418122886;49771.751141244065;49846.75076624594;49973;50000.49999500104;551371;552421;552660;553279;554294;24233;24723.25830225096;26621.733782661926;27184.592231116152;27263.318417039733;47574;47680.84642666025;48103;48366.75816620894;48752.26871596858;39471.802640986614;39489.802550987064;39653.41386344514;40597.39103913503;41510.79244603758;38558.42162367511;39044.02389940274;39151.804240978614;39678.40482392824;40409;38374;39603;39946.20107597773;40055.79972100121;40064;32973.83513082419;35353.82323088368;36227.637723623484;36311.636883630825;36411.45382819313;26414.471710566064;26647.733522664526;26667.799949001954;26759;27075.1877443677 01:14:25 INFO - PROCESS | 2607 | |2;jquery.html;327.5561614013012;390.69135383047376;395.9980200099;406.80473372781046;418.591872923899;19508.609827803437;22478.66282005771;22487;22546;22890.542189156207;20507.282245121423;20882.477938051557;21106.89446552765;21275.787242127575;21762.911854407295;5230.7646155922885;5507.5593952483705;5571.1086226203815;5586.10622300432;5589.273394458714;4059.106996460774;4161.687873409492;4165.520965089008;5518.751656175482;5527.336719593654;4189.832406703728;4392.472903251598;4478.664100192498;6779.084823548807;6857.314268573153;6696.388408520681;6784.694688739019;6835.384815366616;6852.6916288767125;6853.109095817562;5979.641221526722;6011.759529618854;6068.57519973602;6090.208272924536;6097.390260973912;11619.941900290529;13735.862641373558;14057.859421405758;14216.431342746278;23613.70124643144;2213.9446513837283;2323.2913961241816;2447.7185123710824;2526.280010197085;2762.1575419497044;10111.7472063199;10248.979449077406;10557.41934193619;10560.894391056068;10582.259241853073;1911.5794525204433;1957.6769832977684;1967.242611594532;1999.480135164853;2013.8187563119243;97747;131713;142142.1571568573;143013.28493357572;143361;11601.245919015237;11765.411729413496;11855.407229638484;11890.227135236355;12032.338221397908;15325.6168595786;15358.846411535966;15359.308831102628;15370.000949938218;15375.769363459556;8828.161324674145;8928.821423571622;8988.55057247135;8990;9068.637254509746;8870.86693699595;8910.287177025823;8923.910760892439;9026.63893444268;9037;4637.884052898705;4649.349091127245;4660.627149828006;4674.859754207379;4708.081924024782;1588.8728901687837;1958.9412317630495;1959.3240332085409;1959.7746259180376;1963.646543622133;860.7331727164599;869.2958703450225;948.9620415183454;1022.1720406470782;1040.953157107932;20639;22286.55426891453;22381.776182238296;22415.55168896613;22454.663180052314;941.7127776028377;944.9804743782151;979.9314048016713;995.7759504111517;998.32612986234;11273.774524509628;11628.709282267842;11697.2981621103;11702.2978621283;11762.88237117635;603006;604468;609837;620657.8967105135;624507;73718.63140684369;122986.77013229932;125987;126149;128463.35768321098;983.5524836199512;1006.9647562335283;1050.2595670052594;1050.4170185547096;1052.8526006359116;19160.520986975436;19412.902935485232;19727.802721972595;19774.90112549428;19803.306884259557;54564.908701826535;55673;56081.71959140178;56253;56739;81346;81480;82202.58898705468;83068.58465707632;86077.56961215154;8322.875156872531;8460.915390846012;8553;8567.914320856711;8641.02576825951;10800.675979720621;13002.349882505649;13462.192268463923;13659;13986.370613322628;11456.312621242752;11547.422628868355;11841;12107.636770896886;12148.75702485963;11182.944085279521;11402.429878506207;11780.880816322435;11915.761684766083;12093.15347925672;11466.713332166762;11575.826362604399;11909.464074116513;12076.215046022331;12095.939520302341;7363.595002274927;7598.354139898171;7787.844243114992;8441.198086182048;8609.48343099416;8414.242718155396;11225.214235003472;11480.138989575982;11684.240524365889;11965.700857478632 01:14:25 INFO - PROCESS | 2607 | |3;mootools.html;1388.396047719243;1512.689898570793;1516.8938174327795;1722.5951901303192;1899.2023350192917;8025;8533.104024077467;8849.380543361967;9169.449833010023;9180.219681327095;9036.774080647987;9120.817583648322;9139.086091390858;9144.588493517791;9148.542572871347;2415.263344679872;2434.1845481763544;2447.645091461737;2448.3144719478573;2450.3629056445275;2377.1442280778906;2410.9035638574437;2420.588499955003;2421.1889017179265;2423.9151629692965;2386.522695460906;2412.1316326122583;2412.8552286862846;2418.661387405765;2426.2357357432443;2374.2402431221844;2385.7494963028894;2390.438247011968;2390.8685022323853;2399.292208798391;2356.681847950539;2387.39121524012;2387.6299173628117;2391.3977634984603;2395.616701327797;8810.339224558184;8913.688020919237;9106.544672766402;9113.726588202364;9115.954420227923;5406.8918621627345;5578.135389014709;5650.491455769001;5653.236813030229;5669.744861481243;3704.592494825567;3713.591504934455;3758.849646014156;3803.6957043436737;3807.9238415231816;1046.1526163807341;1049.92125590581;1126.3467189030425;1130.2145009218596;1140.4012893231038;11916.165868389216;11932.04543636507;12070.155089143764;12081.033517318681;12091.45588448522;4887.3890763654545;4895.804167833318;4946.530079642428;5044.54599086084;5045.628554579342;10399.53202105907;10403.271770976111;10413.062824345845;10436.843447348296;10547.367157970546;4712.976435117803;5606.990741666457;5618.325800903917;5618.831435056954;5664.980303545319;3798.620137986179;4102.958970410257;4758.1673207188605;5085.160948443466;5131.7177555234075;4102.856400026045;4167.666586673059;4206.221848957953;4220.409142720022;4235.30117530604;1282.504116649169;1313.185824788637;1323.232525135419;1327.8340207474066;1330.5143622577689;884.5135175653365;895.5566994337845;915.9404638698463;931.2503434735104;933.5005771911995;5771.220885180447;5856.857912706982;5921.230240068763;6073.210482637229;6150.477209437158;447.3826119954442;451.6477147824702;459.43030642004345;465.06289826000636;466.32615870068105;3297.7032067114073;3625.873094441682;3969.226000929849;3992.401139829049;4107.507099148122;10656.413897235727;11182;11185.384803835705;11193.608223712294;11203.103751700008;11122.66632001025;11123;11128.944355278334;11129.944350278196;11132.777344453227;8060.153683863227;8372.204640559137;8429.283510901641;8431.19903609156;8476.660933562713;5206.947930520646;6022.066579680157;6047.395260473917;6077.6961151943115;6131.233595800525;9923.206143508358;10116;10378.636747713794;10512.26414151002;10538;9616.75958101053;10401.427921464392;10564.260501764802;10584.84122738175;10695.786084278427;7026.437884969292;7746;7828;7925.960370198112;7931.2068793120225;8440.746777596682;8466.619002145042;8500.107488713596;8560.614772335135;8662;7658.195889431529;7681.308682218403;7705.922940770521;7725.806854828675;7760.68957241704;7510.436717246119;7542.924570754222;7544.811379715551;7571.962140189264;7586.734464293723;6822.044913711985;6922.307769223037;7051.506394552537;7188.101487314086;7256.492045556761;5044.495550444926;5071.644984851173;5077.441481436965;5113.8721531962;5166.018456493254;5036.647434679538;5058.241263810458;5082.872928176826;5180.792768289226;5209.843704688866 01:14:25 INFO - PROCESS | 2607 | |4;prototype.html;312.87797758874035;312.9718873500551;321.52574951945877;325.5913828145677;325.8094015001224;5254.316938797961;5311.309529761131;5511.421300763413;5545.861353466165;5619.522340601049;4191.580841915807;4635.374224479694;5150.768215430306;5337;5567.661582135503;4220.36694495825;4239.43514173925;4253.851115210969;4272.487301523822;4301.505326887401;3317.7179939705034;3938.310795610771;4187.183499217654;4231.70378073535;4246.851360202393;3959.4060890866313;4174.290370636983;4218.831246750126;4232.894177645553;4264.741901139171;3508.7894726316504;3977.6817854571564;4200.983527906591;4229.0546348679645;4238.982644165409;3687.797171155585;3693.4829123922673;3702.537497688398;3703.518542589473;3728.7949162796035;4479.596836284717;4499.640028797721;4873.463918968911;5234.6335756497065;5345.786168553253;4201.949512621844;4804.807807687688;4873.049755297719;4919.901601967977;4940.654154209206;5802.7098645068;5804.43280314317;5843.795467158629;5850.912236316416;5883.38224486427;3495.5455790747296;3988.062805240766;4103.179364127186;4104.056067104553;4109.198706252282;4907.411110666707;6121.846953826145;6127.660425068349;6140.600860944069;6149.538784591129;3966.7421617594764;4179.164167166578;4190.979045104755;4198.685098617616;4228.4080228768;3551.3785087609567;3756.3050835595504;4249.830006799693;4265.637420819203;4318.352247162888;4004.5795191505053;4806.975965120222;4875.878103047452;4891.95108048915;4903.803847846118;4838.879028024327;5861.560382971209;5879.617824841372;5886.264216972879;5913.881722365529;1329.9335033248299;1363.6863521390135;1429.756941319978;1442.5744405400221;1452.6876721504927;729.5513259345464;804.9034115906129;848.1433751910615;891.4651209274383;942.853857652065;3780.432935059763;3888.9222215556097;4173.622704507506;4240.915181696349;4384.12317536494;3943.4479172915817;4274.914501710011;4379.671524635602;4501.3248012797685;4614.584687378152;3770.378737143;4175.728577642443;4477.731336119843;4556.681032327705;4664.95335046652;3088.8108078389982;3101.0231776990177;3108.1249843894307;3110.7666924980717;3113.2839446926882;5119.846404607868;5160.664556803796;5165.269634672427;6095.908561371583;6241.225462521175;4685.367475390779;5627.820281540916;6042.486388656926;6062.605930614496;6151.84620384494;5381.515663590218;6025.975584150792;6185.474234690012;6190.721417536221;6194.473469755031;5665.178549110438;5794.942050579441;5897.321807991964;6004.418100216949;6065.029595264737;5157.6647517911215;5580.804671836466;5646.983542962306;5882.294124705063;5901.704914754331;5918.940810592011;6177.382261773787;6214.613035895358;6235.469985051322;6256.436920677161;3764.5670747864347;3961.8811435656976;3966.1076257841755;4012.478377810866;4060.7563546186143;5163.3545806774155;5875.353711091862;5956.24756403463;6016.75095448453;6030.517558595389;4844.539768721966;5364.2490051393615;5536.889262214814;5807.593468457337;5942;5162.174052151638;5547.861303467445;5780.930527852361;5879.853003674943;5902.881942361043;5430.185472179047;5441.782328706808;5585.748641311232;5665.915011274917;5666.801661941812;5407.701726766188;5579.465646947122;5717.740887693974;5789.8263052108505;5792.420757924174;4667.276572131325;4865.691329895563;5502.339719233718;5603.10350343943;5641.323041235078 01:14:25 INFO - PROCESS | 2607 | |5;yui.html;684.4095100046326;738.6085374751382;789.4473868292197;823.1274848660419;824.7855557555034;15982.200889955498;16822.915885420585;16828.57928551787;16849.494515164533;16852.74720879186;15087.773683394758;15172;15192.696146077073;15195.54413367598;15199.392024319013;698.7938558125339;706.4524993130314;843.877637742527;849.562475325208;864.9870251946226;853.2022558907411;858.772425307294;861.8060936289316;863.1541089732067;863.8401895649325;897.8832751742265;900.1493588558815;900.5092224737501;900.5857305639414;900.8468560344758;893.8435773739635;894.6197865906963;895.4269267668698;896.318797713739;898.8651702244683;657.3820608627874;659.1628631637841;660.9669516524202;663.1312979996172;664.2925284571916;15804.446844360393;15824.44614438489;15841;15861.206939653086;15940.442084526985;12033.93983030088;15073.397064117422;15139.697206055927;15207.543773686808;15251.923740381339;12171.93914030433;12329.321887296195;12331.691707707289;12332.938335308356;12486.875131248753;4001.97999010006;4015.2371049500503;4019.799010049515;4027.335489644205;4105.548389677163;105310;109078;109379;114723.85276147215;118877;10011.49942502872;11027.944860275647;11588.88411115895;11780.469878855472;11999.220050696676;22737.658935115986;22741.772582273967;22745.431364215696;22749.31752047441;22806.65790013151;8043.155468675822;8185.140560241208;8215.465994710325;8450.323974082059;8622.741317760478;4513.413256276663;4517.254652982221;4635.142498637762;4637.60580350674;4783.258594917794;3124.9218769530944;3221.5650887130405;3223.7259832913996;3229.4994275887275;3232.9191770205935;654.1300070905684;663.6416335179046;711.1430725975188;747.2490147401826;749.3330935467438;636.8630744389885;677.7560078371782;690.9861802763917;709.1845869223647;724.9130104387507;9558.235341172689;9861.457619830835;9933.552990115462;10120.645777397904;10388.688339349832;605.4823126227101;619.2723549829022;671.9025741267488;677.2617846547189;707.9398251148607;4573.588377046081;4751.691140075884;4758.619310455155;4775.856724298276;4858.368412106403;164320;167951;173123.26876731325;174101;175914;92578;92897.53551232336;117111;117932;130518;110003;111992.88007119825;113248.43375783069;114566.85433145729;117202;9874.308798384043;10476.319039262424;10477.528511217166;10500.159987201157;10547.683569492927;65740;65862.67068664818;66177.33822661712;67277.66361168162;72937.6353118231;81517.59241203993;105075.94924050967;105816.41275381029;112019;115801;13979.580612581638;14426;14744.778828317369;15324.693506129592;15766;16191.75712364339;16464.588385290463;16488.67022659516;17046.74316486762;17076.829231707525;14580.562583122522;14622.195779232245;15057.397704091714;15476.458323958608;15741.842581574037;14879.404823806926;14915.105093694414;15018.24908754536;15267.3893044277;15739.842601573837;11485.540578377106;13661.453541858215;13907.930460347634;13926.860731392557;14331.85668143347;11645.47595358194;12124.575639852563;12161.81757273624;12382.442790074288;12541.874581254071;11990.880091198977;12018.278903265482;12058.51765929388;12085.51657933708;12418.627441176417 01:14:25 INFO - PROCESS | 2607 | __end_tp_report 01:14:25 INFO - PROCESS | 2607 | __start_cc_report 01:14:25 INFO - PROCESS | 2607 | _x_x_mozilla_cycle_collect,1164 01:14:25 INFO - PROCESS | 2607 | __end_cc_report 01:14:25 INFO - PROCESS | 2607 | __startTimestamp1482398065718__endTimestamp 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | ------- Summary: start ------- 01:14:25 INFO - PROCESS | 2607 | Number of tests: 6 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#0] dojo.html Cycles:165 Average:5826.91 Median:6100.91 stddev:645.87 (10.6%) stddev-sans-first:618.67 01:14:25 INFO - PROCESS | 2607 | Values: 3380.1 3390.5 3418.0 3434.7 3458.9 5778.5 5846.5 5854.9 5888.8 5940.6 5797.1 5879.0 5881.0 5885.1 5894.9 5242.5 5257.8 5321.5 5327.2 5341.4 5213.2 5226.4 5226.8 5368.8 5384.1 5262.8 5317.1 5367.5 5376.6 5390.7 5283.8 5359.4 5364.3 5369.2 5372.0 5184.4 5308.8 5318.6 5363.5 5377.1 5640.2 5681.7 5683.8 5707.9 5837.2 6208.2 6274.2 6293.5 6305.1 6307.9 6331.3 6357.5 6360.6 6375.5 6378.6 5745.2 5765.1 5778.9 5859.2 5865.5 6256.7 6294.0 6301.4 6333.2 6348.2 6181.2 6231.1 6260.4 6265.2 6265.9 6349.6 6358.2 6370.2 6376.2 6382.6 6108.0 6116.9 6149.2 6201.9 6312.6 6262.9 6357.1 6359.0 6363.2 6363.9 4986.7 5033.4 5044.6 5050.4 5066.2 4424.8 4480.8 4510.0 4515.5 4538.5 4919.8 5898.9 5946.0 5966.2 6059.0 6339.1 6350.5 6368.9 6370.6 6402.3 5956.4 5972.8 5990.4 5991.3 5993.8 5382.0 5383.6 5415.0 5427.2 5495.5 6261.9 6380.3 6384.4 6392.8 6401.0 6293.6 6312.2 6312.3 6333.6 6350.6 6247.8 6257.0 6355.0 6367.2 6397.3 6145.4 6159.5 6195.7 6205.6 6320.8 6324.4 6324.8 6334.5 6344.8 6356.9 6107.8 6240.1 6247.2 6261.8 6264.7 4808.3 6061.0 6105.1 6130.4 6142.5 6100.9 6103.9 6107.4 6121.8 6131.7 6181.5 6191.3 6195.8 6206.1 6223.6 5894.8 5949.3 5990.6 6004.4 6048.5 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#1] ext.html Cycles:180 Average:67966.16 Median:19305.08 stddev:153029.84 (792.7%) stddev-sans-first:153375.28 01:14:25 INFO - PROCESS | 2607 | Values: 492.7 503.2 513.5 532.7 533.3 27807.9 32454.2 41646.0 42881.8 43060.9 41312.8 44253.9 44294.6 44350.3 44416.9 10018.1 10212.6 10219.9 10221.4 10228.4 9315.3 9481.2 12247.8 12489.3 12510.4 12466.6 12531.6 12551.9 12553.4 12554.3 12489.9 12598.7 12600.1 12603.6 12610.7 12300.6 12381.3 12390.3 12390.9 12411.9 40467.2 41532.8 41745.6 41796.4 41885.0 3034.9 3535.6 3614.3 3940.3 4074.1 30299.8 31429.0 31838.7 32729.2 33191.8 3376.7 3391.2 3396.6 3412.8 3426.2 366569.2 366583.0 366730.0 366940.0 367420.0 34086.0 59373.7 59643.4 59704.7 59817.4 35184.0 36110.3 36573.3 36626.8 36661.6 15621.4 15868.4 15886.0 15896.0 15897.1 12286.5 12488.0 13334.5 13384.0 13408.3 7887.3 8071.5 8093.7 8098.8 8168.8 3322.5 3386.1 3389.4 3395.0 3413.8 997.3 998.4 1006.8 1072.2 1146.0 25573.9 30369.2 30548.5 30660.7 30997.7 1100.3 1103.4 1105.4 1139.5 1158.4 13779.4 15834.3 16062.4 16128.0 16296.0 722103.0 731493.0 732694.0 734525.0 736349.6 59102.0 59588.0 59634.7 59636.7 59673.7 1198.0 1288.4 1319.5 1342.3 1423.0 25670.1 30215.4 30995.4 31227.8 32743.7 49163.8 49771.8 49846.8 49973.0 50000.5 551371.0 552421.0 552660.0 553279.0 554294.0 24233.0 24723.3 26621.7 27184.6 27263.3 47574.0 47680.8 48103.0 48366.8 48752.3 39471.8 39489.8 39653.4 40597.4 41510.8 38558.4 39044.0 39151.8 39678.4 40409.0 38374.0 39603.0 39946.2 40055.8 40064.0 32973.8 35353.8 36227.6 36311.6 36411.5 26414.5 26647.7 26667.8 26759.0 27075.2 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#2] jquery.html Cycles:180 Average:35665.03 Median:22516.50 stddev:102305.04 (454.4%) stddev-sans-first:102557.62 01:14:25 INFO - PROCESS | 2607 | Values: 327.6 390.7 396.0 406.8 418.6 19508.6 22478.7 22487.0 22546.0 22890.5 20507.3 20882.5 21106.9 21275.8 21762.9 5230.8 5507.6 5571.1 5586.1 5589.3 4059.1 4161.7 4165.5 5518.8 5527.3 4189.8 4392.5 4478.7 6779.1 6857.3 6696.4 6784.7 6835.4 6852.7 6853.1 5979.6 6011.8 6068.6 6090.2 6097.4 11619.9 13735.9 14057.9 14216.4 23613.7 2213.9 2323.3 2447.7 2526.3 2762.2 10111.7 10249.0 10557.4 10560.9 10582.3 1911.6 1957.7 1967.2 1999.5 2013.8 97747.0 131713.0 142142.2 143013.3 143361.0 11601.2 11765.4 11855.4 11890.2 12032.3 15325.6 15358.8 15359.3 15370.0 15375.8 8828.2 8928.8 8988.6 8990.0 9068.6 8870.9 8910.3 8923.9 9026.6 9037.0 4637.9 4649.3 4660.6 4674.9 4708.1 1588.9 1958.9 1959.3 1959.8 1963.6 860.7 869.3 949.0 1022.2 1041.0 20639.0 22286.6 22381.8 22415.6 22454.7 941.7 945.0 979.9 995.8 998.3 11273.8 11628.7 11697.3 11702.3 11762.9 603006.0 604468.0 609837.0 620657.9 624507.0 73718.6 122986.8 125987.0 126149.0 128463.4 983.6 1007.0 1050.3 1050.4 1052.9 19160.5 19412.9 19727.8 19774.9 19803.3 54564.9 55673.0 56081.7 56253.0 56739.0 81346.0 81480.0 82202.6 83068.6 86077.6 8322.9 8460.9 8553.0 8567.9 8641.0 10800.7 13002.3 13462.2 13659.0 13986.4 11456.3 11547.4 11841.0 12107.6 12148.8 11182.9 11402.4 11780.9 11915.8 12093.2 11466.7 11575.8 11909.5 12076.2 12095.9 7363.6 7598.4 7787.8 8441.2 8609.5 8414.2 11225.2 11480.1 11684.2 11965.7 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#3] mootools.html Cycles:180 Average:5858.28 Median:4735.57 stddev:3336.78 (70.5%) stddev-sans-first:3329.23 01:14:25 INFO - PROCESS | 2607 | Values: 1388.4 1512.7 1516.9 1722.6 1899.2 8025.0 8533.1 8849.4 9169.4 9180.2 9036.8 9120.8 9139.1 9144.6 9148.5 2415.3 2434.2 2447.6 2448.3 2450.4 2377.1 2410.9 2420.6 2421.2 2423.9 2386.5 2412.1 2412.9 2418.7 2426.2 2374.2 2385.7 2390.4 2390.9 2399.3 2356.7 2387.4 2387.6 2391.4 2395.6 8810.3 8913.7 9106.5 9113.7 9116.0 5406.9 5578.1 5650.5 5653.2 5669.7 3704.6 3713.6 3758.8 3803.7 3807.9 1046.2 1049.9 1126.3 1130.2 1140.4 11916.2 11932.0 12070.2 12081.0 12091.5 4887.4 4895.8 4946.5 5044.5 5045.6 10399.5 10403.3 10413.1 10436.8 10547.4 4713.0 5607.0 5618.3 5618.8 5665.0 3798.6 4103.0 4758.2 5085.2 5131.7 4102.9 4167.7 4206.2 4220.4 4235.3 1282.5 1313.2 1323.2 1327.8 1330.5 884.5 895.6 915.9 931.3 933.5 5771.2 5856.9 5921.2 6073.2 6150.5 447.4 451.6 459.4 465.1 466.3 3297.7 3625.9 3969.2 3992.4 4107.5 10656.4 11182.0 11185.4 11193.6 11203.1 11122.7 11123.0 11128.9 11129.9 11132.8 8060.2 8372.2 8429.3 8431.2 8476.7 5206.9 6022.1 6047.4 6077.7 6131.2 9923.2 10116.0 10378.6 10512.3 10538.0 9616.8 10401.4 10564.3 10584.8 10695.8 7026.4 7746.0 7828.0 7926.0 7931.2 8440.7 8466.6 8500.1 8560.6 8662.0 7658.2 7681.3 7705.9 7725.8 7760.7 7510.4 7542.9 7544.8 7572.0 7586.7 6822.0 6922.3 7051.5 7188.1 7256.5 5044.5 5071.6 5077.4 5113.9 5166.0 5036.6 5058.2 5082.9 5180.8 5209.8 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#4] prototype.html Cycles:180 Average:4589.33 Median:4883.91 stddev:1415.96 (29.0%) stddev-sans-first:1383.07 01:14:25 INFO - PROCESS | 2607 | Values: 312.9 313.0 321.5 325.6 325.8 5254.3 5311.3 5511.4 5545.9 5619.5 4191.6 4635.4 5150.8 5337.0 5567.7 4220.4 4239.4 4253.9 4272.5 4301.5 3317.7 3938.3 4187.2 4231.7 4246.9 3959.4 4174.3 4218.8 4232.9 4264.7 3508.8 3977.7 4201.0 4229.1 4239.0 3687.8 3693.5 3702.5 3703.5 3728.8 4479.6 4499.6 4873.5 5234.6 5345.8 4201.9 4804.8 4873.0 4919.9 4940.7 5802.7 5804.4 5843.8 5850.9 5883.4 3495.5 3988.1 4103.2 4104.1 4109.2 4907.4 6121.8 6127.7 6140.6 6149.5 3966.7 4179.2 4191.0 4198.7 4228.4 3551.4 3756.3 4249.8 4265.6 4318.4 4004.6 4807.0 4875.9 4892.0 4903.8 4838.9 5861.6 5879.6 5886.3 5913.9 1329.9 1363.7 1429.8 1442.6 1452.7 729.6 804.9 848.1 891.5 942.9 3780.4 3888.9 4173.6 4240.9 4384.1 3943.4 4274.9 4379.7 4501.3 4614.6 3770.4 4175.7 4477.7 4556.7 4665.0 3088.8 3101.0 3108.1 3110.8 3113.3 5119.8 5160.7 5165.3 6095.9 6241.2 4685.4 5627.8 6042.5 6062.6 6151.8 5381.5 6026.0 6185.5 6190.7 6194.5 5665.2 5794.9 5897.3 6004.4 6065.0 5157.7 5580.8 5647.0 5882.3 5901.7 5918.9 6177.4 6214.6 6235.5 6256.4 3764.6 3961.9 3966.1 4012.5 4060.8 5163.4 5875.4 5956.2 6016.8 6030.5 4844.5 5364.2 5536.9 5807.6 5942.0 5162.2 5547.9 5780.9 5879.9 5902.9 5430.2 5441.8 5585.7 5665.9 5666.8 5407.7 5579.5 5717.7 5789.8 5792.4 4667.3 4865.7 5502.3 5603.1 5641.3 01:14:25 INFO - PROCESS | 2607 | 01:14:25 INFO - PROCESS | 2607 | [#5] yui.html Cycles:180 Average:26058.46 Median:173612.13 stddev:41491.02 (23.9%) stddev-sans-first:41563.67 01:14:25 INFO - PROCESS | 2607 | Values: 684.4 738.6 789.4 823.1 824.8 15982.2 16822.9 16828.6 16849.5 16852.7 15087.8 15172.0 15192.7 15195.5 15199.4 698.8 706.5 843.9 849.6 865.0 853.2 858.8 861.8 863.2 863.8 897.9 900.1 900.5 900.6 900.8 893.8 894.6 895.4 896.3 898.9 657.4 659.2 661.0 663.1 664.3 15804.4 15824.4 15841.0 15861.2 15940.4 12033.9 15073.4 15139.7 15207.5 15251.9 12171.9 12329.3 12331.7 12332.9 12486.9 4002.0 4015.2 4019.8 4027.3 4105.5 105310.0 109078.0 109379.0 114723.9 118877.0 10011.5 11027.9 11588.9 11780.5 11999.2 22737.7 22741.8 22745.4 22749.3 22806.7 8043.2 8185.1 8215.5 8450.3 8622.7 4513.4 4517.3 4635.1 4637.6 4783.3 3124.9 3221.6 3223.7 3229.5 3232.9 654.1 663.6 711.1 747.2 749.3 636.9 677.8 691.0 709.2 724.9 9558.2 9861.5 9933.6 10120.6 10388.7 605.5 619.3 671.9 677.3 707.9 4573.6 4751.7 4758.6 4775.9 4858.4 164320.0 167951.0 173123.3 174101.0 175914.0 92578.0 92897.5 117111.0 117932.0 130518.0 110003.0 111992.9 113248.4 114566.9 117202.0 9874.3 10476.3 10477.5 10500.2 10547.7 65740.0 65862.7 66177.3 67277.7 72937.6 81517.6 105075.9 105816.4 112019.0 115801.0 13979.6 14426.0 14744.8 15324.7 15766.0 16191.8 16464.6 16488.7 17046.7 17076.8 14580.6 14622.2 15057.4 15476.5 15741.8 14879.4 14915.1 15018.2 15267.4 15739.8 11485.5 13661.5 13907.9 13926.9 14331.9 11645.5 12124.6 12161.8 12382.4 12541.9 11990.9 12018.3 12058.5 12085.5 12418.6 01:14:25 INFO - PROCESS | 2607 | -------- Summary: end -------- 01:14:25 INFO - PROCESS | 2607 | 01:14:26 INFO - TEST-INFO | 2607: exit 0 01:14:26 INFO - TEST-OK | dromaeo_css | took 1115198ms 01:14:26 INFO - TEST-START | kraken 01:14:26 INFO - operating with platform_type : mac_ 01:14:26 INFO - Initialising browser for kraken test... 01:14:26 INFO - TEST-INFO | started process 2610 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpzR4MGX/profile http://localhost:58295/getInfo.html) 01:14:28 INFO - PROCESS | 2610 | __metrics Screen width/height:1600/1200 01:14:28 INFO - PROCESS | 2610 | colorDepth:24 01:14:28 INFO - PROCESS | 2610 | Browser inner width/height: 1024/689 01:14:28 INFO - PROCESS | 2610 | __metrics 01:14:28 INFO - PROCESS | 2610 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:14:28 INFO - PROCESS | 2610 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:14:29 INFO - TEST-INFO | 2610: exit 0 01:14:29 INFO - Browser initialized. 01:14:29 INFO - Running cycle 1/1 for kraken test... 01:14:29 INFO - TEST-INFO | started process 2612 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpzR4MGX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:40 INFO - PROCESS | 2612 | RSS: Main: 168509440 01:14:40 INFO - PROCESS | 2612 | 01:14:43 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:44 INFO - PROCESS | 2612 | RSS: Main: 219426816 01:14:44 INFO - PROCESS | 2612 | 01:14:46 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-dft) 01:14:47 INFO - PROCESS | 2612 | RSS: Main: 232906752 01:14:47 INFO - PROCESS | 2612 | 01:14:50 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-fft) 01:14:51 INFO - PROCESS | 2612 | RSS: Main: 329170944 01:14:51 INFO - PROCESS | 2612 | 01:14:53 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58295/tests/kraken/driver.html?testName=audio-oscillator) 01:14:54 INFO - PROCESS | 2612 | RSS: Main: 229715968 01:14:54 INFO - PROCESS | 2612 | 01:14:56 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:56 INFO - PROCESS | 2612 | RSS: Main: 230027264 01:14:56 INFO - PROCESS | 2612 | 01:14:59 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:59 INFO - PROCESS | 2612 | RSS: Main: 266625024 01:14:59 INFO - PROCESS | 2612 | 01:15:02 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58295/tests/kraken/driver.html?testName=imaging-desaturate) 01:15:03 INFO - PROCESS | 2612 | RSS: Main: 269086720 01:15:03 INFO - PROCESS | 2612 | 01:15:05 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58295/tests/kraken/driver.html?testName=json-parse-financial) 01:15:06 INFO - PROCESS | 2612 | RSS: Main: 266461184 01:15:06 INFO - PROCESS | 2612 | 01:15:08 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:15:08 INFO - PROCESS | 2612 | RSS: Main: 239976448 01:15:08 INFO - PROCESS | 2612 | 01:15:10 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:15:11 INFO - PROCESS | 2612 | RSS: Main: 245497856 01:15:11 INFO - PROCESS | 2612 | 01:15:13 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:15:14 INFO - PROCESS | 2612 | RSS: Main: 251371520 01:15:14 INFO - PROCESS | 2612 | 01:15:16 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:15:17 INFO - PROCESS | 2612 | RSS: Main: 277413888 01:15:17 INFO - PROCESS | 2612 | 01:15:20 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:15:20 INFO - PROCESS | 2612 | RSS: Main: 265596928 01:15:20 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:58295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58295/tests/kraken/driver.html?testName=ai-astar) 01:15:22 INFO - PROCESS | 2612 | RSS: Main: 309788672 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | __start_tp_report 01:15:22 INFO - PROCESS | 2612 | _x_x_mozilla_page_load 01:15:22 INFO - PROCESS | 2612 | _x_x_mozilla_page_load_details 01:15:22 INFO - PROCESS | 2612 | |i|pagename|runs| 01:15:22 INFO - PROCESS | 2612 | |0;ai-astar;113;113;112;111;111;110;111;112;112;111 01:15:22 INFO - PROCESS | 2612 | |1;audio-beat-detection;147;109;108;142;108;107;111;105;142;107 01:15:22 INFO - PROCESS | 2612 | |2;audio-dft;194;258;182;186;183;181;184;185;182;184 01:15:22 INFO - PROCESS | 2612 | |3;audio-fft;77;72;59;90;60;58;59;58;85;74 01:15:22 INFO - PROCESS | 2612 | |4;audio-oscillator;89;71;94;69;67;69;91;66;68;88 01:15:22 INFO - PROCESS | 2612 | |5;imaging-gaussian-blur;85;83;87;84;86;83;86;83;85;83 01:15:22 INFO - PROCESS | 2612 | |6;imaging-darkroom;91;91;92;91;92;91;91;92;92;92 01:15:22 INFO - PROCESS | 2612 | |7;imaging-desaturate;84;80;85;85;84;84;84;85;84;84 01:15:22 INFO - PROCESS | 2612 | |8;json-parse-financial;56;54;52;53;56;56;57;56;56;56 01:15:22 INFO - PROCESS | 2612 | |9;json-stringify-tinderbox;66;72;72;70;72;69;68;69;68;70 01:15:22 INFO - PROCESS | 2612 | |10;stanford-crypto-aes;84;85;83;83;83;87;87;89;109;108 01:15:22 INFO - PROCESS | 2612 | |11;stanford-crypto-ccm;141;132;142;143;146;148;136;125;199;155 01:15:22 INFO - PROCESS | 2612 | |12;stanford-crypto-pbkdf2;162;162;161;166;162;161;164;160;160;160 01:15:22 INFO - PROCESS | 2612 | |13;stanford-crypto-sha256-iterative;66;67;67;65;65;64;64;64;66;65 01:15:22 INFO - PROCESS | 2612 | __end_tp_report 01:15:22 INFO - PROCESS | 2612 | __start_cc_report 01:15:22 INFO - PROCESS | 2612 | _x_x_mozilla_cycle_collect,1889 01:15:22 INFO - PROCESS | 2612 | __end_cc_report 01:15:22 INFO - PROCESS | 2612 | __startTimestamp1482398122926__endTimestamp 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | ------- Summary: start ------- 01:15:22 INFO - PROCESS | 2612 | Number of tests: 14 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 01:15:22 INFO - PROCESS | 2612 | Values: 113.0 113.0 112.0 111.0 111.0 110.0 111.0 112.0 112.0 111.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:110.00 stddev:17.42 (15.8%) stddev-sans-first:15.14 01:15:22 INFO - PROCESS | 2612 | Values: 147.0 109.0 108.0 142.0 108.0 107.0 111.0 105.0 142.0 107.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#2] audio-dft Cycles:10 Average:191.90 Median:184.50 stddev:23.51 (12.7%) stddev-sans-first:24.92 01:15:22 INFO - PROCESS | 2612 | Values: 194.0 258.0 182.0 186.0 183.0 181.0 184.0 185.0 182.0 184.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#3] audio-fft Cycles:10 Average:69.20 Median:73.00 stddev:12.10 (16.6%) stddev-sans-first:12.50 01:15:22 INFO - PROCESS | 2612 | Values: 77.0 72.0 59.0 90.0 60.0 58.0 59.0 58.0 85.0 74.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:11.62 (14.6%) stddev-sans-first:11.52 01:15:22 INFO - PROCESS | 2612 | Values: 89.0 71.0 94.0 69.0 67.0 69.0 91.0 66.0 68.0 88.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 01:15:22 INFO - PROCESS | 2612 | Values: 85.0 83.0 87.0 84.0 86.0 83.0 86.0 83.0 85.0 83.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#6] imaging-darkroom Cycles:10 Average:91.50 Median:92.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 01:15:22 INFO - PROCESS | 2612 | Values: 91.0 91.0 92.0 91.0 92.0 91.0 91.0 92.0 92.0 92.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.54 01:15:22 INFO - PROCESS | 2612 | Values: 84.0 80.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.62 (2.9%) stddev-sans-first:1.69 01:15:22 INFO - PROCESS | 2612 | Values: 56.0 54.0 52.0 53.0 56.0 56.0 57.0 56.0 56.0 56.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:2.01 (2.9%) stddev-sans-first:1.66 01:15:22 INFO - PROCESS | 2612 | Values: 66.0 72.0 72.0 70.0 72.0 69.0 68.0 69.0 68.0 70.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:84.50 stddev:10.06 (11.9%) stddev-sans-first:10.45 01:15:22 INFO - PROCESS | 2612 | Values: 84.0 85.0 83.0 83.0 83.0 87.0 87.0 89.0 109.0 108.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:144.50 stddev:20.21 (14.0%) stddev-sans-first:21.33 01:15:22 INFO - PROCESS | 2612 | Values: 141.0 132.0 142.0 143.0 146.0 148.0 136.0 125.0 199.0 155.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:1.93 (1.2%) stddev-sans-first:2.05 01:15:22 INFO - PROCESS | 2612 | Values: 162.0 162.0 161.0 166.0 162.0 161.0 164.0 160.0 160.0 160.0 01:15:22 INFO - PROCESS | 2612 | 01:15:22 INFO - PROCESS | 2612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.16 (1.8%) stddev-sans-first:1.20 01:15:22 INFO - PROCESS | 2612 | Values: 66.0 67.0 67.0 65.0 65.0 64.0 64.0 64.0 66.0 65.0 01:15:22 INFO - PROCESS | 2612 | -------- Summary: end -------- 01:15:22 INFO - PROCESS | 2612 | 01:15:23 INFO - TEST-INFO | 2612: exit 0 01:15:23 INFO - TEST-OK | kraken | took 57415ms 01:15:23 INFO - SUITE-END | took 1172s 01:15:24 INFO - Completed test suite (00:19:32) 01:15:24 INFO - javascript benchmark 01:15:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.0704806178296, 3390.4914262860575, 3418.008777454537, 3434.6565343465672, 3458.8789392371255, 5778.508826749726, 5846.473817356447, 5854.941450585493, 5888.764449422023, 5940.64356138632, 5797.130430435437, 5878.970605146979, 5881.000229960906, 5885.11723241514, 5894.852628684285, 5242.501962313574, 5257.789688412459, 5321.547668448186, 5327.174287985368, 5341.43914888935, 5213.218017297417, 5226.372835259755, 5226.817061402851, 5368.785248590052, 5384.057789886774, 5262.842114736545, 5317.069512835258, 5367.463253674621, 5376.596755243353, 5390.703511306877, 5283.8150664726745, 5359.410464848864, 5364.302640656729, 5369.24830523727, 5371.973140134274, 5184.429712731597, 5308.761105750251, 5318.601104917147, 5363.490468405495, 5377.085895397791, 5640.153976903456, 5681.659100453986, 5683.8010669626365, 5707.942920570783, 5837.153612726131, 6208.192934918477, 6274.247090349188, 6293.496520278367, 6305.148804911324, 6307.8738425231695, 6331.33520980295, 6357.4914006879335, 6360.58656187351, 6375.521835862282, 6378.649174295412, 5745.195672605797, 5765.077587585966, 5778.942210577925, 5859.150423188614, 5865.501432378253, 6256.655883926337, 6293.96853015732, 6301.369863013662, 6333.20834895638, 6348.174737284216, 6181.196444462191, 6231.096491008779, 6260.40526150015, 6265.216847894013, 6265.937340626535, 6349.619022858643, 6358.1734374531015, 6370.235571731422, 6376.202974628171, 6382.5851319665, 6108.031519550537, 6116.938830611726, 6149.169862068564, 6201.906971395432, 6312.589681670676, 6262.937370626327, 6357.11000459936, 6358.968205159037, 6363.236411630634, 6363.9181339172455, 4986.650934434555, 5033.370828646419, 5044.646874718735, 5050.393952725696, 5066.16408292635, 4424.75663838492, 4480.843170489083, 4509.954900451019, 4515.5484451554585, 4538.546145385435, 4919.803207871645, 5898.852528686817, 5945.989181839098, 5966.224390829165, 6058.969705151534, 6339.144215530937, 6350.460210882126, 6368.936310636927, 6370.58591191571, 6402.263739669997, 5956.374580668968, 5972.790952316648, 5990.400959903975, 5991.310999235056, 5993.790217342459, 5381.973090134603, 5383.623146379794, 5415.0, 5427.185922111715, 5495.505404513613, 6261.906071408933, 6380.266269379081, 6384.361563843579, 6392.808215753535, 6400.967995159995, 6293.559450838397, 6312.179416675986, 6312.337204593635, 6333.556651034383, 6350.555461117678, 6247.781327653511, 6256.968715156395, 6354.968225158845, 6367.235931688042, 6397.26431460388, 6145.40219542931, 6159.538034647329, 6195.721192546256, 6205.565610407228, 6320.778772743116, 6324.367563243639, 6324.841878953063, 6334.493240540838, 6344.777932772331, 6356.872862542631, 6107.816765497042, 6240.095186198067, 6247.187865577446, 6261.780837670842, 6264.749410023548, 4808.302796094476, 6061.030235162353, 6105.09585775316, 6130.386961303834, 6142.539309551712, 6100.908486372619, 6103.908441373294, 6107.4197951194565, 6121.84695382619, 6131.693415329127, 6181.53638477125, 6191.25704915395, 6195.783147589813, 6206.100115483139, 6223.595466294857, 5894.793682221101, 5949.25634295713, 5990.64056156632, 6004.42957918997, 6048.4858787003595], "value": 5785.903928297358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.6994533334665, 503.23508267433493, 513.5070332480818, 532.7442827442825, 533.2800719029311, 27807.860960695194, 32454.18864528388, 41646.0, 42881.785591072075, 43060.92347691309, 41312.79343603278, 44253.8936526587, 44294.557054429446, 44350.33474497885, 44416.88957776057, 10018.148457381114, 10212.64255751049, 10219.94890025549, 10221.437820919846, 10228.386296822177, 9315.301352398563, 9481.194098501635, 12247.755044899097, 12489.313087780169, 12510.3744812759, 12466.563670271542, 12531.624051278477, 12551.937240313786, 12553.435095420728, 12554.309512976783, 12489.875101249008, 12598.748025039447, 12600.054995875254, 12603.558875439361, 12610.68473288166, 12300.569480068154, 12381.319027453486, 12390.31853248071, 12390.876091239152, 12411.875881241253, 40467.190656187006, 41532.79233603843, 41745.582544174475, 41796.37305440421, 41885.0, 3034.863431145604, 3535.646435356444, 3614.2952124335766, 3940.271049855757, 4074.1444296697728, 30299.848500757576, 31429.0, 31838.681613183802, 32729.181770455692, 33191.83404082988, 3376.7129793967542, 3391.2369716813764, 3396.626371099177, 3412.84642191102, 3426.1605906552804, 366569.16715416254, 366583.0, 366730.0, 366940.0, 367420.0, 34086.0, 59373.703131484064, 59643.403565964654, 59704.70147649234, 59817.40182598205, 35184.0, 36110.277794443966, 36573.26853462916, 36626.81686591604, 36661.63338366582, 15621.375144994301, 15868.44460443902, 15886.0, 15896.046237225804, 15897.125658088686, 12286.508539658313, 12488.0, 13334.466621335232, 13383.996200285017, 13408.329583520785, 7887.290143886963, 8071.4753541019645, 8093.716719914774, 8098.75703728889, 8168.7957801055445, 3322.4882678381277, 3386.0519054664733, 3389.4237979543536, 3394.983025084908, 3413.7781044232047, 997.2969056814928, 998.3710262534556, 1006.7634105985088, 1072.158355690779, 1145.9838430180773, 25573.8721306396, 30369.24076898095, 30548.54177187344, 30660.69339306623, 30997.69002309993, 1100.3178029621686, 1103.365564800243, 1105.4141305108305, 1139.5384869128015, 1158.362900404791, 13779.448822047207, 15834.28745706446, 16062.43781467643, 16128.032318060954, 16296.0, 722103.0, 731493.0, 732694.028768696, 734525.0, 736349.6365036388, 59102.0, 59587.999999999134, 59634.70182649059, 59636.70181649064, 59673.70163149157, 1197.9940100299443, 1288.368699337318, 1319.4919955816888, 1342.3221273256943, 1423.046558805582, 25670.101546445785, 30215.395692085596, 30995.380092397576, 31227.84386078055, 32743.672563274064, 49163.75418122886, 49771.751141244065, 49846.75076624594, 49973.0, 50000.49999500104, 551371.0, 552421.0, 552660.0, 553279.0, 554294.0, 24233.0, 24723.25830225096, 26621.733782661926, 27184.592231116152, 27263.318417039733, 47574.0, 47680.84642666025, 48103.0, 48366.75816620894, 48752.26871596858, 39471.802640986614, 39489.802550987064, 39653.41386344514, 40597.39103913503, 41510.79244603758, 38558.42162367511, 39044.02389940274, 39151.804240978614, 39678.40482392824, 40409.0, 38374.0, 39603.0, 39946.20107597773, 40055.79972100121, 40064.0, 32973.83513082419, 35353.82323088368, 36227.637723623484, 36311.636883630825, 36411.45382819313, 26414.471710566064, 26647.733522664526, 26667.799949001954, 26759.0, 27075.1877443677], "value": 19424.58449618366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5561614013012, 390.69135383047376, 395.9980200099, 406.80473372781046, 418.591872923899, 19508.609827803437, 22478.66282005771, 22487.0, 22546.0, 22890.542189156207, 20507.282245121423, 20882.477938051557, 21106.89446552765, 21275.787242127575, 21762.911854407295, 5230.7646155922885, 5507.5593952483705, 5571.1086226203815, 5586.10622300432, 5589.273394458714, 4059.106996460774, 4161.687873409492, 4165.520965089008, 5518.751656175482, 5527.336719593654, 4189.832406703728, 4392.472903251598, 4478.664100192498, 6779.084823548807, 6857.314268573153, 6696.388408520681, 6784.694688739019, 6835.384815366616, 6852.6916288767125, 6853.109095817562, 5979.641221526722, 6011.759529618854, 6068.57519973602, 6090.208272924536, 6097.390260973912, 11619.941900290529, 13735.862641373558, 14057.859421405758, 14216.431342746278, 23613.70124643144, 2213.9446513837283, 2323.2913961241816, 2447.7185123710824, 2526.280010197085, 2762.1575419497044, 10111.7472063199, 10248.979449077406, 10557.41934193619, 10560.894391056068, 10582.259241853073, 1911.5794525204433, 1957.6769832977684, 1967.242611594532, 1999.480135164853, 2013.8187563119243, 97747.0, 131713.0, 142142.1571568573, 143013.28493357572, 143361.0, 11601.245919015237, 11765.411729413496, 11855.407229638484, 11890.227135236355, 12032.338221397908, 15325.6168595786, 15358.846411535966, 15359.308831102628, 15370.000949938218, 15375.769363459556, 8828.161324674145, 8928.821423571622, 8988.55057247135, 8990.0, 9068.637254509746, 8870.86693699595, 8910.287177025823, 8923.910760892439, 9026.63893444268, 9037.0, 4637.884052898705, 4649.349091127245, 4660.627149828006, 4674.859754207379, 4708.081924024782, 1588.8728901687837, 1958.9412317630495, 1959.3240332085409, 1959.7746259180376, 1963.646543622133, 860.7331727164599, 869.2958703450225, 948.9620415183454, 1022.1720406470782, 1040.953157107932, 20639.0, 22286.55426891453, 22381.776182238296, 22415.55168896613, 22454.663180052314, 941.7127776028377, 944.9804743782151, 979.9314048016713, 995.7759504111517, 998.32612986234, 11273.774524509628, 11628.709282267842, 11697.2981621103, 11702.2978621283, 11762.88237117635, 603006.0, 604468.0, 609837.0, 620657.8967105135, 624507.0, 73718.63140684369, 122986.77013229932, 125987.0, 126149.0, 128463.35768321098, 983.5524836199512, 1006.9647562335283, 1050.2595670052594, 1050.4170185547096, 1052.8526006359116, 19160.520986975436, 19412.902935485232, 19727.802721972595, 19774.90112549428, 19803.306884259557, 54564.908701826535, 55673.0, 56081.71959140178, 56253.0, 56739.0, 81346.0, 81480.0, 82202.58898705468, 83068.58465707632, 86077.56961215154, 8322.875156872531, 8460.915390846012, 8553.0, 8567.914320856711, 8641.02576825951, 10800.675979720621, 13002.349882505649, 13462.192268463923, 13659.0, 13986.370613322628, 11456.312621242752, 11547.422628868355, 11841.0, 12107.636770896886, 12148.75702485963, 11182.944085279521, 11402.429878506207, 11780.880816322435, 11915.761684766083, 12093.15347925672, 11466.713332166762, 11575.826362604399, 11909.464074116513, 12076.215046022331, 12095.939520302341, 7363.595002274927, 7598.354139898171, 7787.844243114992, 8441.198086182048, 8609.48343099416, 8414.242718155396, 11225.214235003472, 11480.138989575982, 11684.240524365889, 11965.700857478632], "value": 9695.94662883965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.396047719243, 1512.689898570793, 1516.8938174327795, 1722.5951901303192, 1899.2023350192917, 8025.0, 8533.104024077467, 8849.380543361967, 9169.449833010023, 9180.219681327095, 9036.774080647987, 9120.817583648322, 9139.086091390858, 9144.588493517791, 9148.542572871347, 2415.263344679872, 2434.1845481763544, 2447.645091461737, 2448.3144719478573, 2450.3629056445275, 2377.1442280778906, 2410.9035638574437, 2420.588499955003, 2421.1889017179265, 2423.9151629692965, 2386.522695460906, 2412.1316326122583, 2412.8552286862846, 2418.661387405765, 2426.2357357432443, 2374.2402431221844, 2385.7494963028894, 2390.438247011968, 2390.8685022323853, 2399.292208798391, 2356.681847950539, 2387.39121524012, 2387.6299173628117, 2391.3977634984603, 2395.616701327797, 8810.339224558184, 8913.688020919237, 9106.544672766402, 9113.726588202364, 9115.954420227923, 5406.8918621627345, 5578.135389014709, 5650.491455769001, 5653.236813030229, 5669.744861481243, 3704.592494825567, 3713.591504934455, 3758.849646014156, 3803.6957043436737, 3807.9238415231816, 1046.1526163807341, 1049.92125590581, 1126.3467189030425, 1130.2145009218596, 1140.4012893231038, 11916.165868389216, 11932.04543636507, 12070.155089143764, 12081.033517318681, 12091.45588448522, 4887.3890763654545, 4895.804167833318, 4946.530079642428, 5044.54599086084, 5045.628554579342, 10399.53202105907, 10403.271770976111, 10413.062824345845, 10436.843447348296, 10547.367157970546, 4712.976435117803, 5606.990741666457, 5618.325800903917, 5618.831435056954, 5664.980303545319, 3798.620137986179, 4102.958970410257, 4758.1673207188605, 5085.160948443466, 5131.7177555234075, 4102.856400026045, 4167.666586673059, 4206.221848957953, 4220.409142720022, 4235.30117530604, 1282.504116649169, 1313.185824788637, 1323.232525135419, 1327.8340207474066, 1330.5143622577689, 884.5135175653365, 895.5566994337845, 915.9404638698463, 931.2503434735104, 933.5005771911995, 5771.220885180447, 5856.857912706982, 5921.230240068763, 6073.210482637229, 6150.477209437158, 447.3826119954442, 451.6477147824702, 459.43030642004345, 465.06289826000636, 466.32615870068105, 3297.7032067114073, 3625.873094441682, 3969.226000929849, 3992.401139829049, 4107.507099148122, 10656.413897235727, 11182.0, 11185.384803835705, 11193.608223712294, 11203.103751700008, 11122.66632001025, 11123.0, 11128.944355278334, 11129.944350278196, 11132.777344453227, 8060.153683863227, 8372.204640559137, 8429.283510901641, 8431.19903609156, 8476.660933562713, 5206.947930520646, 6022.066579680157, 6047.395260473917, 6077.6961151943115, 6131.233595800525, 9923.206143508358, 10116.0, 10378.636747713794, 10512.26414151002, 10538.0, 9616.75958101053, 10401.427921464392, 10564.260501764802, 10584.84122738175, 10695.786084278427, 7026.437884969292, 7746.0, 7828.0, 7925.960370198112, 7931.2068793120225, 8440.746777596682, 8466.619002145042, 8500.107488713596, 8560.614772335135, 8662.0, 7658.195889431529, 7681.308682218403, 7705.922940770521, 7725.806854828675, 7760.68957241704, 7510.436717246119, 7542.924570754222, 7544.811379715551, 7571.962140189264, 7586.734464293723, 6822.044913711985, 6922.307769223037, 7051.506394552537, 7188.101487314086, 7256.492045556761, 5044.495550444926, 5071.644984851173, 5077.441481436965, 5113.8721531962, 5166.018456493254, 5036.647434679538, 5058.241263810458, 5082.872928176826, 5180.792768289226, 5209.843704688866], "value": 4611.895844630729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.87797758874035, 312.9718873500551, 321.52574951945877, 325.5913828145677, 325.8094015001224, 5254.316938797961, 5311.309529761131, 5511.421300763413, 5545.861353466165, 5619.522340601049, 4191.580841915807, 4635.374224479694, 5150.768215430306, 5337.0, 5567.661582135503, 4220.36694495825, 4239.43514173925, 4253.851115210969, 4272.487301523822, 4301.505326887401, 3317.7179939705034, 3938.310795610771, 4187.183499217654, 4231.70378073535, 4246.851360202393, 3959.4060890866313, 4174.290370636983, 4218.831246750126, 4232.894177645553, 4264.741901139171, 3508.7894726316504, 3977.6817854571564, 4200.983527906591, 4229.0546348679645, 4238.982644165409, 3687.797171155585, 3693.4829123922673, 3702.537497688398, 3703.518542589473, 3728.7949162796035, 4479.596836284717, 4499.640028797721, 4873.463918968911, 5234.6335756497065, 5345.786168553253, 4201.949512621844, 4804.807807687688, 4873.049755297719, 4919.901601967977, 4940.654154209206, 5802.7098645068, 5804.43280314317, 5843.795467158629, 5850.912236316416, 5883.38224486427, 3495.5455790747296, 3988.062805240766, 4103.179364127186, 4104.056067104553, 4109.198706252282, 4907.411110666707, 6121.846953826145, 6127.660425068349, 6140.600860944069, 6149.538784591129, 3966.7421617594764, 4179.164167166578, 4190.979045104755, 4198.685098617616, 4228.4080228768, 3551.3785087609567, 3756.3050835595504, 4249.830006799693, 4265.637420819203, 4318.352247162888, 4004.5795191505053, 4806.975965120222, 4875.878103047452, 4891.95108048915, 4903.803847846118, 4838.879028024327, 5861.560382971209, 5879.617824841372, 5886.264216972879, 5913.881722365529, 1329.9335033248299, 1363.6863521390135, 1429.756941319978, 1442.5744405400221, 1452.6876721504927, 729.5513259345464, 804.9034115906129, 848.1433751910615, 891.4651209274383, 942.853857652065, 3780.432935059763, 3888.9222215556097, 4173.622704507506, 4240.915181696349, 4384.12317536494, 3943.4479172915817, 4274.914501710011, 4379.671524635602, 4501.3248012797685, 4614.584687378152, 3770.378737143, 4175.728577642443, 4477.731336119843, 4556.681032327705, 4664.95335046652, 3088.8108078389982, 3101.0231776990177, 3108.1249843894307, 3110.7666924980717, 3113.2839446926882, 5119.846404607868, 5160.664556803796, 5165.269634672427, 6095.908561371583, 6241.225462521175, 4685.367475390779, 5627.820281540916, 6042.486388656926, 6062.605930614496, 6151.84620384494, 5381.515663590218, 6025.975584150792, 6185.474234690012, 6190.721417536221, 6194.473469755031, 5665.178549110438, 5794.942050579441, 5897.321807991964, 6004.418100216949, 6065.029595264737, 5157.6647517911215, 5580.804671836466, 5646.983542962306, 5882.294124705063, 5901.704914754331, 5918.940810592011, 6177.382261773787, 6214.613035895358, 6235.469985051322, 6256.436920677161, 3764.5670747864347, 3961.8811435656976, 3966.1076257841755, 4012.478377810866, 4060.7563546186143, 5163.3545806774155, 5875.353711091862, 5956.24756403463, 6016.75095448453, 6030.517558595389, 4844.539768721966, 5364.2490051393615, 5536.889262214814, 5807.593468457337, 5942.0, 5162.174052151638, 5547.861303467445, 5780.930527852361, 5879.853003674943, 5902.881942361043, 5430.185472179047, 5441.782328706808, 5585.748641311232, 5665.915011274917, 5666.801661941812, 5407.701726766188, 5579.465646947122, 5717.740887693974, 5789.8263052108505, 5792.420757924174, 4667.276572131325, 4865.691329895563, 5502.339719233718, 5603.10350343943, 5641.323041235078], "value": 4143.469306098634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4095100046326, 738.6085374751382, 789.4473868292197, 823.1274848660419, 824.7855557555034, 15982.200889955498, 16822.915885420585, 16828.57928551787, 16849.494515164533, 16852.74720879186, 15087.773683394758, 15172.0, 15192.696146077073, 15195.54413367598, 15199.392024319013, 698.7938558125339, 706.4524993130314, 843.877637742527, 849.562475325208, 864.9870251946226, 853.2022558907411, 858.772425307294, 861.8060936289316, 863.1541089732067, 863.8401895649325, 897.8832751742265, 900.1493588558815, 900.5092224737501, 900.5857305639414, 900.8468560344758, 893.8435773739635, 894.6197865906963, 895.4269267668698, 896.318797713739, 898.8651702244683, 657.3820608627874, 659.1628631637841, 660.9669516524202, 663.1312979996172, 664.2925284571916, 15804.446844360393, 15824.44614438489, 15841.0, 15861.206939653086, 15940.442084526985, 12033.93983030088, 15073.397064117422, 15139.697206055927, 15207.543773686808, 15251.923740381339, 12171.93914030433, 12329.321887296195, 12331.691707707289, 12332.938335308356, 12486.875131248753, 4001.97999010006, 4015.2371049500503, 4019.799010049515, 4027.335489644205, 4105.548389677163, 105310.0, 109078.0, 109379.0, 114723.85276147215, 118877.0, 10011.49942502872, 11027.944860275647, 11588.88411115895, 11780.469878855472, 11999.220050696676, 22737.658935115986, 22741.772582273967, 22745.431364215696, 22749.31752047441, 22806.65790013151, 8043.155468675822, 8185.140560241208, 8215.465994710325, 8450.323974082059, 8622.741317760478, 4513.413256276663, 4517.254652982221, 4635.142498637762, 4637.60580350674, 4783.258594917794, 3124.9218769530944, 3221.5650887130405, 3223.7259832913996, 3229.4994275887275, 3232.9191770205935, 654.1300070905684, 663.6416335179046, 711.1430725975188, 747.2490147401826, 749.3330935467438, 636.8630744389885, 677.7560078371782, 690.9861802763917, 709.1845869223647, 724.9130104387507, 9558.235341172689, 9861.457619830835, 9933.552990115462, 10120.645777397904, 10388.688339349832, 605.4823126227101, 619.2723549829022, 671.9025741267488, 677.2617846547189, 707.9398251148607, 4573.588377046081, 4751.691140075884, 4758.619310455155, 4775.856724298276, 4858.368412106403, 164320.0, 167951.0, 173123.26876731325, 174101.0, 175914.0, 92578.0, 92897.53551232336, 117111.0, 117932.0, 130518.0, 110003.0, 111992.88007119825, 113248.43375783069, 114566.85433145729, 117202.0, 9874.308798384043, 10476.319039262424, 10477.528511217166, 10500.159987201157, 10547.683569492927, 65740.0, 65862.67068664818, 66177.33822661712, 67277.66361168162, 72937.6353118231, 81517.59241203993, 105075.94924050967, 105816.41275381029, 112019.0, 115801.0, 13979.580612581638, 14426.0, 14744.778828317369, 15324.693506129592, 15766.0, 16191.75712364339, 16464.588385290463, 16488.67022659516, 17046.74316486762, 17076.829231707525, 14580.562583122522, 14622.195779232245, 15057.397704091714, 15476.458323958608, 15741.842581574037, 14879.404823806926, 14915.105093694414, 15018.24908754536, 15267.3893044277, 15739.842601573837, 11485.540578377106, 13661.453541858215, 13907.930460347634, 13926.860731392557, 14331.85668143347, 11645.47595358194, 12124.575639852563, 12161.81757273624, 12382.442790074288, 12541.874581254071, 11990.880091198977, 12018.278903265482, 12058.51765929388, 12085.51657933708, 12418.627441176417], "value": 8192.280738339738, "unit": "score"}], "name": "dromaeo_css", "value": 7447.336647746878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 111.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 108.0, 142.0, 108.0, 107.0, 111.0, 105.0, 142.0, 107.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 258.0, 182.0, 186.0, 183.0, 181.0, 184.0, 185.0, 182.0, 184.0], "value": 191.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 59.0, 90.0, 60.0, 58.0, 59.0, 58.0, 85.0, 74.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 94.0, 69.0, 67.0, 69.0, 91.0, 66.0, 68.0, 88.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 87.0, 84.0, 86.0, 83.0, 86.0, 83.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 92.0, 91.0, 92.0, 91.0, 91.0, 92.0, 92.0, 92.0], "value": 91.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 52.0, 53.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 72.0, 70.0, 72.0, 69.0, 68.0, 69.0, 68.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 83.0, 83.0, 87.0, 87.0, 89.0, 109.0, 108.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 142.0, 143.0, 146.0, 148.0, 136.0, 125.0, 199.0, 155.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 166.0, 162.0, 161.0, 164.0, 160.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 65.0, 64.0, 64.0, 64.0, 66.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1416.8, "alertThreshold": 2.0}]} 01:15:24 INFO - Return code: 0 01:15:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:15:24 INFO - # TBPL SUCCESS # 01:15:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:15:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:15:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:15:24 INFO - 2016-12-22 01:15:24.252 screenresolution[2616:300592] starting screenresolution argv=screenresolution get 01:15:24 INFO - 2016-12-22 01:15:24.255 screenresolution[2616:300592] Display 0: 1600x1200x32@60 01:15:24 INFO - 2016-12-22 01:15:24.261 screenresolution[2617:300595] starting screenresolution argv=screenresolution list 01:15:24 INFO - Available Modes on Display 0 01:15:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:15:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:15:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:15:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:15:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:15:24 INFO - Intel Iris: 01:15:24 INFO - Chipset Model: Intel Iris 01:15:24 INFO - Type: GPU 01:15:24 INFO - Bus: Built-In 01:15:24 INFO - VRAM (Dynamic, Max): 1536 MB 01:15:24 INFO - Vendor: Intel (0x8086) 01:15:24 INFO - Device ID: 0x0a2e 01:15:24 INFO - Revision ID: 0x0009 01:15:24 INFO - Displays: 01:15:24 INFO - Display: 01:15:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:15:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:15:24 INFO - Display Serial Number: 1600x1200 60 01:15:24 INFO - Main Display: Yes 01:15:24 INFO - Mirror: Off 01:15:24 INFO - Online: Yes 01:15:24 INFO - Rotation: Supported 01:15:24 INFO - Return code: 0 01:15:24 INFO - Running post-action listener: _resource_record_post_action 01:15:24 INFO - [mozharness: 2016-12-22 09:15:24.496547Z] Finished run-tests step (success) 01:15:24 INFO - Running post-run listener: _resource_record_post_run 01:15:24 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 360448; Write bytes: 496099328; Read time: 4; Write time: 1590 01:15:24 INFO - TinderboxPrint: CPU usage
53.3% 01:15:24 INFO - TinderboxPrint: I/O read bytes / time
360,448 / 4 01:15:24 INFO - TinderboxPrint: I/O write bytes / time
496,099,328 / 1,590 01:15:24 INFO - TinderboxPrint: CPU idle
2,235.0 (46.7%) 01:15:24 INFO - TinderboxPrint: CPU system
957.1 (20.0%) 01:15:24 INFO - TinderboxPrint: CPU user
1,589.5 (33.2%) 01:15:24 INFO - TinderboxPrint: Swap in / out
194,928,640 / 0 01:15:24 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183353856; Write bytes: 180449792; Read time: 16762; Write time: 414 01:15:24 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 360448; Write bytes: 295636480; Read time: 4; Write time: 1119 01:15:24 INFO - Running post-run listener: _upload_blobber_files 01:15:24 INFO - Blob upload gear active. 01:15:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:15:24 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 01:15:24 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'] 01:15:24 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 01:15:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:15:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:15:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:26 INFO - (blobuploader) - INFO - Done attempting. 01:15:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:15:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:27 INFO - (blobuploader) - INFO - Done attempting. 01:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:30 INFO - (blobuploader) - INFO - Done attempting. 01:15:30 INFO - (blobuploader) - INFO - Iteration through files over. 01:15:30 INFO - Return code: 0 01:15:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:15:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:15:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5e02d0502959ad303aa4aa8f4d2e36d122b172588668a058bd932d1461f915ed09a62b88bd7852036a0349216119a99d54d067b9600c45833b6c09b6cb5f4bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53e1f24dda9b959866b268fc5a4fd38afff8f4398c87411ac85c8e286ff80f8d0f04ffc30519869241e9121e0d5089799dd0b21a9f9aaeabbba0fe62bef776af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7f0a32ec337765283fb25ae9cc0f7a76709c0e0eff68273d9a080d92e32f68793f700f5d752c70b27054b29b415f2c50f5082accd9e35c0f4a814589e43609"} 01:15:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:15:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:15:30 INFO - Contents: 01:15:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5e02d0502959ad303aa4aa8f4d2e36d122b172588668a058bd932d1461f915ed09a62b88bd7852036a0349216119a99d54d067b9600c45833b6c09b6cb5f4bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53e1f24dda9b959866b268fc5a4fd38afff8f4398c87411ac85c8e286ff80f8d0f04ffc30519869241e9121e0d5089799dd0b21a9f9aaeabbba0fe62bef776af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7f0a32ec337765283fb25ae9cc0f7a76709c0e0eff68273d9a080d92e32f68793f700f5d752c70b27054b29b415f2c50f5082accd9e35c0f4a814589e43609"} 01:15:30 INFO - Running post-run listener: copy_logs_to_upload_dir 01:15:30 INFO - Copying logs to upload dir... 01:15:30 INFO - mkdir: /builds/slave/test/build/upload/logs 01:15:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.688363 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-22 01:15:30.184560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 01:15:30.187959) ========= 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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/d5e02d0502959ad303aa4aa8f4d2e36d122b172588668a058bd932d1461f915ed09a62b88bd7852036a0349216119a99d54d067b9600c45833b6c09b6cb5f4bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53e1f24dda9b959866b268fc5a4fd38afff8f4398c87411ac85c8e286ff80f8d0f04ffc30519869241e9121e0d5089799dd0b21a9f9aaeabbba0fe62bef776af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7f0a32ec337765283fb25ae9cc0f7a76709c0e0eff68273d9a080d92e32f68793f700f5d752c70b27054b29b415f2c50f5082accd9e35c0f4a814589e43609"} build_url:https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/CxQgAS9ZTGGYkqWjWz6Azg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d5e02d0502959ad303aa4aa8f4d2e36d122b172588668a058bd932d1461f915ed09a62b88bd7852036a0349216119a99d54d067b9600c45833b6c09b6cb5f4bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53e1f24dda9b959866b268fc5a4fd38afff8f4398c87411ac85c8e286ff80f8d0f04ffc30519869241e9121e0d5089799dd0b21a9f9aaeabbba0fe62bef776af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c7f0a32ec337765283fb25ae9cc0f7a76709c0e0eff68273d9a080d92e32f68793f700f5d752c70b27054b29b415f2c50f5082accd9e35c0f4a814589e43609"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 01:15:30.222317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 01:15:30.222652) ========= 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.5c4TTJgVDb/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.Gk4BpSkdrf/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005270 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 01:15:30.272995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 01:15:30.273537) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 01:15:30.274094) ========= ========= Total master_lag: 0.20 =========