builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0380 starttime: 1479151571.79 results: success (0) buildid: 20161114081643 builduid: da4be81bc0254b29b4f65eae2dfacea3 revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:11.792492) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:11.792895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:11.793178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:11.817543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:11.817801) ========= 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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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-11-14 11:26:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.9M=0s 2016-11-14 11:26:12 (24.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:12.038461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:12.038770) ========= 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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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.025478 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:12.086399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:26:12.086712) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --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 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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-11-14 11:26:12,175 truncating revision to first 12 chars 2016-11-14 11:26:12,175 Setting DEBUG logging. 2016-11-14 11:26:12,175 attempt 1/10 2016-11-14 11:26:12,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ed88686e49e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:26:12,949 unpacking tar archive at: mozilla-beta-4ed88686e49e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052634 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:26:13.161481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:13.161804) ========= script_repo_revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:13.162211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:13.162477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:26:13.181578) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-14 11:26:13.181871) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:13 INFO - MultiFileLogger online at 20161114 11:26:13 in /builds/slave/test 11:26:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:26:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:13 INFO - {'append_to_log': False, 11:26:13 INFO - 'base_work_dir': '/builds/slave/test', 11:26:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:26:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:13 INFO - 'branch': 'Mozilla-Beta', 11:26:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:13 INFO - 'config_files': ('talos/mac_config.py',), 11:26:13 INFO - 'default_actions': ('clobber', 11:26:13 INFO - 'read-buildbot-config', 11:26:13 INFO - 'download-and-extract', 11:26:13 INFO - 'populate-webroot', 11:26:13 INFO - 'create-virtualenv', 11:26:13 INFO - 'install', 11:26:13 INFO - 'run-tests'), 11:26:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:13 INFO - 'download_minidump_stackwalk': True, 11:26:13 INFO - 'download_symbols': 'ondemand', 11:26:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:13 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:13 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:13 INFO - 'installer_path': 'installer.exe', 11:26:13 INFO - 'log_level': 'info', 11:26:13 INFO - 'log_name': 'talos', 11:26:13 INFO - 'log_to_console': True, 11:26:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:26:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:26:13 INFO - 'opt_config_files': (), 11:26:13 INFO - 'pip_index': False, 11:26:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:13 INFO - 'cmd': ('bash', 11:26:13 INFO - '-c', 11:26:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:13 INFO - 'enabled': True, 11:26:13 INFO - 'halt_on_failure': False, 11:26:13 INFO - 'name': 'check_screen_resolution'},), 11:26:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:13 INFO - 'cmd': ('bash', 11:26:13 INFO - '-c', 11:26:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:13 INFO - 'enabled': True, 11:26:13 INFO - 'halt_on_failure': False, 11:26:13 INFO - 'name': 'check_screen_resolution'},), 11:26:13 INFO - 'run_cmd_checks_enabled': True, 11:26:13 INFO - 'sps_profile': False, 11:26:13 INFO - 'sps_profile_interval': 0, 11:26:13 INFO - 'suite': 'dromaeojs-e10s', 11:26:13 INFO - 'system_bits': '32', 11:26:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:13 INFO - 'title': 't-yosemite-r7-0380', 11:26:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:13 INFO - 'use_talos_json': True, 11:26:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:13 INFO - 'work_dir': 'build'} 11:26:13 INFO - [mozharness: 2016-11-14 19:26:13.402440Z] Running clobber step. 11:26:13 INFO - Running pre-action listener: _resource_record_pre_action 11:26:13 INFO - Running main action method: clobber 11:26:13 INFO - rmtree: /builds/slave/test/build 11:26:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:15 INFO - Running post-action listener: _resource_record_post_action 11:26:15 INFO - [mozharness: 2016-11-14 19:26:15.837392Z] Finished clobber step (success) 11:26:15 INFO - [mozharness: 2016-11-14 19:26:15.837531Z] Running read-buildbot-config step. 11:26:15 INFO - Running pre-action listener: _resource_record_pre_action 11:26:15 INFO - Running main action method: read_buildbot_config 11:26:15 INFO - Using buildbot properties: 11:26:15 INFO - { 11:26:15 INFO - "project": "", 11:26:15 INFO - "product": "firefox", 11:26:15 INFO - "script_repo_revision": "production", 11:26:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:26:15 INFO - "repository": "", 11:26:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:26:15 INFO - "buildid": "20161114081643", 11:26:15 INFO - "pgo_build": "False", 11:26:15 INFO - "basedir": "/builds/slave/test", 11:26:15 INFO - "buildnumber": 0, 11:26:15 INFO - "slavename": "t-yosemite-r7-0380", 11:26:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:26:15 INFO - "platform": "yosemite_r7", 11:26:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:26:15 INFO - "branch": "mozilla-beta", 11:26:15 INFO - "repo_path": "releases/mozilla-beta", 11:26:15 INFO - "revision": "4ed88686e49e3b941dd9b01f2f5c038f53187a05", 11:26:15 INFO - "stage_platform": "macosx64", 11:26:15 INFO - "builduid": "da4be81bc0254b29b4f65eae2dfacea3", 11:26:15 INFO - "slavebuilddir": "test" 11:26:15 INFO - } 11:26:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:26:15 INFO - Running post-action listener: _resource_record_post_action 11:26:15 INFO - [mozharness: 2016-11-14 19:26:15.840906Z] Finished read-buildbot-config step (success) 11:26:15 INFO - [mozharness: 2016-11-14 19:26:15.841039Z] Running download-and-extract step. 11:26:15 INFO - Running pre-action listener: _resource_record_pre_action 11:26:15 INFO - Running main action method: download_and_extract 11:26:15 INFO - mkdir: /builds/slave/test/build/tests 11:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:15 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:26:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/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 11:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/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 11:26:17 INFO - Downloaded 1165 bytes. 11:26:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:26:17 INFO - Using the following test package requirements: 11:26:17 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:26:17 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:26:17 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:26:17 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:26:17 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:26:17 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:26:17 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:26:17 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:26:17 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:26:17 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:26:17 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:26:17 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:26:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:26:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:26:17 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:26:17 INFO - Expected file size: 16231351 11:26:24 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 11:26:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:26:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:26:24 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:26:25 INFO - Expected file size: 16231351 11:26:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:26:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:26:31 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:26:32 INFO - Expected file size: 14414089 11:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:33 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:26:33 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/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 11:26:35 INFO - Downloaded 86008559 bytes. 11:26:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:26:35 INFO - mkdir: /builds/slave/test/properties 11:26:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:35 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:35 INFO - Contents: 11:26:35 INFO - build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:26:36 INFO - Running post-action listener: _resource_record_post_action 11:26:36 INFO - Running post-action listener: set_extra_try_arguments 11:26:36 INFO - [mozharness: 2016-11-14 19:26:36.507096Z] Finished download-and-extract step (success) 11:26:36 INFO - [mozharness: 2016-11-14 19:26:36.507234Z] Running populate-webroot step. 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: populate_webroot 11:26:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:36 INFO - '--tppagecycles', 11:26:36 INFO - '7'], 11:26:36 INFO - 'tests': ['tsvgm']}}, 11:26:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['damp', 'tps']}, 11:26:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'tests': ['damp', 'tps']}, 11:26:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['dromaeo_dom']}, 11:26:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['basic_compositor_video']}, 11:26:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:26:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['a11yr', 11:26:36 INFO - 'ts_paint', 11:26:36 INFO - 'tpaint', 11:26:36 INFO - 'sessionrestore', 11:26:36 INFO - 'sessionrestore_no_auto_restore', 11:26:36 INFO - 'tabpaint']}, 11:26:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['tsvgx', 11:26:36 INFO - 'tsvgr_opacity', 11:26:36 INFO - 'tart', 11:26:36 INFO - 'tscrollx', 11:26:36 INFO - 'cart']}, 11:26:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:36 INFO - 'tsvgr_opacity', 11:26:36 INFO - 'tart', 11:26:36 INFO - 'tscrollx', 11:26:36 INFO - 'cart']}, 11:26:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'talos_options': ['--disable-e10s'], 11:26:36 INFO - 'tests': ['tp5o']}, 11:26:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'tests': ['tp5o']}, 11:26:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'talos_options': ['--disable-e10s', 11:26:36 INFO - '--xperf_path', 11:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:36 INFO - 'tests': ['tp5n']}, 11:26:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:36 INFO - 'talos_options': ['--xperf_path', 11:26:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:36 INFO - 'tests': ['tp5n']}}, 11:26:36 INFO - 'talos.zip': {'path': '', 11:26:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:36 INFO - Running post-action listener: _resource_record_post_action 11:26:36 INFO - [mozharness: 2016-11-14 19:26:36.526005Z] Finished populate-webroot step (success) 11:26:36 INFO - [mozharness: 2016-11-14 19:26:36.526141Z] Running create-virtualenv step. 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: create_virtualenv 11:26:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:36 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 11:26:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:36 INFO - Using real prefix '/tools/python27' 11:26:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:40 INFO - Installing pip.................done. 11:26:40 INFO - Return code: 0 11:26:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:40 INFO - 'HOME': '/Users/cltbld', 11:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PAGER': '/bin/cat', 11:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test', 11:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:40 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:40 INFO - 'XPC_FLAGS': '0x0', 11:26:40 INFO - 'XPC_SERVICE_NAME': '0', 11:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:26:40 INFO - Cleaning up... 11:26:40 INFO - Return code: 0 11:26:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:40 INFO - 'HOME': '/Users/cltbld', 11:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PAGER': '/bin/cat', 11:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test', 11:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:40 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:40 INFO - 'XPC_FLAGS': '0x0', 11:26:40 INFO - 'XPC_SERVICE_NAME': '0', 11:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:40 INFO - Downloading/unpacking psutil>=3.1.1 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:44 INFO - Installing collected packages: psutil 11:26:44 INFO - Running setup.py install for psutil 11:26:44 INFO - building 'psutil._psutil_osx' extension 11:26:44 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 11:26:44 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 11:26:44 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 11:26:44 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 11:26:44 INFO - building 'psutil._psutil_posix' extension 11:26:44 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 11:26:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:26:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:26:44 INFO - ^ 11:26:44 INFO - 1 warning generated. 11:26:44 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 11:26:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:45 INFO - Successfully installed psutil 11:26:45 INFO - Cleaning up... 11:26:45 INFO - Return code: 0 11:26:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:45 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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:45 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 11:26:45 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 11:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:45 INFO - 'HOME': '/Users/cltbld', 11:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:45 INFO - 'LOGNAME': 'cltbld', 11:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:45 INFO - 'MOZ_NO_REMOTE': '1', 11:26:45 INFO - 'NO_EM_RESTART': '1', 11:26:45 INFO - 'PAGER': '/bin/cat', 11:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:45 INFO - 'PWD': '/builds/slave/test', 11:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:45 INFO - 'SHELL': '/bin/bash', 11:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:45 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:45 INFO - 'USER': 'cltbld', 11:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:45 INFO - 'XPC_FLAGS': '0x0', 11:26:45 INFO - 'XPC_SERVICE_NAME': '0', 11:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:48 INFO - Installing collected packages: mozsystemmonitor 11:26:48 INFO - Running setup.py install for mozsystemmonitor 11:26:48 INFO - Successfully installed mozsystemmonitor 11:26:48 INFO - Cleaning up... 11:26:48 INFO - Return code: 0 11:26:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:48 INFO - 'HOME': '/Users/cltbld', 11:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:48 INFO - 'LOGNAME': 'cltbld', 11:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:48 INFO - 'MOZ_NO_REMOTE': '1', 11:26:48 INFO - 'NO_EM_RESTART': '1', 11:26:48 INFO - 'PAGER': '/bin/cat', 11:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:48 INFO - 'PWD': '/builds/slave/test', 11:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:48 INFO - 'SHELL': '/bin/bash', 11:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:48 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:48 INFO - 'USER': 'cltbld', 11:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:48 INFO - 'XPC_FLAGS': '0x0', 11:26:48 INFO - 'XPC_SERVICE_NAME': '0', 11:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:51 INFO - warning: no files found matching '*.txt' 11:26:51 INFO - no previously-included directories found matching 'build' 11:26:51 INFO - no previously-included directories found matching 'dist' 11:26:51 INFO - no previously-included directories found matching '.git*' 11:26:51 INFO - Installing collected packages: jsonschema, functools32 11:26:51 INFO - Running setup.py install for functools32 11:26:51 INFO - warning: no files found matching '*.txt' 11:26:51 INFO - no previously-included directories found matching 'build' 11:26:51 INFO - no previously-included directories found matching 'dist' 11:26:51 INFO - no previously-included directories found matching '.git*' 11:26:51 INFO - Successfully installed jsonschema functools32 11:26:51 INFO - Cleaning up... 11:26:51 INFO - Return code: 0 11:26:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:51 INFO - 'HOME': '/Users/cltbld', 11:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:51 INFO - 'LOGNAME': 'cltbld', 11:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:51 INFO - 'MOZ_NO_REMOTE': '1', 11:26:51 INFO - 'NO_EM_RESTART': '1', 11:26:51 INFO - 'PAGER': '/bin/cat', 11:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:51 INFO - 'PWD': '/builds/slave/test', 11:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:51 INFO - 'SHELL': '/bin/bash', 11:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:51 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:51 INFO - 'USER': 'cltbld', 11:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:51 INFO - 'XPC_FLAGS': '0x0', 11:26:51 INFO - 'XPC_SERVICE_NAME': '0', 11:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:26:52 INFO - Cleaning up... 11:26:52 INFO - Return code: 0 11:26:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:52 INFO - 'HOME': '/Users/cltbld', 11:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:52 INFO - 'LOGNAME': 'cltbld', 11:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:52 INFO - 'MOZ_NO_REMOTE': '1', 11:26:52 INFO - 'NO_EM_RESTART': '1', 11:26:52 INFO - 'PAGER': '/bin/cat', 11:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:52 INFO - 'PWD': '/builds/slave/test', 11:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:52 INFO - 'SHELL': '/bin/bash', 11:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:52 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:52 INFO - 'USER': 'cltbld', 11:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:52 INFO - 'XPC_FLAGS': '0x0', 11:26:52 INFO - 'XPC_SERVICE_NAME': '0', 11:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:54 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 11:26:54 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 11:26:54 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 11:26:54 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 11:26:54 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 11:26:54 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 11:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:56 INFO - Downloading docopt-0.6.1.tar.gz 11:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:56 INFO - Running setup.py install for blobuploader 11:26:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:56 INFO - Running setup.py install for requests 11:26:56 INFO - Running setup.py install for docopt 11:26:56 INFO - Successfully installed blobuploader requests docopt 11:26:56 INFO - Cleaning up... 11:26:57 INFO - Return code: 0 11:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:57 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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:26:57 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 11:26:57 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 11:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:57 INFO - 'HOME': '/Users/cltbld', 11:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:57 INFO - 'LOGNAME': 'cltbld', 11:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:57 INFO - 'MOZ_NO_REMOTE': '1', 11:26:57 INFO - 'NO_EM_RESTART': '1', 11:26:57 INFO - 'PAGER': '/bin/cat', 11:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:57 INFO - 'PWD': '/builds/slave/test', 11:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:57 INFO - 'SHELL': '/bin/bash', 11:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:26:57 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:57 INFO - 'USER': 'cltbld', 11:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:57 INFO - 'XPC_FLAGS': '0x0', 11:26:57 INFO - 'XPC_SERVICE_NAME': '0', 11:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-cg1TP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-i4A7dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-51qVru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-ui52Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-TUzCUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-BHIhW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:57 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-KEmt8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-saTFAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dLyduu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-xGUSWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-CfLDrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-4UJNtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-Zat7bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-FpYiC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-bxJNo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:58 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dSGm49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:59 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dK0lEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:59 INFO - Running setup.py install for manifestparser 11:26:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:59 INFO - Running setup.py install for mozcrash 11:26:59 INFO - Running setup.py install for mozdebug 11:26:59 INFO - Running setup.py install for mozdevice 11:26:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:26:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:59 INFO - Running setup.py install for mozfile 11:26:59 INFO - Running setup.py install for mozhttpd 11:26:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Running setup.py install for mozinfo 11:27:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Running setup.py install for mozInstall 11:27:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Running setup.py install for mozleak 11:27:00 INFO - Running setup.py install for mozlog 11:27:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Running setup.py install for moznetwork 11:27:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:00 INFO - Running setup.py install for mozprocess 11:27:00 INFO - Running setup.py install for mozprofile 11:27:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:01 INFO - Running setup.py install for mozrunner 11:27:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:01 INFO - Running setup.py install for mozscreenshot 11:27:01 INFO - Running setup.py install for moztest 11:27:01 INFO - Running setup.py install for mozversion 11:27:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:01 INFO - Cleaning up... 11:27:01 INFO - Return code: 0 11:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:01 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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:27:01 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 11:27:01 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 11:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:01 INFO - 'HOME': '/Users/cltbld', 11:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:01 INFO - 'LOGNAME': 'cltbld', 11:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:01 INFO - 'MOZ_NO_REMOTE': '1', 11:27:01 INFO - 'NO_EM_RESTART': '1', 11:27:01 INFO - 'PAGER': '/bin/cat', 11:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:01 INFO - 'PWD': '/builds/slave/test', 11:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:01 INFO - 'SHELL': '/bin/bash', 11:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:27:01 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:01 INFO - 'USER': 'cltbld', 11:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:01 INFO - 'XPC_FLAGS': '0x0', 11:27:01 INFO - 'XPC_SERVICE_NAME': '0', 11:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:01 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-4_9utk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dCJNki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-PC3Cc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-gKjubP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-aGaGdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-KNbCa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-3ZX5iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-cIJXxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-tOf0Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:02 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)) 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:02 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-0uuqBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-OCgaTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-Py2XxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-26vG5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-sIYig2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-5zctd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-08Zydd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:03 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)) 11:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:03 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-Xgd0SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:03 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)) 11:27:03 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)) 11:27:03 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)) 11:27:03 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)) 11:27:03 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)) 11:27:03 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)) 11:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:03 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 11:27:03 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 11:27:03 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 11:27:03 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 11:27:03 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 11:27:03 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 11:27:06 INFO - Downloading blessings-1.6.tar.gz 11:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:06 INFO - Installing collected packages: blessings 11:27:06 INFO - Running setup.py install for blessings 11:27:06 INFO - Successfully installed blessings 11:27:06 INFO - Cleaning up... 11:27:06 INFO - Return code: 0 11:27:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:06 INFO - Reading from file tmpfile_stdout 11:27:06 INFO - Current package versions: 11:27:06 INFO - blessings == 1.6 11:27:06 INFO - blobuploader == 1.2.4 11:27:06 INFO - docopt == 0.6.1 11:27:06 INFO - functools32 == 3.2.3-2 11:27:06 INFO - jsonschema == 2.5.1 11:27:06 INFO - manifestparser == 1.1 11:27:06 INFO - mozInstall == 1.12 11:27:06 INFO - mozcrash == 0.17 11:27:06 INFO - mozdebug == 0.1 11:27:06 INFO - mozdevice == 0.48 11:27:06 INFO - mozfile == 1.2 11:27:06 INFO - mozhttpd == 0.7 11:27:06 INFO - mozinfo == 0.9 11:27:06 INFO - mozleak == 0.1 11:27:06 INFO - mozlog == 3.4 11:27:06 INFO - moznetwork == 0.27 11:27:06 INFO - mozprocess == 0.23 11:27:06 INFO - mozprofile == 0.28 11:27:06 INFO - mozrunner == 6.12 11:27:06 INFO - mozscreenshot == 0.1 11:27:06 INFO - mozsystemmonitor == 0.3 11:27:06 INFO - moztest == 0.7 11:27:06 INFO - mozversion == 1.4 11:27:06 INFO - psutil == 3.1.1 11:27:06 INFO - requests == 1.2.3 11:27:06 INFO - wsgiref == 0.1.2 11:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:27:06 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 11:27:06 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 11:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:06 INFO - 'HOME': '/Users/cltbld', 11:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:06 INFO - 'LOGNAME': 'cltbld', 11:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:06 INFO - 'MOZ_NO_REMOTE': '1', 11:27:06 INFO - 'NO_EM_RESTART': '1', 11:27:06 INFO - 'PAGER': '/bin/cat', 11:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:06 INFO - 'PWD': '/builds/slave/test', 11:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:06 INFO - 'SHELL': '/bin/bash', 11:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:27:06 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:06 INFO - 'USER': 'cltbld', 11:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:06 INFO - 'XPC_FLAGS': '0x0', 11:27:06 INFO - 'XPC_SERVICE_NAME': '0', 11:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 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)) 11:27:07 INFO - Cleaning up... 11:27:07 INFO - Return code: 0 11:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:07 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')]} 11:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:07 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')]} 11:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:07 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 0x10850f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108485570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb119ca9f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, '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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 11:27:07 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 11:27:07 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 11:27:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:27:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:07 INFO - 'HOME': '/Users/cltbld', 11:27:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:07 INFO - 'LOGNAME': 'cltbld', 11:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:07 INFO - 'MOZ_NO_REMOTE': '1', 11:27:07 INFO - 'NO_EM_RESTART': '1', 11:27:07 INFO - 'PAGER': '/bin/cat', 11:27:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:07 INFO - 'PWD': '/builds/slave/test', 11:27:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:07 INFO - 'SHELL': '/bin/bash', 11:27:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:27:07 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:27:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:07 INFO - 'USER': 'cltbld', 11:27:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:07 INFO - 'XPC_FLAGS': '0x0', 11:27:07 INFO - 'XPC_SERVICE_NAME': '0', 11:27:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:07 INFO - Cleaning up... 11:27:07 INFO - Return code: 0 11:27:07 INFO - Running post-action listener: _resource_record_post_action 11:27:07 INFO - Running post-action listener: _start_resource_monitoring 11:27:07 INFO - Starting resource monitoring. 11:27:07 INFO - [mozharness: 2016-11-14 19:27:07.502655Z] Finished create-virtualenv step (success) 11:27:07 INFO - [mozharness: 2016-11-14 19:27:07.503601Z] Running install step. 11:27:07 INFO - Running pre-action listener: _resource_record_pre_action 11:27:07 INFO - Running main action method: install 11:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:07 INFO - Reading from file tmpfile_stdout 11:27:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:07 INFO - Reading from file tmpfile_stdout 11:27:07 INFO - Output received: 11:27:07 INFO - Usage: mozinstall [options] installer 11:27:07 INFO - Options: 11:27:07 INFO - -h, --help show this help message and exit 11:27:07 INFO - -d DEST, --destination=DEST 11:27:07 INFO - Directory to install application into. [default: 11:27:07 INFO - "/builds/slave/test"] 11:27:07 INFO - --app=APP Application being installed. [default: firefox] 11:27:07 INFO - mkdir: /builds/slave/test/build/application 11:27:07 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'] 11:27:07 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 11:27:29 INFO - Reading from file tmpfile_stdout 11:27:29 INFO - Output received: 11:27:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:27:29 INFO - Running post-action listener: _resource_record_post_action 11:27:29 INFO - [mozharness: 2016-11-14 19:27:29.732120Z] Finished install step (success) 11:27:29 INFO - [mozharness: 2016-11-14 19:27:29.732251Z] Running run-tests step. 11:27:29 INFO - Running pre-action listener: _resource_record_pre_action 11:27:29 INFO - Running main action method: run_tests 11:27:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:27:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:27:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:27:29 INFO - 2016-11-14 11:27:29.746 screenresolution[1656:7581] starting screenresolution argv=screenresolution get 11:27:29 INFO - 2016-11-14 11:27:29.749 screenresolution[1656:7581] Display 0: 1600x1200x32@60 11:27:29 INFO - 2016-11-14 11:27:29.754 screenresolution[1657:7583] starting screenresolution argv=screenresolution list 11:27:29 INFO - Available Modes on Display 0 11:27:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:27:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:27:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:27:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:27:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:27:29 INFO - Intel Iris: 11:27:29 INFO - Chipset Model: Intel Iris 11:27:29 INFO - Type: GPU 11:27:29 INFO - Bus: Built-In 11:27:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:27:29 INFO - Vendor: Intel (0x8086) 11:27:29 INFO - Device ID: 0x0a2e 11:27:29 INFO - Revision ID: 0x0009 11:27:29 INFO - Displays: 11:27:29 INFO - Display: 11:27:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:27:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:27:29 INFO - Display Serial Number: 1600x1200 60 11:27:29 INFO - Main Display: Yes 11:27:29 INFO - Mirror: Off 11:27:29 INFO - Online: Yes 11:27:29 INFO - Rotation: Supported 11:27:29 INFO - Return code: 0 11:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:29 INFO - Python 2.7.3 11:27:29 INFO - Return code: 0 11:27:29 INFO - grabbing minidump binary from tooltool 11:27:29 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')]} 11:27:29 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 0x108323d30>, '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 0x108189db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10831bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:29 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 11:27:29 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 11:27:29 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 11:27:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:30 INFO - Return code: 0 11:27:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:27:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:27:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0380', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:27:30 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0380 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ty6jeDr6Yt/Render', 11:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:30 INFO - 'HOME': '/Users/cltbld', 11:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:30 INFO - 'LOGNAME': 'cltbld', 11:27:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:30 INFO - 'MOZ_NO_REMOTE': '1', 11:27:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:30 INFO - 'NO_EM_RESTART': '1', 11:27:30 INFO - 'PAGER': '/bin/cat', 11:27:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:30 INFO - 'PWD': '/builds/slave/test', 11:27:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:30 INFO - 'SHELL': '/bin/bash', 11:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GjEeOs4Prh/Listeners', 11:27:30 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 11:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:30 INFO - 'USER': 'cltbld', 11:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:30 INFO - 'XPC_FLAGS': '0x0', 11:27:30 INFO - 'XPC_SERVICE_NAME': '0', 11:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0380', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:27:30 INFO - mozversion application_buildid: 20161114081643 11:27:30 INFO - mozversion application_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:27:30 INFO - mozversion application_display_name: Firefox 11:27:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:30 INFO - mozversion application_name: Firefox 11:27:30 INFO - mozversion application_remotingname: firefox 11:27:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:30 INFO - mozversion application_vendor: Mozilla 11:27:30 INFO - mozversion application_version: 51.0 11:27:30 INFO - mozversion platform_buildid: 20161114081643 11:27:30 INFO - mozversion platform_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:27:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:30 INFO - mozversion platform_version: 51.0 11:27:30 INFO - using testdate: 1479151650 11:27:30 INFO - actual date: 1479151650 11:27:30 INFO - starting webserver on 'localhost:49278' 11:27:30 INFO - SUITE-START | Running 2 tests 11:27:30 INFO - TEST-START | dromaeo_css 11:27:30 INFO - operating with platform_type : mac_ 11:27:30 INFO - Initialising browser for dromaeo_css test... 11:27:30 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpA3dRj8/profile http://localhost:49278/getInfo.html) 11:27:32 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 11:27:32 INFO - PROCESS | 1667 | colorDepth:24 11:27:32 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 11:27:32 INFO - PROCESS | 1667 | __metrics 11:27:32 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 11:27:33 INFO - TEST-INFO | 1667: exit 0 11:27:33 INFO - Browser initialized. 11:27:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:33 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpA3dRj8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:45 INFO - PROCESS | 1671 | RSS: Main: 174264320 11:27:45 INFO - PROCESS | 1671 | 11:28:34 INFO - PROCESS | 1671 | 1479151714992 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] 11:30:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 11:30:47 INFO - PROCESS | 1671 | RSS: Main: 185638912 11:30:47 INFO - PROCESS | 1671 | 11:33:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 11:33:50 INFO - PROCESS | 1671 | RSS: Main: 196407296 11:33:50 INFO - PROCESS | 1671 | 11:36:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 11:36:52 INFO - PROCESS | 1671 | RSS: Main: 200454144 11:36:52 INFO - PROCESS | 1671 | 11:39:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 11:39:55 INFO - PROCESS | 1671 | RSS: Main: 204496896 11:39:55 INFO - PROCESS | 1671 | 11:42:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 11:42:58 INFO - PROCESS | 1671 | RSS: Main: 206594048 11:42:58 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 11:46:01 INFO - PROCESS | 1671 | RSS: Main: 207572992 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | __start_tp_report 11:46:01 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 11:46:01 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 11:46:01 INFO - PROCESS | 1671 | |i|pagename|runs| 11:46:01 INFO - PROCESS | 1671 | |0;dojo.html;2900.7389334959857;3585.8924232273007;3622.529071220741;3622.746407751457;3640.5631324241094;4986.252062190664;5741.167530708045;5983.640981541105;6080.665563394012;6087.147799308101;5950.285965684113;6027.095935609661;6033.7284822183;6054.273487181534;6059.787907423241;5384.542313903313;5466.535344495723;5526.143447765603;5527.972360138194;5530.972345138269;5523.889522209553;5532.972335138339;5533.114701647737;5561.944380556203;5571.415001424853;5420.7018613976215;5452.127659574468;5533.889322213553;5538.947599956015;5560.749766260507;4593.862184134481;5108.386993560796;5501.5323697485765;5504.311961004874;5571.359293681197;5378.139497680391;5458.426865179139;5474.206240095164;5476.945230547683;5491.752871120809;4879.8780030499165;6008.759649614054;6088.452039316483;6138.0179171332375;6153.446189842935;4953.504649535053;5794.101914203306;6217.160683307741;6274.403931626488;6286.119943207955;6381.872362552769;6406.487481001509;6436.195475565554;6487.6756162191705;6493.51298652603;6170.19787427636;6177.042558403455;6184.319724830265;6192.938070619236;6194.907076393858;6472.611643301417;6487.091807147003;6530.771423000172;6577.83555411109;6615.86768264632;6284.402981716729;6299.433051025429;6303.991361382157;6306.905396419057;6317.810465686037;6256.343083976208;6275.717592708248;6452.580582262138;6477.838054048687;6481.870362592722;6195.535334849904;6287.9056814147825;6329.082283068929;6370.649614271259;6387.010013447923;6337.2395312562785;6339.11252424661;6348.238211414659;6364.854326221324;6370.681465926685;5074;5185.818496352609;5257.78968841242;5262.421133675292;5287.576993840484;4444.511103778582;4468.017036252019;4579.862604121881;4591.449026116888;4652.697574657636;6087.482563982111;6179.567430279837;6227.595206311576;6252.562320637603;6264.091706702503;6426.742930282736;6451.774187903401;6454.548181627241;6479.611223326616;6503.317151699003;6077.9392206078255;6111.591738512148;6111.865232675468;6118.7410088057595;6182;5722.570807189478;5725.255716756878;5742.397048309951;5761.654300741969;5778;5345.812896548602;5563.360213575329;6636.270010298863;6640.302768209365;6680.064790929274;6236.906446403217;6298.212723409574;6388;6448.32292609288;6460.25707043696;6519.674016299071;6540.476761858945;6618.205815302194;6679.131712877295;6688.431483323972;6330.778422755181;6340.207474065742;6350.301466838551;6364.713587888648;6394.520410969289;6146.0473626587955;6358.427741503287;6375.203099612549;6418.807435776934;6443.613383197023;6206.224221972254;6258.155149055002;6273.466755325666;6276.717547710273;6312.715927783169;6279.183706118175;6280.246370435394;6288.811335659938;6296.496280297473;6298.590591611531;5056.418511871035;6147.108669243024;6186.628802271878;6206.596571222856;6286.27707813589;6178.011518157074;6192.907106393498;6204.534659900616;6233.96883015582;6245.8750824982335;6269.31037585856;6290.276618188784;6290.874182516232;6326.588771729823;6327.493800496041 11:46:01 INFO - PROCESS | 1671 | |1;ext.html;481.54734549523425;486.8777467936407;500.58701571203756;552.9861753456163;561.6124873837055;38389.42415863761;44405.33391999122;44492.55507444924;44528;44541.10917781646;42920;46290.53709462904;46557.7672111639;46685.533144668545;46849.29726054112;8313.210245026712;9344.579493922773;10391.53238104287;10402.375857448576;10408.115310198642;8661.35039872009;10090.74773130674;10170.084692377684;10246.180305575535;10289.279750417474;8766.780830479258;10193.133583645398;10245.334053286513;10255.435951022691;10294.897051029506;10233.744156396113;10294.588216471333;10338.328008679411;10344.017318354745;10363.430011349374;8726.301895848317;10121.443320617363;10138.087572118471;10179.949100254526;10262.07641312278;43755;44239;44275.77862110701;44309;44431.77784111091;3386.3565922474895;3583.516225309576;3642.071271825694;3856.2094770571966;3938.5273767147837;32323.676763232303;32801;33135;33157;33179.83410082958;3296.4066468035744;3360.1935535471557;3419.093940105874;3479.0954351868445;3481.704055155315;407144;538097;538636;543081.2845935784;544129;66214.66892665505;66280;66482.66758666272;66508;66620;35995.74014909466;36035.819820901255;36119.277614447565;37146.8142659285;37755.81122094372;18469.630607388044;18615.348462804006;18718.34485793018;18738.437846864617;18760.624787504446;14170.71658566823;14337.56987290383;14349.78475322871;14352.425902963765;14357.497487587885;20365.389038328874;20867.791322086887;20941.790582093985;20956;21016;8362;8464.746057618282;8505.74482765518;8550;8561.44350617208;867.8351113288455;1034.927555071153;1058.3491152940885;1080.9243352965375;1180.504188240941;31229.843850780602;32004.719811207757;32128.518072228937;32385.838070809965;32671;969.5733877094056;1052.6736711619421;1203.825445310425;1263.6398626391617;1280.423754548926;16418.589535261715;16442.424515142153;16495.83504164943;16639.50081497557;16837.663246734995;718903;723404;729338;731067;733751;61674.074888876705;62414;62542.37457625366;62655.6867215661;62719.6864015677;1422.665673566711;1445.0607105381587;1448.109412711175;1456.805419555954;1458.5478501664306;30521.694783051884;31064;32165.839170803996;32272.35455290928;32784.50823237701;55387;55698.443015569326;55768;55787;55791;620464;624054;627722;628610;628747;27799.583006254517;28158;28563.571546427236;29123;29182.27044323909;52305.43083707495;52306.692332691986;52672;55314.61713457035;55834.441655584546;41700;43490.912727182076;46139.30791038204;46441.98109219673;46884;37968.810155949046;45228.547714522436;45241.86895327643;45395;46131.61605151851;43271.350929736705;43743.12513749771;43965.560344396145;44190;44460.77769611131;37525.62474375221;38981.050947453085;39127.129633769255;39522.2095558093;39897.80306590807;28333.858330708215;28605.856970715013;28627.713722862503;28650.426991459637;28798.280042998256 11:46:01 INFO - PROCESS | 1671 | |2;jquery.html;384.70264458407706;386.4222986634981;388.5492828319149;396.58754894909293;415.7380850064459;16635.833641663594;18937.86372817632;20773.857437840914;20895.477613059662;21361.145554177852;20342.491437714063;20529.178832846705;20873.373798786062;20960.68558971613;21014.57970840582;5918.763249470016;6027.819165425044;6147.969260153693;6198.44214020738;6245.937540624581;6055.818325450244;6151.231096112986;6168.0439531872635;6187.5978061426085;6519.380658837403;6784.8303792405095;6833.521653484258;6864.347886950732;6876.243613202544;6926.203486599055;6156.846078848042;6185.41238582334;6212.782552610682;6596.967015164917;6909.896351554731;5882.294124705063;5920.79277225295;6048.667323297217;6067.848303792396;6081.209442772455;12484.875151248461;12526.561570345086;12737.490500379974;12782.10525263232;12865.871341286562;2228.687983682286;2255.548890221962;2257.2099765082253;2402.7705109998187;3032.9536309973246;9988.650397236062;10006.749831254205;10057.698269051867;10519.73700657482;14499.275036248251;1813.7732783402075;1972.9408117756348;1991.6912878503856;2018.8687735297158;2032.0652499850087;133443;137057;141025;141044;146378.26810865983;11307.604233851776;11318.26431281964;11327.376994265394;11386.829197562043;11473.50844390224;14241.145531268157;14446.422143114369;14577.198254096127;14589.489367872073;14624.634384140481;8726.389152759373;8940.374173807772;8998.955005225063;9012.954935225282;9113;7315.451341149329;9046.457212567268;9108.49903255314;9196.724098277062;9249.445033298023;4456.640724579034;4485.775711214426;4512.826665067106;4527.139843429738;4574.771261436981;1652.7355623100245;1811.7101263797729;1849.7780266368122;1953.7948515405678;1967.0853053329984;777.8211011467281;899.3569597737649;915.7957286168667;975.205207755691;1034.886162522122;20755.169793208104;21300.467488312916;21364.786352136278;21371.572568548854;21478.57042859134;891.3782040121988;953.2612225525273;1023.7133602591286;1028.8353863381824;1060.1306928318859;10874.456277186267;10990.340579565252;10992.890071099346;11070.612528561624;11118.833217501744;463601;548020;549776;582840;629111;115273;121073.78926210625;133346;143293;145440;838.4508147163496;957.4159762544703;978.505854543451;978.574320170728;979.9020097990144;18827.71758423652;19323.51691207675;19488.1230344632;19564.315248966217;19590.412287631392;48165.795855103905;56792.7160364212;57440.71279643575;58135.418645814694;61791.6910415445;70734.64632676804;74315.62842185971;75192.62403687947;75448.62275688586;76236.85644715223;6864.313568643096;7137.750178743719;8062.879056814035;8113.594320283844;8159.510429374256;11143.554257829595;12913.096083274457;13023.47906083746;13161.210327380388;13454.865451345753;11161.888381116085;11362.94318528402;11402.885971140182;11748.236364636272;11806.291622502335;11058;11061.115110790957;11074.335539867634;11077.390743509184;11740.41297935117;11299.830502542303;11504.884951150381;11517.884821151682;11625.534978600761;11643;5477.589180811535;6990.8951365728535;7400.962995184989;7457.32884040439;7569.243075692387;9574.47340396285;10633.096186824207;10965.61620343284;11286.830697539708;11375.20373573842 11:46:01 INFO - PROCESS | 1671 | |3;mootools.html;1573.001144273386;1623.1478473801253;1662.6259091704376;1874.915628796704;1985;7782.143964163952;8124.878126828103;8320.70877519287;9035.186833185013;9491.762705932346;9015.95492022539;9267.95366023169;9279.443233406;9372.062793720625;9395;2453.3989172652723;2492.19003823758;2494.0397946790436;2495.3761559610098;2497.475530138673;2461.4584791345874;2495.1641200197955;2495.8752062396898;2505.498900219954;2510.5230006298834;2467.9753202468014;2474.9133780317693;2481.1688084491716;2481.280428675682;2500.5624015797252;2044.488877780555;2445.7921076708503;2470.147799009339;2475.814313926454;2488.054539275082;2416.081888882231;2450.3629056445275;2450.5221481811054;2464.125235541375;2486.78862296705;9338.159565639126;9397.248220142372;9421;9495.525223738785;9498.477583732893;5556.666600004012;5688.516476099537;5693.3168019837885;5696.316442026942;5703.458171473703;3605.603383627799;3808.447775072599;3839.9040023999623;3869.071422858522;3872.8257228424786;1087.521490544166;1105;1146.1232157399513;1146.5356530605118;1152.2280072351462;12345.567905123278;12557.623271301876;12560.748785024249;12569.680183580684;12576.245425274421;4820.276958456189;4822.035592881368;4907.141250281186;4997.375328083989;4999.900001999939;10440;10574.682759517227;10589.470526473646;10601.045905868508;10602.681919542427;5544.805931792449;5586.720663966786;5638.984982703071;5640.605157639008;5644.858878527987;4639.884002899887;4658.021815418732;5028.949710502849;5118.641695081308;5137.845864624067;4105.794710264475;4143.751374917515;4235.470566179228;4260.8721738347895;4276.48682158143;1313.7109835836102;1337.665583604099;1343.6909510812372;1344.28080976677;1347.144563202354;790.5888937752452;855.18329994856;867.6919693508713;946.2099147212017;961.3510880155867;6006.339302676702;6068.848278792977;6070.332263451017;6094.2077529920825;6302.747890084345;893.4460634406579;948.5873644964463;979.4025644356936;998.2962011781822;1012.8885822559513;3965.2466031453932;4085.4893138357706;4090.652294554996;4106.322456794655;4125.752454852718;11177.888221117848;11399.658010259705;11623.360715160577;11646.301221926711;11681.240719353214;9530.094641009093;11360.20478566509;11487.195896287347;11514.827277590843;11647.475863585989;7076.4692648051605;7571.810704732316;7995.800104997305;8293.33653307734;9117.407368521024;4890.584300334512;4959.479254678206;5003.874903127451;5848.883022339614;6108.267007959073;10634.73413164677;10719.464026798472;10730.73173170677;10781.730456738644;10843.186760993114;8494.617742201739;10840.078593319657;10860.837087443853;10880.129589632968;10945.726356840823;6556.475481961336;7452.329290363893;7653.693852245848;7794.883076753967;7806.57063861493;8717.128287171487;8893.555322233991;8907.153820387053;8919;8950.507722075348;7703.845923081395;7822.217778222132;7840.803979900548;7903.56530390834;7988.760337189894;7673;7727.652255648397;7776.339011184113;7798.298153166243;7823.491473054461;7132.465065120033;7152.6781294842895;7269.890951635624;7295.124585049828;7296.306850849161;4221.493420789402;5101.668391554537;5112.309838171799;5305.018571564273;5376.489233522809;5064.5441910228255;5110.335656364798;5171.379434467888;5294.549963253166;5362.088444964287 11:46:01 INFO - PROCESS | 1671 | |4;prototype.html;252.64629518673866;302.61114467908743;308.97991630544016;312.2490410562597;317.9205198700325;4729.716217026972;5617.820257745878;5667.461591148839;5689.971550142249;5712.828615141542;4124.051468162317;5300.204969254613;5424.430434804338;5520.199571062193;5638.548916086714;4288.571142885702;4300.97849510752;4313.892152696177;4316.482022157345;4332.545082766312;4092.0997380576227;4207.242696314662;4305.956940430587;4325.610695037446;4326.675499337546;3673.742838001341;4184.932842125254;4186.702122342069;4197;4234.364845273203;4207.894802629959;4208.516020657602;4224.4930608327195;4245.980964568512;4246.174145117614;3646.270745850814;3650.872219472306;3653.6346365363515;3664.4136938089778;3667.7982710950887;4803.3035209894715;5215.374155101412;5245.606579506552;5455.481729235717;5489.807856725035;3700.35243832331;4470.26240670289;4788.9521104788855;4820.469748327681;4857.53853383928;5700.743466544015;5924.5260379169995;5958.612690175168;5992.580519363646;5996.640201587875;3563.768355056939;3964.920701585981;3982.522097348308;3984.4820173377566;3986.6412022918075;5094.898102037975;6058.666773327465;6285.308616052231;6319.431251187415;6397.360263973612;3650.5984341722387;3836.1943991761486;4038.5153781545814;4039.596040395937;4060.553339132693;3461.44616861301;3469.8959031229106;3976.324024915771;4075.9592404076175;4080.7961651312935;4811.639127065484;4814.15752243356;4824.179889418807;4831.4685384607665;4834.903301933941;5872.500837428866;6001.0294904022785;6051.939480605226;6053.545984051214;6068.4538391544975;1182.674764439786;1276.668066302768;1385.515069725608;1391.4295138993166;1392.9860701393059;785.7642707187821;800.7037396163457;855.9957200213959;895.5298468304193;927.2165020557618;5033.924491132636;5367.704776237344;5492.450754924555;5560.555155587544;5623.750499800031;5012.646585421916;6047.516198704093;6069.2716873975405;6073.848153796191;6117.969410153009;4881.779555111222;5378.91931621026;5481.397046324901;5626.324841019104;5637.605367624309;2286.5198308355098;2614.816962812623;2632.2234940692542;2689.3007817967077;2733.5352989991748;4427.870892922284;4779.694539061638;4790.658615587571;5350.545203657733;5415.566754659618;4347.369631403492;4475.664325175625;4606.838760643362;4809.326694262806;5268.631195816332;4543.909121817611;4612.010610821615;4925.399245245238;5321.36143662763;5359.53461407749;4406.210658833336;4556.225441674989;4807.6298254997155;5206.817761378334;5230.581553475637;4412.955870441255;4928.581070609039;5096.337476128079;5126.872088140603;5173.163526948029;5831.4168583141345;6035.969820150871;6479.546431749733;6561.3438656134;6587.835304117435;4100.876973690674;4116.320807066801;4141.958580414278;4142.316517774533;4147.693476554876;5623.156526520891;5748.281464816898;5890.263717035371;5937.664025594207;6199.442050215503;4914.0908931847725;5307.9118780649105;5910.7635694573455;5978.461938425563;6044.7279872406725;5068.797248110034;6107.480864126599;6150.769846030722;6229.750809967551;6241;5651.660900345993;5706.258186435737;5981.338304454476;5989.125219894388;6060.909086363797;5192.636515444034;6056.394360563909;6163.363615466896;6186.876262474815;6187.81436556904;4822.95177048225;4903.41159060915;5524.806631767869;5560.138178582326;5893.116032595145 11:46:01 INFO - PROCESS | 1671 | |5;yui.html;747.424483147976;763.2672634271099;766.0194950463407;810.8621534339162;817.7996390884234;15379;16289.348426062943;16433.42483013095;16861.241244144014;16908.985460872325;15210.315535800888;15346.079235245894;15370.69258614827;15380.61548461289;15405.460808871692;880.5069161269694;901.7565257380503;926.5274709897933;932.1983094538691;936.9109934556207;719.3957076056112;792.9762107136767;848.1476116502906;872.8865247517814;873.1225118755642;851.6416315976008;908.9636414543444;913.680211925824;930.1163894300441;930.4882314726907;772.6793380746955;899.6626265150569;909.667971190514;914.92680585553;928.679605536089;671.513152964102;679.1069743287561;686.2965460403077;687.4088284075691;690.32693124204;15197.392104315813;15466.072035677895;15603;15706.764398533916;15782.605434864221;14766.778498322534;14833.92583037078;14864.925675371554;14881.925590372088;14947.40210391583;12184.147109702324;12245.755084898341;12263.325517096557;12424.937875310565;12782.360881955865;3497.1956450016382;3843.7501562398634;3863.0728625130046;3871.6709079728257;3873.709471789627;127776;130832;130868.34565827205;131945.340273299;133282.3335883324;10837.729056773485;11003.22977391575;11235.887641123483;11342.376169310603;11356.48895799691;21491.46271343229;21628.567428651655;21835.672464913037;22678.433039173822;23359.88320058389;8223.917760822435;8238.464499807493;8283.875741863876;8335;8466.619002144918;4421.53573874745;4475.70907890986;4479.6257983268915;4550.362949187116;4652.232381657056;3320.9833950830093;3715.3869611514338;3892.844286228519;3896.064944413377;3920.8039598019986;647.8866198415259;711.992880071203;723.1322413104295;726.989095163573;727.7125535413588;626.3736263736264;633.521691123199;691.7659939781502;707.7133760826873;709.1631874388169;9631.422114673142;9859.112679858847;9991.250656200815;10154.593816247416;10297.897021029694;454.86808825440914;620.6307247187916;637.9808605741836;684.7329541478828;700.527144177678;4870.683405578626;5002.124628190125;5004.199328107558;5041.294218809369;5054.797808087709;98903.50548247213;108008.45995769971;133571;151918;159324;133608.33195833958;133769;136256.31871840576;137053.3147334257;141116;117842.8215717849;121733.17400239003;121886;122734.15898761526;124937.37531312468;9413.905860941302;9632.422054676741;9641.758956026155;9710.174635155809;9716.299647561507;62406.37593624006;64808.67595661992;66285.33714662792;66331.66834165991;68196.6590167046;99537.50231248798;100666;103551;103816;105475.94524054661;11890.940545297219;12509.749805003667;13560.796588051384;13674.384652690454;13837.930810345884;14360.35378407995;15130.924345378202;15258.27551045777;15266.542003739905;15650.9217453912;14176.313622791666;14194.858051419767;14834.703305933604;15298.388064477296;15622.984506007073;14403;14712.391023451359;14913.701725965202;15047.699046019237;15149.469768558047;13360.265185414895;13415.396307166005;13793.862061379257;14297.713205811528;14581.343839527035;9458.905410945803;11030.613928512463;11149.498272577592;11519.19365644397;11947.880521194676;8840.911590884267;11634.534618615498;11845.170838041255;11879.58421455245;12111.152219344562 11:46:01 INFO - PROCESS | 1671 | __end_tp_report 11:46:01 INFO - PROCESS | 1671 | __start_cc_report 11:46:01 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,351 11:46:01 INFO - PROCESS | 1671 | __end_cc_report 11:46:01 INFO - PROCESS | 1671 | __startTimestamp1479152761447__endTimestamp 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | ------- Summary: start ------- 11:46:01 INFO - PROCESS | 1671 | Number of tests: 6 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5939.00 Median:6195.54 stddev:666.05 (10.8%) stddev-sans-first:623.99 11:46:01 INFO - PROCESS | 1671 | Values: 2900.7 3585.9 3622.5 3622.7 3640.6 4986.3 5741.2 5983.6 6080.7 6087.1 5950.3 6027.1 6033.7 6054.3 6059.8 5384.5 5466.5 5526.1 5528.0 5531.0 5523.9 5533.0 5533.1 5561.9 5571.4 5420.7 5452.1 5533.9 5538.9 5560.7 4593.9 5108.4 5501.5 5504.3 5571.4 5378.1 5458.4 5474.2 5476.9 5491.8 4879.9 6008.8 6088.5 6138.0 6153.4 4953.5 5794.1 6217.2 6274.4 6286.1 6381.9 6406.5 6436.2 6487.7 6493.5 6170.2 6177.0 6184.3 6192.9 6194.9 6472.6 6487.1 6530.8 6577.8 6615.9 6284.4 6299.4 6304.0 6306.9 6317.8 6256.3 6275.7 6452.6 6477.8 6481.9 6195.5 6287.9 6329.1 6370.6 6387.0 6337.2 6339.1 6348.2 6364.9 6370.7 5074.0 5185.8 5257.8 5262.4 5287.6 4444.5 4468.0 4579.9 4591.4 4652.7 6087.5 6179.6 6227.6 6252.6 6264.1 6426.7 6451.8 6454.5 6479.6 6503.3 6077.9 6111.6 6111.9 6118.7 6182.0 5722.6 5725.3 5742.4 5761.7 5778.0 5345.8 5563.4 6636.3 6640.3 6680.1 6236.9 6298.2 6388.0 6448.3 6460.3 6519.7 6540.5 6618.2 6679.1 6688.4 6330.8 6340.2 6350.3 6364.7 6394.5 6146.0 6358.4 6375.2 6418.8 6443.6 6206.2 6258.2 6273.5 6276.7 6312.7 6279.2 6280.2 6288.8 6296.5 6298.6 5056.4 6147.1 6186.6 6206.6 6286.3 6178.0 6192.9 6204.5 6234.0 6245.9 6269.3 6290.3 6290.9 6326.6 6327.5 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:76146.90 Median:37640.72 stddev:168374.47 (447.3%) stddev-sans-first:168750.96 11:46:01 INFO - PROCESS | 1671 | Values: 481.5 486.9 500.6 553.0 561.6 38389.4 44405.3 44492.6 44528.0 44541.1 42920.0 46290.5 46557.8 46685.5 46849.3 8313.2 9344.6 10391.5 10402.4 10408.1 8661.4 10090.7 10170.1 10246.2 10289.3 8766.8 10193.1 10245.3 10255.4 10294.9 10233.7 10294.6 10338.3 10344.0 10363.4 8726.3 10121.4 10138.1 10179.9 10262.1 43755.0 44239.0 44275.8 44309.0 44431.8 3386.4 3583.5 3642.1 3856.2 3938.5 32323.7 32801.0 33135.0 33157.0 33179.8 3296.4 3360.2 3419.1 3479.1 3481.7 407144.0 538097.0 538636.0 543081.3 544129.0 66214.7 66280.0 66482.7 66508.0 66620.0 35995.7 36035.8 36119.3 37146.8 37755.8 18469.6 18615.3 18718.3 18738.4 18760.6 14170.7 14337.6 14349.8 14352.4 14357.5 20365.4 20867.8 20941.8 20956.0 21016.0 8362.0 8464.7 8505.7 8550.0 8561.4 867.8 1034.9 1058.3 1080.9 1180.5 31229.8 32004.7 32128.5 32385.8 32671.0 969.6 1052.7 1203.8 1263.6 1280.4 16418.6 16442.4 16495.8 16639.5 16837.7 718903.0 723404.0 729338.0 731067.0 733751.0 61674.1 62414.0 62542.4 62655.7 62719.7 1422.7 1445.1 1448.1 1456.8 1458.5 30521.7 31064.0 32165.8 32272.4 32784.5 55387.0 55698.4 55768.0 55787.0 55791.0 620464.0 624054.0 627722.0 628610.0 628747.0 27799.6 28158.0 28563.6 29123.0 29182.3 52305.4 52306.7 52672.0 55314.6 55834.4 41700.0 43490.9 46139.3 46442.0 46884.0 37968.8 45228.5 45241.9 45395.0 46131.6 43271.4 43743.1 43965.6 44190.0 44460.8 37525.6 38981.1 39127.1 39522.2 39897.8 28333.9 28605.9 28627.7 28650.4 28798.3 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34287.58 Median:21425.07 stddev:94193.21 (439.6%) stddev-sans-first:94423.04 11:46:01 INFO - PROCESS | 1671 | Values: 384.7 386.4 388.5 396.6 415.7 16635.8 18937.9 20773.9 20895.5 21361.1 20342.5 20529.2 20873.4 20960.7 21014.6 5918.8 6027.8 6148.0 6198.4 6245.9 6055.8 6151.2 6168.0 6187.6 6519.4 6784.8 6833.5 6864.3 6876.2 6926.2 6156.8 6185.4 6212.8 6597.0 6909.9 5882.3 5920.8 6048.7 6067.8 6081.2 12484.9 12526.6 12737.5 12782.1 12865.9 2228.7 2255.5 2257.2 2402.8 3033.0 9988.7 10006.7 10057.7 10519.7 14499.3 1813.8 1972.9 1991.7 2018.9 2032.1 133443.0 137057.0 141025.0 141044.0 146378.3 11307.6 11318.3 11327.4 11386.8 11473.5 14241.1 14446.4 14577.2 14589.5 14624.6 8726.4 8940.4 8999.0 9013.0 9113.0 7315.5 9046.5 9108.5 9196.7 9249.4 4456.6 4485.8 4512.8 4527.1 4574.8 1652.7 1811.7 1849.8 1953.8 1967.1 777.8 899.4 915.8 975.2 1034.9 20755.2 21300.5 21364.8 21371.6 21478.6 891.4 953.3 1023.7 1028.8 1060.1 10874.5 10990.3 10992.9 11070.6 11118.8 463601.0 548020.0 549776.0 582840.0 629111.0 115273.0 121073.8 133346.0 143293.0 145440.0 838.5 957.4 978.5 978.6 979.9 18827.7 19323.5 19488.1 19564.3 19590.4 48165.8 56792.7 57440.7 58135.4 61791.7 70734.6 74315.6 75192.6 75448.6 76236.9 6864.3 7137.8 8062.9 8113.6 8159.5 11143.6 12913.1 13023.5 13161.2 13454.9 11161.9 11362.9 11402.9 11748.2 11806.3 11058.0 11061.1 11074.3 11077.4 11740.4 11299.8 11504.9 11517.9 11625.5 11643.0 5477.6 6990.9 7401.0 7457.3 7569.2 9574.5 10633.1 10965.6 11286.8 11375.2 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5958.60 Median:4933.31 stddev:3386.15 (68.6%) stddev-sans-first:3379.61 11:46:01 INFO - PROCESS | 1671 | Values: 1573.0 1623.1 1662.6 1874.9 1985.0 7782.1 8124.9 8320.7 9035.2 9491.8 9016.0 9268.0 9279.4 9372.1 9395.0 2453.4 2492.2 2494.0 2495.4 2497.5 2461.5 2495.2 2495.9 2505.5 2510.5 2468.0 2474.9 2481.2 2481.3 2500.6 2044.5 2445.8 2470.1 2475.8 2488.1 2416.1 2450.4 2450.5 2464.1 2486.8 9338.2 9397.2 9421.0 9495.5 9498.5 5556.7 5688.5 5693.3 5696.3 5703.5 3605.6 3808.4 3839.9 3869.1 3872.8 1087.5 1105.0 1146.1 1146.5 1152.2 12345.6 12557.6 12560.7 12569.7 12576.2 4820.3 4822.0 4907.1 4997.4 4999.9 10440.0 10574.7 10589.5 10601.0 10602.7 5544.8 5586.7 5639.0 5640.6 5644.9 4639.9 4658.0 5028.9 5118.6 5137.8 4105.8 4143.8 4235.5 4260.9 4276.5 1313.7 1337.7 1343.7 1344.3 1347.1 790.6 855.2 867.7 946.2 961.4 6006.3 6068.8 6070.3 6094.2 6302.7 893.4 948.6 979.4 998.3 1012.9 3965.2 4085.5 4090.7 4106.3 4125.8 11177.9 11399.7 11623.4 11646.3 11681.2 9530.1 11360.2 11487.2 11514.8 11647.5 7076.5 7571.8 7995.8 8293.3 9117.4 4890.6 4959.5 5003.9 5848.9 6108.3 10634.7 10719.5 10730.7 10781.7 10843.2 8494.6 10840.1 10860.8 10880.1 10945.7 6556.5 7452.3 7653.7 7794.9 7806.6 8717.1 8893.6 8907.2 8919.0 8950.5 7703.8 7822.2 7840.8 7903.6 7988.8 7673.0 7727.7 7776.3 7798.3 7823.5 7132.5 7152.7 7269.9 7295.1 7296.3 4221.5 5101.7 5112.3 5305.0 5376.5 5064.5 5110.3 5171.4 5294.5 5362.1 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4628.61 Median:4926.99 stddev:1453.39 (29.5%) stddev-sans-first:1419.87 11:46:01 INFO - PROCESS | 1671 | Values: 252.6 302.6 309.0 312.2 317.9 4729.7 5617.8 5667.5 5690.0 5712.8 4124.1 5300.2 5424.4 5520.2 5638.5 4288.6 4301.0 4313.9 4316.5 4332.5 4092.1 4207.2 4306.0 4325.6 4326.7 3673.7 4184.9 4186.7 4197.0 4234.4 4207.9 4208.5 4224.5 4246.0 4246.2 3646.3 3650.9 3653.6 3664.4 3667.8 4803.3 5215.4 5245.6 5455.5 5489.8 3700.4 4470.3 4789.0 4820.5 4857.5 5700.7 5924.5 5958.6 5992.6 5996.6 3563.8 3964.9 3982.5 3984.5 3986.6 5094.9 6058.7 6285.3 6319.4 6397.4 3650.6 3836.2 4038.5 4039.6 4060.6 3461.4 3469.9 3976.3 4076.0 4080.8 4811.6 4814.2 4824.2 4831.5 4834.9 5872.5 6001.0 6051.9 6053.5 6068.5 1182.7 1276.7 1385.5 1391.4 1393.0 785.8 800.7 856.0 895.5 927.2 5033.9 5367.7 5492.5 5560.6 5623.8 5012.6 6047.5 6069.3 6073.8 6118.0 4881.8 5378.9 5481.4 5626.3 5637.6 2286.5 2614.8 2632.2 2689.3 2733.5 4427.9 4779.7 4790.7 5350.5 5415.6 4347.4 4475.7 4606.8 4809.3 5268.6 4543.9 4612.0 4925.4 5321.4 5359.5 4406.2 4556.2 4807.6 5206.8 5230.6 4413.0 4928.6 5096.3 5126.9 5173.2 5831.4 6036.0 6479.5 6561.3 6587.8 4100.9 4116.3 4142.0 4142.3 4147.7 5623.2 5748.3 5890.3 5937.7 6199.4 4914.1 5307.9 5910.8 5978.5 6044.7 5068.8 6107.5 6150.8 6229.8 6241.0 5651.7 5706.3 5981.3 5989.1 6060.9 5192.6 6056.4 6163.4 6186.9 6187.8 4823.0 4903.4 5524.8 5560.1 5893.1 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:26155.12 Median:22257.05 stddev:41523.33 (186.6%) stddev-sans-first:41595.99 11:46:01 INFO - PROCESS | 1671 | Values: 747.4 763.3 766.0 810.9 817.8 15379.0 16289.3 16433.4 16861.2 16909.0 15210.3 15346.1 15370.7 15380.6 15405.5 880.5 901.8 926.5 932.2 936.9 719.4 793.0 848.1 872.9 873.1 851.6 909.0 913.7 930.1 930.5 772.7 899.7 909.7 914.9 928.7 671.5 679.1 686.3 687.4 690.3 15197.4 15466.1 15603.0 15706.8 15782.6 14766.8 14833.9 14864.9 14881.9 14947.4 12184.1 12245.8 12263.3 12424.9 12782.4 3497.2 3843.8 3863.1 3871.7 3873.7 127776.0 130832.0 130868.3 131945.3 133282.3 10837.7 11003.2 11235.9 11342.4 11356.5 21491.5 21628.6 21835.7 22678.4 23359.9 8223.9 8238.5 8283.9 8335.0 8466.6 4421.5 4475.7 4479.6 4550.4 4652.2 3321.0 3715.4 3892.8 3896.1 3920.8 647.9 712.0 723.1 727.0 727.7 626.4 633.5 691.8 707.7 709.2 9631.4 9859.1 9991.3 10154.6 10297.9 454.9 620.6 638.0 684.7 700.5 4870.7 5002.1 5004.2 5041.3 5054.8 98903.5 108008.5 133571.0 151918.0 159324.0 133608.3 133769.0 136256.3 137053.3 141116.0 117842.8 121733.2 121886.0 122734.2 124937.4 9413.9 9632.4 9641.8 9710.2 9716.3 62406.4 64808.7 66285.3 66331.7 68196.7 99537.5 100666.0 103551.0 103816.0 105475.9 11890.9 12509.7 13560.8 13674.4 13837.9 14360.4 15130.9 15258.3 15266.5 15650.9 14176.3 14194.9 14834.7 15298.4 15623.0 14403.0 14712.4 14913.7 15047.7 15149.5 13360.3 13415.4 13793.9 14297.7 14581.3 9458.9 11030.6 11149.5 11519.2 11947.9 8840.9 11634.5 11845.2 11879.6 12111.2 11:46:01 INFO - PROCESS | 1671 | -------- Summary: end -------- 11:46:01 INFO - PROCESS | 1671 | 11:46:01 INFO - TEST-INFO | 1671: exit 0 11:46:01 INFO - TEST-OK | dromaeo_css | took 1111639ms 11:46:01 INFO - TEST-START | kraken 11:46:01 INFO - operating with platform_type : mac_ 11:46:01 INFO - Initialising browser for kraken test... 11:46:01 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpJTWHb6/profile http://localhost:49278/getInfo.html) 11:46:04 INFO - PROCESS | 1794 | __metrics Screen width/height:1600/1200 11:46:04 INFO - PROCESS | 1794 | colorDepth:24 11:46:04 INFO - PROCESS | 1794 | Browser inner width/height: 1024/689 11:46:04 INFO - PROCESS | 1794 | __metrics 11:46:04 ERROR - PROCESS | 1794 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 11:46:04 INFO - TEST-INFO | 1794: exit 0 11:46:04 INFO - Browser initialized. 11:46:04 INFO - Running cycle 1/1 for kraken test... 11:46:04 INFO - TEST-INFO | started process 1797 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpJTWHb6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:16 INFO - PROCESS | 1797 | RSS: Main: 174120960 11:46:16 INFO - PROCESS | 1797 | 11:46:19 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:20 INFO - PROCESS | 1797 | RSS: Main: 186146816 11:46:20 INFO - PROCESS | 1797 | 11:46:23 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 11:46:23 INFO - PROCESS | 1797 | RSS: Main: 194846720 11:46:23 INFO - PROCESS | 1797 | 11:46:27 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 11:46:27 INFO - PROCESS | 1797 | RSS: Main: 197664768 11:46:27 INFO - PROCESS | 1797 | 11:46:29 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 11:46:30 INFO - PROCESS | 1797 | RSS: Main: 197697536 11:46:30 INFO - PROCESS | 1797 | 11:46:32 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:32 INFO - PROCESS | 1797 | RSS: Main: 197861376 11:46:32 INFO - PROCESS | 1797 | 11:46:35 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:36 INFO - PROCESS | 1797 | RSS: Main: 199626752 11:46:36 INFO - PROCESS | 1797 | 11:46:39 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:40 INFO - PROCESS | 1797 | RSS: Main: 199544832 11:46:40 INFO - PROCESS | 1797 | 11:46:42 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:46:43 INFO - PROCESS | 1797 | RSS: Main: 199868416 11:46:43 INFO - PROCESS | 1797 | 11:46:45 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:45 INFO - PROCESS | 1797 | RSS: Main: 199651328 11:46:45 INFO - PROCESS | 1797 | 11:46:47 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:48 INFO - PROCESS | 1797 | RSS: Main: 199979008 11:46:48 INFO - PROCESS | 1797 | 11:46:50 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:51 INFO - PROCESS | 1797 | RSS: Main: 199704576 11:46:51 INFO - PROCESS | 1797 | 11:46:53 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:54 INFO - PROCESS | 1797 | RSS: Main: 199680000 11:46:54 INFO - PROCESS | 1797 | 11:46:57 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:58 INFO - PROCESS | 1797 | RSS: Main: 199991296 11:46:58 INFO - PROCESS | 1797 | 11:46:59 INFO - PROCESS | 1797 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:47:00 INFO - PROCESS | 1797 | RSS: Main: 201572352 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | __start_tp_report 11:47:00 INFO - PROCESS | 1797 | _x_x_mozilla_page_load 11:47:00 INFO - PROCESS | 1797 | _x_x_mozilla_page_load_details 11:47:00 INFO - PROCESS | 1797 | |i|pagename|runs| 11:47:00 INFO - PROCESS | 1797 | |0;ai-astar;85;172;98;171;168;171;118;115;115;137 11:47:00 INFO - PROCESS | 1797 | |1;audio-beat-detection;138;109;110;139;112;119;142;140;132;111 11:47:00 INFO - PROCESS | 1797 | |2;audio-dft;194;197;198;193;192;193;194;196;196;274 11:47:00 INFO - PROCESS | 1797 | |3;audio-fft;84;59;58;84;61;69;51;69;106;84 11:47:00 INFO - PROCESS | 1797 | |4;audio-oscillator;86;71;91;94;100;102;98;72;70;84 11:47:00 INFO - PROCESS | 1797 | |5;imaging-gaussian-blur;99;131;89;86;89;85;90;90;120;86 11:47:00 INFO - PROCESS | 1797 | |6;imaging-darkroom;106;96;169;159;97;114;136;98;99;100 11:47:00 INFO - PROCESS | 1797 | |7;imaging-desaturate;92;94;96;99;95;90;92;78;143;145 11:47:00 INFO - PROCESS | 1797 | |8;json-parse-financial;54;55;54;56;58;59;59;58;58;58 11:47:00 INFO - PROCESS | 1797 | |9;json-stringify-tinderbox;66;72;67;73;69;88;91;98;88;69 11:47:00 INFO - PROCESS | 1797 | |10;stanford-crypto-aes;83;81;86;85;81;86;94;77;83;100 11:47:00 INFO - PROCESS | 1797 | |11;stanford-crypto-ccm;137;138;137;135;157;127;148;154;184;163 11:47:00 INFO - PROCESS | 1797 | |12;stanford-crypto-pbkdf2;164;164;162;164;162;163;163;160;163;161 11:47:00 INFO - PROCESS | 1797 | |13;stanford-crypto-sha256-iterative;70;75;82;60;81;83;87;85;89;74 11:47:00 INFO - PROCESS | 1797 | __end_tp_report 11:47:00 INFO - PROCESS | 1797 | __start_cc_report 11:47:00 INFO - PROCESS | 1797 | _x_x_mozilla_cycle_collect,896 11:47:00 INFO - PROCESS | 1797 | __end_cc_report 11:47:00 INFO - PROCESS | 1797 | __startTimestamp1479152820192__endTimestamp 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | ------- Summary: start ------- 11:47:00 INFO - PROCESS | 1797 | Number of tests: 14 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#0] ai-astar Cycles:10 Average:135.00 Median:171.00 stddev:33.35 (19.5%) stddev-sans-first:30.07 11:47:00 INFO - PROCESS | 1797 | Values: 85.0 172.0 98.0 171.0 168.0 171.0 118.0 115.0 115.0 137.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:135.00 stddev:14.18 (10.5%) stddev-sans-first:14.26 11:47:00 INFO - PROCESS | 1797 | Values: 138.0 109.0 110.0 139.0 112.0 119.0 142.0 140.0 132.0 111.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#2] audio-dft Cycles:10 Average:202.70 Median:196.00 stddev:25.13 (12.8%) stddev-sans-first:26.45 11:47:00 INFO - PROCESS | 1797 | Values: 194.0 197.0 198.0 193.0 192.0 193.0 194.0 196.0 196.0 274.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#3] audio-fft Cycles:10 Average:72.50 Median:69.00 stddev:16.77 (24.3%) stddev-sans-first:17.26 11:47:00 INFO - PROCESS | 1797 | Values: 84.0 59.0 58.0 84.0 61.0 69.0 51.0 69.0 106.0 84.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:85.00 stddev:12.29 (14.5%) stddev-sans-first:13.03 11:47:00 INFO - PROCESS | 1797 | Values: 86.0 71.0 91.0 94.0 100.0 102.0 98.0 72.0 70.0 84.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:89.00 stddev:15.98 (18.0%) stddev-sans-first:16.92 11:47:00 INFO - PROCESS | 1797 | Values: 99.0 131.0 89.0 86.0 89.0 85.0 90.0 90.0 120.0 86.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#6] imaging-darkroom Cycles:10 Average:117.40 Median:132.50 stddev:27.43 (20.7%) stddev-sans-first:28.78 11:47:00 INFO - PROCESS | 1797 | Values: 106.0 96.0 169.0 159.0 97.0 114.0 136.0 98.0 99.0 100.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:93.00 stddev:22.62 (24.3%) stddev-sans-first:23.68 11:47:00 INFO - PROCESS | 1797 | Values: 92.0 94.0 96.0 99.0 95.0 90.0 92.0 78.0 143.0 145.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:1.97 (3.4%) stddev-sans-first:1.79 11:47:00 INFO - PROCESS | 1797 | Values: 54.0 55.0 54.0 56.0 58.0 59.0 59.0 58.0 58.0 58.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:80.50 stddev:11.82 (14.7%) stddev-sans-first:11.70 11:47:00 INFO - PROCESS | 1797 | Values: 66.0 72.0 67.0 73.0 69.0 88.0 91.0 98.0 88.0 69.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.00 stddev:6.74 (8.0%) stddev-sans-first:7.08 11:47:00 INFO - PROCESS | 1797 | Values: 83.0 81.0 86.0 85.0 81.0 86.0 94.0 77.0 83.0 100.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:151.00 stddev:16.96 (11.2%) stddev-sans-first:17.52 11:47:00 INFO - PROCESS | 1797 | Values: 137.0 138.0 137.0 135.0 157.0 127.0 148.0 154.0 184.0 163.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.33 11:47:00 INFO - PROCESS | 1797 | Values: 164.0 164.0 162.0 164.0 162.0 163.0 163.0 160.0 163.0 161.0 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - PROCESS | 1797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:82.50 stddev:8.88 (10.8%) stddev-sans-first:8.86 11:47:00 INFO - PROCESS | 1797 | Values: 70.0 75.0 82.0 60.0 81.0 83.0 87.0 85.0 89.0 74.0 11:47:00 INFO - PROCESS | 1797 | -------- Summary: end -------- 11:47:00 INFO - PROCESS | 1797 | 11:47:00 INFO - TEST-INFO | 1797: exit 0 11:47:00 INFO - TEST-OK | kraken | took 58971ms 11:47:00 INFO - SUITE-END | took 1170s 11:47:01 INFO - Completed test suite (00:19:31) 11:47:01 INFO - javascript benchmark 11:47:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7618.888276406937, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2900.7389334959857, 3585.8924232273007, 3622.529071220741, 3622.746407751457, 3640.5631324241094, 4986.252062190664, 5741.167530708045, 5983.640981541105, 6080.665563394012, 6087.147799308101, 5950.285965684113, 6027.095935609661, 6033.7284822183, 6054.273487181534, 6059.787907423241, 5384.542313903313, 5466.535344495723, 5526.143447765603, 5527.972360138194, 5530.972345138269, 5523.889522209553, 5532.972335138339, 5533.114701647737, 5561.944380556203, 5571.415001424853, 5420.7018613976215, 5452.127659574468, 5533.889322213553, 5538.947599956015, 5560.749766260507, 4593.862184134481, 5108.386993560796, 5501.5323697485765, 5504.311961004874, 5571.359293681197, 5378.139497680391, 5458.426865179139, 5474.206240095164, 5476.945230547683, 5491.752871120809, 4879.8780030499165, 6008.759649614054, 6088.452039316483, 6138.0179171332375, 6153.446189842935, 4953.504649535053, 5794.101914203306, 6217.160683307741, 6274.403931626488, 6286.119943207955, 6381.872362552769, 6406.487481001509, 6436.195475565554, 6487.6756162191705, 6493.51298652603, 6170.19787427636, 6177.042558403455, 6184.319724830265, 6192.938070619236, 6194.907076393858, 6472.611643301417, 6487.091807147003, 6530.771423000172, 6577.83555411109, 6615.86768264632, 6284.402981716729, 6299.433051025429, 6303.991361382157, 6306.905396419057, 6317.810465686037, 6256.343083976208, 6275.717592708248, 6452.580582262138, 6477.838054048687, 6481.870362592722, 6195.535334849904, 6287.9056814147825, 6329.082283068929, 6370.649614271259, 6387.010013447923, 6337.2395312562785, 6339.11252424661, 6348.238211414659, 6364.854326221324, 6370.681465926685, 5074.0, 5185.818496352609, 5257.78968841242, 5262.421133675292, 5287.576993840484, 4444.511103778582, 4468.017036252019, 4579.862604121881, 4591.449026116888, 4652.697574657636, 6087.482563982111, 6179.567430279837, 6227.595206311576, 6252.562320637603, 6264.091706702503, 6426.742930282736, 6451.774187903401, 6454.548181627241, 6479.611223326616, 6503.317151699003, 6077.9392206078255, 6111.591738512148, 6111.865232675468, 6118.7410088057595, 6182.0, 5722.570807189478, 5725.255716756878, 5742.397048309951, 5761.654300741969, 5778.0, 5345.812896548602, 5563.360213575329, 6636.270010298863, 6640.302768209365, 6680.064790929274, 6236.906446403217, 6298.212723409574, 6388.0, 6448.32292609288, 6460.25707043696, 6519.674016299071, 6540.476761858945, 6618.205815302194, 6679.131712877295, 6688.431483323972, 6330.778422755181, 6340.207474065742, 6350.301466838551, 6364.713587888648, 6394.520410969289, 6146.0473626587955, 6358.427741503287, 6375.203099612549, 6418.807435776934, 6443.613383197023, 6206.224221972254, 6258.155149055002, 6273.466755325666, 6276.717547710273, 6312.715927783169, 6279.183706118175, 6280.246370435394, 6288.811335659938, 6296.496280297473, 6298.590591611531, 5056.418511871035, 6147.108669243024, 6186.628802271878, 6206.596571222856, 6286.27707813589, 6178.011518157074, 6192.907106393498, 6204.534659900616, 6233.96883015582, 6245.8750824982335, 6269.31037585856, 6290.276618188784, 6290.874182516232, 6326.588771729823, 6327.493800496041], "value": 5898.740472425846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.54734549523425, 486.8777467936407, 500.58701571203756, 552.9861753456163, 561.6124873837055, 38389.42415863761, 44405.33391999122, 44492.55507444924, 44528.0, 44541.10917781646, 42920.0, 46290.53709462904, 46557.7672111639, 46685.533144668545, 46849.29726054112, 8313.210245026712, 9344.579493922773, 10391.53238104287, 10402.375857448576, 10408.115310198642, 8661.35039872009, 10090.74773130674, 10170.084692377684, 10246.180305575535, 10289.279750417474, 8766.780830479258, 10193.133583645398, 10245.334053286513, 10255.435951022691, 10294.897051029506, 10233.744156396113, 10294.588216471333, 10338.328008679411, 10344.017318354745, 10363.430011349374, 8726.301895848317, 10121.443320617363, 10138.087572118471, 10179.949100254526, 10262.07641312278, 43755.0, 44239.0, 44275.77862110701, 44309.0, 44431.77784111091, 3386.3565922474895, 3583.516225309576, 3642.071271825694, 3856.2094770571966, 3938.5273767147837, 32323.676763232303, 32801.0, 33135.0, 33157.0, 33179.83410082958, 3296.4066468035744, 3360.1935535471557, 3419.093940105874, 3479.0954351868445, 3481.704055155315, 407144.0, 538097.0, 538636.0, 543081.2845935784, 544129.0, 66214.66892665505, 66280.0, 66482.66758666272, 66508.0, 66620.0, 35995.74014909466, 36035.819820901255, 36119.277614447565, 37146.8142659285, 37755.81122094372, 18469.630607388044, 18615.348462804006, 18718.34485793018, 18738.437846864617, 18760.624787504446, 14170.71658566823, 14337.56987290383, 14349.78475322871, 14352.425902963765, 14357.497487587885, 20365.389038328874, 20867.791322086887, 20941.790582093985, 20956.0, 21016.0, 8362.0, 8464.746057618282, 8505.74482765518, 8550.0, 8561.44350617208, 867.8351113288455, 1034.927555071153, 1058.3491152940885, 1080.9243352965375, 1180.504188240941, 31229.843850780602, 32004.719811207757, 32128.518072228937, 32385.838070809965, 32671.0, 969.5733877094056, 1052.6736711619421, 1203.825445310425, 1263.6398626391617, 1280.423754548926, 16418.589535261715, 16442.424515142153, 16495.83504164943, 16639.50081497557, 16837.663246734995, 718903.0, 723404.0, 729338.0, 731067.0, 733751.0, 61674.074888876705, 62414.0, 62542.37457625366, 62655.6867215661, 62719.6864015677, 1422.665673566711, 1445.0607105381587, 1448.109412711175, 1456.805419555954, 1458.5478501664306, 30521.694783051884, 31064.0, 32165.839170803996, 32272.35455290928, 32784.50823237701, 55387.0, 55698.443015569326, 55768.0, 55787.0, 55791.0, 620464.0, 624054.0, 627722.0, 628610.0, 628747.0, 27799.583006254517, 28158.0, 28563.571546427236, 29123.0, 29182.27044323909, 52305.43083707495, 52306.692332691986, 52672.0, 55314.61713457035, 55834.441655584546, 41700.0, 43490.912727182076, 46139.30791038204, 46441.98109219673, 46884.0, 37968.810155949046, 45228.547714522436, 45241.86895327643, 45395.0, 46131.61605151851, 43271.350929736705, 43743.12513749771, 43965.560344396145, 44190.0, 44460.77769611131, 37525.62474375221, 38981.050947453085, 39127.129633769255, 39522.2095558093, 39897.80306590807, 28333.858330708215, 28605.856970715013, 28627.713722862503, 28650.426991459637, 28798.280042998256], "value": 21375.475722276922, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.70264458407706, 386.4222986634981, 388.5492828319149, 396.58754894909293, 415.7380850064459, 16635.833641663594, 18937.86372817632, 20773.857437840914, 20895.477613059662, 21361.145554177852, 20342.491437714063, 20529.178832846705, 20873.373798786062, 20960.68558971613, 21014.57970840582, 5918.763249470016, 6027.819165425044, 6147.969260153693, 6198.44214020738, 6245.937540624581, 6055.818325450244, 6151.231096112986, 6168.0439531872635, 6187.5978061426085, 6519.380658837403, 6784.8303792405095, 6833.521653484258, 6864.347886950732, 6876.243613202544, 6926.203486599055, 6156.846078848042, 6185.41238582334, 6212.782552610682, 6596.967015164917, 6909.896351554731, 5882.294124705063, 5920.79277225295, 6048.667323297217, 6067.848303792396, 6081.209442772455, 12484.875151248461, 12526.561570345086, 12737.490500379974, 12782.10525263232, 12865.871341286562, 2228.687983682286, 2255.548890221962, 2257.2099765082253, 2402.7705109998187, 3032.9536309973246, 9988.650397236062, 10006.749831254205, 10057.698269051867, 10519.73700657482, 14499.275036248251, 1813.7732783402075, 1972.9408117756348, 1991.6912878503856, 2018.8687735297158, 2032.0652499850087, 133443.0, 137057.0, 141025.0, 141044.0, 146378.26810865983, 11307.604233851776, 11318.26431281964, 11327.376994265394, 11386.829197562043, 11473.50844390224, 14241.145531268157, 14446.422143114369, 14577.198254096127, 14589.489367872073, 14624.634384140481, 8726.389152759373, 8940.374173807772, 8998.955005225063, 9012.954935225282, 9113.0, 7315.451341149329, 9046.457212567268, 9108.49903255314, 9196.724098277062, 9249.445033298023, 4456.640724579034, 4485.775711214426, 4512.826665067106, 4527.139843429738, 4574.771261436981, 1652.7355623100245, 1811.7101263797729, 1849.7780266368122, 1953.7948515405678, 1967.0853053329984, 777.8211011467281, 899.3569597737649, 915.7957286168667, 975.205207755691, 1034.886162522122, 20755.169793208104, 21300.467488312916, 21364.786352136278, 21371.572568548854, 21478.57042859134, 891.3782040121988, 953.2612225525273, 1023.7133602591286, 1028.8353863381824, 1060.1306928318859, 10874.456277186267, 10990.340579565252, 10992.890071099346, 11070.612528561624, 11118.833217501744, 463601.0, 548020.0, 549776.0, 582840.0, 629111.0, 115273.0, 121073.78926210625, 133346.0, 143293.0, 145440.0, 838.4508147163496, 957.4159762544703, 978.505854543451, 978.574320170728, 979.9020097990144, 18827.71758423652, 19323.51691207675, 19488.1230344632, 19564.315248966217, 19590.412287631392, 48165.795855103905, 56792.7160364212, 57440.71279643575, 58135.418645814694, 61791.6910415445, 70734.64632676804, 74315.62842185971, 75192.62403687947, 75448.62275688586, 76236.85644715223, 6864.313568643096, 7137.750178743719, 8062.879056814035, 8113.594320283844, 8159.510429374256, 11143.554257829595, 12913.096083274457, 13023.47906083746, 13161.210327380388, 13454.865451345753, 11161.888381116085, 11362.94318528402, 11402.885971140182, 11748.236364636272, 11806.291622502335, 11058.0, 11061.115110790957, 11074.335539867634, 11077.390743509184, 11740.41297935117, 11299.830502542303, 11504.884951150381, 11517.884821151682, 11625.534978600761, 11643.0, 5477.589180811535, 6990.8951365728535, 7400.962995184989, 7457.32884040439, 7569.243075692387, 9574.47340396285, 10633.096186824207, 10965.61620343284, 11286.830697539708, 11375.20373573842], "value": 9581.470628474606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.001144273386, 1623.1478473801253, 1662.6259091704376, 1874.915628796704, 1985.0, 7782.143964163952, 8124.878126828103, 8320.70877519287, 9035.186833185013, 9491.762705932346, 9015.95492022539, 9267.95366023169, 9279.443233406, 9372.062793720625, 9395.0, 2453.3989172652723, 2492.19003823758, 2494.0397946790436, 2495.3761559610098, 2497.475530138673, 2461.4584791345874, 2495.1641200197955, 2495.8752062396898, 2505.498900219954, 2510.5230006298834, 2467.9753202468014, 2474.9133780317693, 2481.1688084491716, 2481.280428675682, 2500.5624015797252, 2044.488877780555, 2445.7921076708503, 2470.147799009339, 2475.814313926454, 2488.054539275082, 2416.081888882231, 2450.3629056445275, 2450.5221481811054, 2464.125235541375, 2486.78862296705, 9338.159565639126, 9397.248220142372, 9421.0, 9495.525223738785, 9498.477583732893, 5556.666600004012, 5688.516476099537, 5693.3168019837885, 5696.316442026942, 5703.458171473703, 3605.603383627799, 3808.447775072599, 3839.9040023999623, 3869.071422858522, 3872.8257228424786, 1087.521490544166, 1105.0, 1146.1232157399513, 1146.5356530605118, 1152.2280072351462, 12345.567905123278, 12557.623271301876, 12560.748785024249, 12569.680183580684, 12576.245425274421, 4820.276958456189, 4822.035592881368, 4907.141250281186, 4997.375328083989, 4999.900001999939, 10440.0, 10574.682759517227, 10589.470526473646, 10601.045905868508, 10602.681919542427, 5544.805931792449, 5586.720663966786, 5638.984982703071, 5640.605157639008, 5644.858878527987, 4639.884002899887, 4658.021815418732, 5028.949710502849, 5118.641695081308, 5137.845864624067, 4105.794710264475, 4143.751374917515, 4235.470566179228, 4260.8721738347895, 4276.48682158143, 1313.7109835836102, 1337.665583604099, 1343.6909510812372, 1344.28080976677, 1347.144563202354, 790.5888937752452, 855.18329994856, 867.6919693508713, 946.2099147212017, 961.3510880155867, 6006.339302676702, 6068.848278792977, 6070.332263451017, 6094.2077529920825, 6302.747890084345, 893.4460634406579, 948.5873644964463, 979.4025644356936, 998.2962011781822, 1012.8885822559513, 3965.2466031453932, 4085.4893138357706, 4090.652294554996, 4106.322456794655, 4125.752454852718, 11177.888221117848, 11399.658010259705, 11623.360715160577, 11646.301221926711, 11681.240719353214, 9530.094641009093, 11360.20478566509, 11487.195896287347, 11514.827277590843, 11647.475863585989, 7076.4692648051605, 7571.810704732316, 7995.800104997305, 8293.33653307734, 9117.407368521024, 4890.584300334512, 4959.479254678206, 5003.874903127451, 5848.883022339614, 6108.267007959073, 10634.73413164677, 10719.464026798472, 10730.73173170677, 10781.730456738644, 10843.186760993114, 8494.617742201739, 10840.078593319657, 10860.837087443853, 10880.129589632968, 10945.726356840823, 6556.475481961336, 7452.329290363893, 7653.693852245848, 7794.883076753967, 7806.57063861493, 8717.128287171487, 8893.555322233991, 8907.153820387053, 8919.0, 8950.507722075348, 7703.845923081395, 7822.217778222132, 7840.803979900548, 7903.56530390834, 7988.760337189894, 7673.0, 7727.652255648397, 7776.339011184113, 7798.298153166243, 7823.491473054461, 7132.465065120033, 7152.6781294842895, 7269.890951635624, 7295.124585049828, 7296.306850849161, 4221.493420789402, 5101.668391554537, 5112.309838171799, 5305.018571564273, 5376.489233522809, 5064.5441910228255, 5110.335656364798, 5171.379434467888, 5294.549963253166, 5362.088444964287], "value": 4778.9565442039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.64629518673866, 302.61114467908743, 308.97991630544016, 312.2490410562597, 317.9205198700325, 4729.716217026972, 5617.820257745878, 5667.461591148839, 5689.971550142249, 5712.828615141542, 4124.051468162317, 5300.204969254613, 5424.430434804338, 5520.199571062193, 5638.548916086714, 4288.571142885702, 4300.97849510752, 4313.892152696177, 4316.482022157345, 4332.545082766312, 4092.0997380576227, 4207.242696314662, 4305.956940430587, 4325.610695037446, 4326.675499337546, 3673.742838001341, 4184.932842125254, 4186.702122342069, 4197.0, 4234.364845273203, 4207.894802629959, 4208.516020657602, 4224.4930608327195, 4245.980964568512, 4246.174145117614, 3646.270745850814, 3650.872219472306, 3653.6346365363515, 3664.4136938089778, 3667.7982710950887, 4803.3035209894715, 5215.374155101412, 5245.606579506552, 5455.481729235717, 5489.807856725035, 3700.35243832331, 4470.26240670289, 4788.9521104788855, 4820.469748327681, 4857.53853383928, 5700.743466544015, 5924.5260379169995, 5958.612690175168, 5992.580519363646, 5996.640201587875, 3563.768355056939, 3964.920701585981, 3982.522097348308, 3984.4820173377566, 3986.6412022918075, 5094.898102037975, 6058.666773327465, 6285.308616052231, 6319.431251187415, 6397.360263973612, 3650.5984341722387, 3836.1943991761486, 4038.5153781545814, 4039.596040395937, 4060.553339132693, 3461.44616861301, 3469.8959031229106, 3976.324024915771, 4075.9592404076175, 4080.7961651312935, 4811.639127065484, 4814.15752243356, 4824.179889418807, 4831.4685384607665, 4834.903301933941, 5872.500837428866, 6001.0294904022785, 6051.939480605226, 6053.545984051214, 6068.4538391544975, 1182.674764439786, 1276.668066302768, 1385.515069725608, 1391.4295138993166, 1392.9860701393059, 785.7642707187821, 800.7037396163457, 855.9957200213959, 895.5298468304193, 927.2165020557618, 5033.924491132636, 5367.704776237344, 5492.450754924555, 5560.555155587544, 5623.750499800031, 5012.646585421916, 6047.516198704093, 6069.2716873975405, 6073.848153796191, 6117.969410153009, 4881.779555111222, 5378.91931621026, 5481.397046324901, 5626.324841019104, 5637.605367624309, 2286.5198308355098, 2614.816962812623, 2632.2234940692542, 2689.3007817967077, 2733.5352989991748, 4427.870892922284, 4779.694539061638, 4790.658615587571, 5350.545203657733, 5415.566754659618, 4347.369631403492, 4475.664325175625, 4606.838760643362, 4809.326694262806, 5268.631195816332, 4543.909121817611, 4612.010610821615, 4925.399245245238, 5321.36143662763, 5359.53461407749, 4406.210658833336, 4556.225441674989, 4807.6298254997155, 5206.817761378334, 5230.581553475637, 4412.955870441255, 4928.581070609039, 5096.337476128079, 5126.872088140603, 5173.163526948029, 5831.4168583141345, 6035.969820150871, 6479.546431749733, 6561.3438656134, 6587.835304117435, 4100.876973690674, 4116.320807066801, 4141.958580414278, 4142.316517774533, 4147.693476554876, 5623.156526520891, 5748.281464816898, 5890.263717035371, 5937.664025594207, 6199.442050215503, 4914.0908931847725, 5307.9118780649105, 5910.7635694573455, 5978.461938425563, 6044.7279872406725, 5068.797248110034, 6107.480864126599, 6150.769846030722, 6229.750809967551, 6241.0, 5651.660900345993, 5706.258186435737, 5981.338304454476, 5989.125219894388, 6060.909086363797, 5192.636515444034, 6056.394360563909, 6163.363615466896, 6186.876262474815, 6187.81436556904, 4822.95177048225, 4903.41159060915, 5524.806631767869, 5560.138178582326, 5893.116032595145], "value": 4157.2914165037755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.424483147976, 763.2672634271099, 766.0194950463407, 810.8621534339162, 817.7996390884234, 15379.0, 16289.348426062943, 16433.42483013095, 16861.241244144014, 16908.985460872325, 15210.315535800888, 15346.079235245894, 15370.69258614827, 15380.61548461289, 15405.460808871692, 880.5069161269694, 901.7565257380503, 926.5274709897933, 932.1983094538691, 936.9109934556207, 719.3957076056112, 792.9762107136767, 848.1476116502906, 872.8865247517814, 873.1225118755642, 851.6416315976008, 908.9636414543444, 913.680211925824, 930.1163894300441, 930.4882314726907, 772.6793380746955, 899.6626265150569, 909.667971190514, 914.92680585553, 928.679605536089, 671.513152964102, 679.1069743287561, 686.2965460403077, 687.4088284075691, 690.32693124204, 15197.392104315813, 15466.072035677895, 15603.0, 15706.764398533916, 15782.605434864221, 14766.778498322534, 14833.92583037078, 14864.925675371554, 14881.925590372088, 14947.40210391583, 12184.147109702324, 12245.755084898341, 12263.325517096557, 12424.937875310565, 12782.360881955865, 3497.1956450016382, 3843.7501562398634, 3863.0728625130046, 3871.6709079728257, 3873.709471789627, 127776.0, 130832.0, 130868.34565827205, 131945.340273299, 133282.3335883324, 10837.729056773485, 11003.22977391575, 11235.887641123483, 11342.376169310603, 11356.48895799691, 21491.46271343229, 21628.567428651655, 21835.672464913037, 22678.433039173822, 23359.88320058389, 8223.917760822435, 8238.464499807493, 8283.875741863876, 8335.0, 8466.619002144918, 4421.53573874745, 4475.70907890986, 4479.6257983268915, 4550.362949187116, 4652.232381657056, 3320.9833950830093, 3715.3869611514338, 3892.844286228519, 3896.064944413377, 3920.8039598019986, 647.8866198415259, 711.992880071203, 723.1322413104295, 726.989095163573, 727.7125535413588, 626.3736263736264, 633.521691123199, 691.7659939781502, 707.7133760826873, 709.1631874388169, 9631.422114673142, 9859.112679858847, 9991.250656200815, 10154.593816247416, 10297.897021029694, 454.86808825440914, 620.6307247187916, 637.9808605741836, 684.7329541478828, 700.527144177678, 4870.683405578626, 5002.124628190125, 5004.199328107558, 5041.294218809369, 5054.797808087709, 98903.50548247213, 108008.45995769971, 133571.0, 151918.0, 159324.0, 133608.33195833958, 133769.0, 136256.31871840576, 137053.3147334257, 141116.0, 117842.8215717849, 121733.17400239003, 121886.0, 122734.15898761526, 124937.37531312468, 9413.905860941302, 9632.422054676741, 9641.758956026155, 9710.174635155809, 9716.299647561507, 62406.37593624006, 64808.67595661992, 66285.33714662792, 66331.66834165991, 68196.6590167046, 99537.50231248798, 100666.0, 103551.0, 103816.0, 105475.94524054661, 11890.940545297219, 12509.749805003667, 13560.796588051384, 13674.384652690454, 13837.930810345884, 14360.35378407995, 15130.924345378202, 15258.27551045777, 15266.542003739905, 15650.9217453912, 14176.313622791666, 14194.858051419767, 14834.703305933604, 15298.388064477296, 15622.984506007073, 14403.0, 14712.391023451359, 14913.701725965202, 15047.699046019237, 15149.469768558047, 13360.265185414895, 13415.396307166005, 13793.862061379257, 14297.713205811528, 14581.343839527035, 9458.905410945803, 11030.613928512463, 11149.498272577592, 11519.19365644397, 11947.880521194676, 8840.911590884267, 11634.534618615498, 11845.170838041255, 11879.58421455245, 12111.152219344562], "value": 8148.036103573099, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 172.0, 98.0, 171.0, 168.0, 171.0, 118.0, 115.0, 115.0, 137.0], "value": 135.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 109.0, 110.0, 139.0, 112.0, 119.0, 142.0, 140.0, 132.0, 111.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 198.0, 193.0, 192.0, 193.0, 194.0, 196.0, 196.0, 274.0], "value": 202.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 84.0, 61.0, 69.0, 51.0, 69.0, 106.0, 84.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 91.0, 94.0, 100.0, 102.0, 98.0, 72.0, 70.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 131.0, 89.0, 86.0, 89.0, 85.0, 90.0, 90.0, 120.0, 86.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 96.0, 169.0, 159.0, 97.0, 114.0, 136.0, 98.0, 99.0, 100.0], "value": 117.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 96.0, 99.0, 95.0, 90.0, 92.0, 78.0, 143.0, 145.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 56.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 67.0, 73.0, 69.0, 88.0, 91.0, 98.0, 88.0, 69.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 86.0, 85.0, 81.0, 86.0, 94.0, 77.0, 83.0, 100.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 137.0, 135.0, 157.0, 127.0, 148.0, 154.0, 184.0, 163.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 164.0, 162.0, 163.0, 163.0, 160.0, 163.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 82.0, 60.0, 81.0, 83.0, 87.0, 85.0, 89.0, 74.0], "value": 78.6, "unit": "score"}]}]} 11:47:01 INFO - Return code: 0 11:47:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:47:01 ERROR - # TBPL SUCCESS # 11:47:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:01 INFO - 2016-11-14 11:47:01.523 screenresolution[1808:10796] starting screenresolution argv=screenresolution get 11:47:01 INFO - 2016-11-14 11:47:01.526 screenresolution[1808:10796] Display 0: 1600x1200x32@60 11:47:01 INFO - 2016-11-14 11:47:01.532 screenresolution[1809:10799] starting screenresolution argv=screenresolution list 11:47:01 INFO - Available Modes on Display 0 11:47:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:01 INFO - Intel Iris: 11:47:01 INFO - Chipset Model: Intel Iris 11:47:01 INFO - Type: GPU 11:47:01 INFO - Bus: Built-In 11:47:01 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:01 INFO - Vendor: Intel (0x8086) 11:47:01 INFO - Device ID: 0x0a2e 11:47:01 INFO - Revision ID: 0x0009 11:47:01 INFO - Displays: 11:47:01 INFO - Display: 11:47:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:01 INFO - Display Serial Number: 1600x1200 60 11:47:01 INFO - Main Display: Yes 11:47:01 INFO - Mirror: Off 11:47:01 INFO - Online: Yes 11:47:01 INFO - Rotation: Supported 11:47:01 INFO - Return code: 0 11:47:01 INFO - Running post-action listener: _resource_record_post_action 11:47:01 INFO - [mozharness: 2016-11-14 19:47:01.766270Z] Finished run-tests step (success) 11:47:01 INFO - Running post-run listener: _resource_record_post_run 11:47:01 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 37536768; Write bytes: 501045760; Read time: 240; Write time: 1649 11:47:01 INFO - TinderboxPrint: CPU usage
54.3% 11:47:01 INFO - TinderboxPrint: I/O read bytes / time
37,536,768 / 240 11:47:01 INFO - TinderboxPrint: I/O write bytes / time
501,045,760 / 1,649 11:47:01 INFO - TinderboxPrint: CPU idle
2,180.2 (45.7%) 11:47:01 INFO - TinderboxPrint: CPU system
967.8 (20.3%) 11:47:01 INFO - TinderboxPrint: CPU user
1,625.5 (34.1%) 11:47:01 INFO - TinderboxPrint: Swap in / out
232,275,968 / 0 11:47:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194437632; Write bytes: 189138944; Read time: 18058; Write time: 411 11:47:01 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 35464192; Write bytes: 301548032; Read time: 220; Write time: 1202 11:47:02 INFO - Running post-run listener: _upload_blobber_files 11:47:02 INFO - Blob upload gear active. 11:47:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:02 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 11:47:02 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'] 11:47:02 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 11:47:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:03 INFO - (blobuploader) - INFO - Done attempting. 11:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:04 INFO - (blobuploader) - INFO - Done attempting. 11:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:06 INFO - (blobuploader) - INFO - Done attempting. 11:47:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:06 INFO - Return code: 0 11:47:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12982a0bc6816af09aadd44cdcc9fac8f5aec0dad17ca09417f40efc1e18d879309d7602e5c810462c1261c267fbfa40b850b4406b20c53a4b82f574c629c735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef482c5d85349adb46c34ca732ef3bf89ce232dcb3840002c3bd95d1fcd53d75e0577dd09320cc33d8e56f2232bb0a31791fffda969387ba03a53034deb1c5bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0ea4d627eef855d6f4f39acd0a0c6b2bc2fb9f9f3612cf0a147e8068ef2b952a4d33a00a48895a7315f2e79cad57b00b4326a82f1fbcb23b5230af0a5325bd9"} 11:47:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:06 INFO - Contents: 11:47:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12982a0bc6816af09aadd44cdcc9fac8f5aec0dad17ca09417f40efc1e18d879309d7602e5c810462c1261c267fbfa40b850b4406b20c53a4b82f574c629c735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef482c5d85349adb46c34ca732ef3bf89ce232dcb3840002c3bd95d1fcd53d75e0577dd09320cc33d8e56f2232bb0a31791fffda969387ba03a53034deb1c5bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0ea4d627eef855d6f4f39acd0a0c6b2bc2fb9f9f3612cf0a147e8068ef2b952a4d33a00a48895a7315f2e79cad57b00b4326a82f1fbcb23b5230af0a5325bd9"} 11:47:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:06 INFO - Copying logs to upload dir... 11:47:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.812531 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-14 11:47:07.031710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:47:07.035377) ========= 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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12982a0bc6816af09aadd44cdcc9fac8f5aec0dad17ca09417f40efc1e18d879309d7602e5c810462c1261c267fbfa40b850b4406b20c53a4b82f574c629c735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef482c5d85349adb46c34ca732ef3bf89ce232dcb3840002c3bd95d1fcd53d75e0577dd09320cc33d8e56f2232bb0a31791fffda969387ba03a53034deb1c5bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0ea4d627eef855d6f4f39acd0a0c6b2bc2fb9f9f3612cf0a147e8068ef2b952a4d33a00a48895a7315f2e79cad57b00b4326a82f1fbcb23b5230af0a5325bd9"} build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12982a0bc6816af09aadd44cdcc9fac8f5aec0dad17ca09417f40efc1e18d879309d7602e5c810462c1261c267fbfa40b850b4406b20c53a4b82f574c629c735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef482c5d85349adb46c34ca732ef3bf89ce232dcb3840002c3bd95d1fcd53d75e0577dd09320cc33d8e56f2232bb0a31791fffda969387ba03a53034deb1c5bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0ea4d627eef855d6f4f39acd0a0c6b2bc2fb9f9f3612cf0a147e8068ef2b952a4d33a00a48895a7315f2e79cad57b00b4326a82f1fbcb23b5230af0a5325bd9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:47:07.067752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:47:07.068090) ========= 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.Ty6jeDr6Yt/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.GjEeOs4Prh/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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.005426 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:47:07.352006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:47:07.352357) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:47:07.352937) ========= ========= Total master_lag: 0.40 =========