builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0207 starttime: 1476632521.43 results: success (0) buildid: 20161016061936 builduid: 8d5c27dfb8be4bb7a97943d2e59361dc revision: f0596b7956ec3ee2bd1e329c2abfcc183fbead50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:01.429234) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:01.429672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:01.429960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:01.698834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:01.702379) ========= 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.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-10-16 08:42:01-- 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% 164M=0s 2016-10-16 08:42:02 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.614402 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:02.353814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:02.354112) ========= 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.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.020650 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:02.415651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 08:42:02.415977) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f0596b7956ec3ee2bd1e329c2abfcc183fbead50 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f0596b7956ec3ee2bd1e329c2abfcc183fbead50 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-10-16 08:42:02,510 truncating revision to first 12 chars 2016-10-16 08:42:02,510 Setting DEBUG logging. 2016-10-16 08:42:02,510 attempt 1/10 2016-10-16 08:42:02,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f0596b7956ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 08:42:03,429 unpacking tar archive at: mozilla-aurora-f0596b7956ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.208162 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 08:42:03.649610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:03.649927) ========= script_repo_revision: f0596b7956ec3ee2bd1e329c2abfcc183fbead50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:03.653359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:03.653624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 08:42:03.671492) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-16 08:42:03.671817) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:03 INFO - MultiFileLogger online at 20161016 08:42:03 in /builds/slave/test 08:42:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:42:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:03 INFO - {'append_to_log': False, 08:42:03 INFO - 'base_work_dir': '/builds/slave/test', 08:42:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:42:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:03 INFO - 'branch': 'Mozilla-Aurora', 08:42:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:03 INFO - 'config_files': ('talos/mac_config.py',), 08:42:03 INFO - 'default_actions': ('clobber', 08:42:03 INFO - 'read-buildbot-config', 08:42:03 INFO - 'download-and-extract', 08:42:03 INFO - 'populate-webroot', 08:42:03 INFO - 'create-virtualenv', 08:42:03 INFO - 'install', 08:42:03 INFO - 'run-tests'), 08:42:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:03 INFO - 'download_minidump_stackwalk': True, 08:42:03 INFO - 'download_symbols': 'ondemand', 08:42:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:03 INFO - 'installer_path': 'installer.exe', 08:42:03 INFO - 'log_level': 'info', 08:42:03 INFO - 'log_name': 'talos', 08:42:03 INFO - 'log_to_console': True, 08:42:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:03 INFO - 'opt_config_files': (), 08:42:03 INFO - 'pip_index': False, 08:42:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:03 INFO - 'cmd': ('bash', 08:42:03 INFO - '-c', 08:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:03 INFO - 'enabled': True, 08:42:03 INFO - 'halt_on_failure': False, 08:42:03 INFO - 'name': 'check_screen_resolution'},), 08:42:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:03 INFO - 'cmd': ('bash', 08:42:03 INFO - '-c', 08:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:03 INFO - 'enabled': True, 08:42:03 INFO - 'halt_on_failure': False, 08:42:03 INFO - 'name': 'check_screen_resolution'},), 08:42:03 INFO - 'run_cmd_checks_enabled': True, 08:42:03 INFO - 'sps_profile': False, 08:42:03 INFO - 'sps_profile_interval': 0, 08:42:03 INFO - 'suite': 'dromaeojs-e10s', 08:42:03 INFO - 'system_bits': '32', 08:42:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:03 INFO - 'title': 't-yosemite-r7-0207', 08:42:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:03 INFO - 'use_talos_json': True, 08:42:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:03 INFO - 'work_dir': 'build'} 08:42:03 INFO - [mozharness: 2016-10-16 15:42:03.872543Z] Running clobber step. 08:42:03 INFO - Running pre-action listener: _resource_record_pre_action 08:42:03 INFO - Running main action method: clobber 08:42:03 INFO - rmtree: /builds/slave/test/build 08:42:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:05 INFO - Running post-action listener: _resource_record_post_action 08:42:05 INFO - [mozharness: 2016-10-16 15:42:05.048519Z] Finished clobber step (success) 08:42:05 INFO - [mozharness: 2016-10-16 15:42:05.048794Z] Running read-buildbot-config step. 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: read_buildbot_config 08:42:05 INFO - Using buildbot properties: 08:42:05 INFO - { 08:42:05 INFO - "project": "", 08:42:05 INFO - "product": "firefox", 08:42:05 INFO - "script_repo_revision": "production", 08:42:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:42:05 INFO - "repository": "", 08:42:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:42:05 INFO - "buildid": "20161016061936", 08:42:05 INFO - "pgo_build": "False", 08:42:05 INFO - "basedir": "/builds/slave/test", 08:42:05 INFO - "buildnumber": 139, 08:42:05 INFO - "slavename": "t-yosemite-r7-0207", 08:42:05 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:42:05 INFO - "platform": "yosemite_r7", 08:42:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:42:05 INFO - "branch": "mozilla-aurora", 08:42:05 INFO - "repo_path": "releases/mozilla-aurora", 08:42:05 INFO - "revision": "f0596b7956ec3ee2bd1e329c2abfcc183fbead50", 08:42:05 INFO - "stage_platform": "macosx64", 08:42:05 INFO - "builduid": "8d5c27dfb8be4bb7a97943d2e59361dc", 08:42:05 INFO - "slavebuilddir": "test" 08:42:05 INFO - } 08:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:42:05 INFO - Running post-action listener: _resource_record_post_action 08:42:05 INFO - [mozharness: 2016-10-16 15:42:05.054413Z] Finished read-buildbot-config step (success) 08:42:05 INFO - [mozharness: 2016-10-16 15:42:05.054616Z] Running download-and-extract step. 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: download_and_extract 08:42:05 INFO - mkdir: /builds/slave/test/build/tests 08:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:05 INFO - trying https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 08:42:06 INFO - Downloaded 1199 bytes. 08:42:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:42:06 INFO - Using the following test package requirements: 08:42:06 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:42:06 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:42:06 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:42:06 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'jsshell-mac.zip'], 08:42:06 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:42:06 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:42:06 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:42:06 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:42:06 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:42:06 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:42:06 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:42:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:42:07 INFO - Expected file size: 16435274 08:42:15 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:42:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:42:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:42:15 INFO - Fetch https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:42:15 INFO - Expected file size: 16435274 08:42:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:42:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:42:22 INFO - Fetch https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:42:22 INFO - Expected file size: 14414081 08:42:23 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')]} 08:42:23 INFO - trying https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:42:23 INFO - Downloading https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 08:42:26 INFO - Downloaded 115422153 bytes. 08:42:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:42:26 INFO - mkdir: /builds/slave/test/properties 08:42:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:26 INFO - Contents: 08:42:26 INFO - build_url:https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:42:27 INFO - Running post-action listener: _resource_record_post_action 08:42:27 INFO - Running post-action listener: set_extra_try_arguments 08:42:27 INFO - [mozharness: 2016-10-16 15:42:27.102636Z] Finished download-and-extract step (success) 08:42:27 INFO - [mozharness: 2016-10-16 15:42:27.102784Z] Running populate-webroot step. 08:42:27 INFO - Running pre-action listener: _resource_record_pre_action 08:42:27 INFO - Running main action method: populate_webroot 08:42:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:27 INFO - '--tppagecycles', 08:42:27 INFO - '7'], 08:42:27 INFO - 'tests': ['tsvgm']}}, 08:42:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['damp', 'tps']}, 08:42:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'tests': ['damp', 'tps']}, 08:42:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['dromaeo_dom']}, 08:42:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['basic_compositor_video']}, 08:42:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['a11yr', 08:42:27 INFO - 'ts_paint', 08:42:27 INFO - 'tpaint', 08:42:27 INFO - 'sessionrestore', 08:42:27 INFO - 'sessionrestore_no_auto_restore', 08:42:27 INFO - 'tabpaint']}, 08:42:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['tsvgx', 08:42:27 INFO - 'tsvgr_opacity', 08:42:27 INFO - 'tart', 08:42:27 INFO - 'tscrollx', 08:42:27 INFO - 'cart']}, 08:42:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:27 INFO - 'tsvgr_opacity', 08:42:27 INFO - 'tart', 08:42:27 INFO - 'tscrollx', 08:42:27 INFO - 'cart']}, 08:42:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'talos_options': ['--disable-e10s'], 08:42:27 INFO - 'tests': ['tp5o']}, 08:42:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'tests': ['tp5o']}, 08:42:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'talos_options': ['--disable-e10s', 08:42:27 INFO - '--xperf_path', 08:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:27 INFO - 'tests': ['tp5n']}, 08:42:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:27 INFO - 'talos_options': ['--xperf_path', 08:42:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:27 INFO - 'tests': ['tp5n']}}, 08:42:27 INFO - 'talos.zip': {'path': '', 08:42:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:27 INFO - Running post-action listener: _resource_record_post_action 08:42:27 INFO - [mozharness: 2016-10-16 15:42:27.121187Z] Finished populate-webroot step (success) 08:42:27 INFO - [mozharness: 2016-10-16 15:42:27.121320Z] Running create-virtualenv step. 08:42:27 INFO - Running pre-action listener: _resource_record_pre_action 08:42:27 INFO - Running main action method: create_virtualenv 08:42:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:27 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 08:42:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:27 INFO - Using real prefix '/tools/python27' 08:42:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:30 INFO - Installing pip.................done. 08:42:30 INFO - Return code: 0 08:42:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:30 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')]} 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 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')]} 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:30 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 08:42:30 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 08:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:30 INFO - 'HOME': '/Users/cltbld', 08:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:30 INFO - 'LOGNAME': 'cltbld', 08:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:30 INFO - 'MOZ_NO_REMOTE': '1', 08:42:30 INFO - 'NO_EM_RESTART': '1', 08:42:30 INFO - 'PAGER': '/bin/cat', 08:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:30 INFO - 'PWD': '/builds/slave/test', 08:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:30 INFO - 'SHELL': '/bin/bash', 08:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:30 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:30 INFO - 'USER': 'cltbld', 08:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:30 INFO - 'XPC_FLAGS': '0x0', 08:42:30 INFO - 'XPC_SERVICE_NAME': '0', 08:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:31 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 08:42:31 INFO - Cleaning up... 08:42:31 INFO - Return code: 0 08:42:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:31 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')]} 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 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')]} 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:31 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 08:42:31 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 08:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:31 INFO - 'HOME': '/Users/cltbld', 08:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:31 INFO - 'LOGNAME': 'cltbld', 08:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:31 INFO - 'MOZ_NO_REMOTE': '1', 08:42:31 INFO - 'NO_EM_RESTART': '1', 08:42:31 INFO - 'PAGER': '/bin/cat', 08:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:31 INFO - 'PWD': '/builds/slave/test', 08:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:31 INFO - 'SHELL': '/bin/bash', 08:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:31 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:31 INFO - 'USER': 'cltbld', 08:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:31 INFO - 'XPC_FLAGS': '0x0', 08:42:31 INFO - 'XPC_SERVICE_NAME': '0', 08:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:31 INFO - Downloading/unpacking psutil>=3.1.1 08:42:31 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 08:42:31 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 08:42:31 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 08:42:31 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 08:42:31 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 08:42:31 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 08:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:34 INFO - Installing collected packages: psutil 08:42:34 INFO - Running setup.py install for psutil 08:42:34 INFO - building 'psutil._psutil_osx' extension 08:42:34 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 08:42:34 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 08:42:34 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 08:42:34 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 08:42:35 INFO - building 'psutil._psutil_posix' extension 08:42:35 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 08:42:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:35 INFO - ^ 08:42:35 INFO - 1 warning generated. 08:42:35 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 08:42:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:35 INFO - Successfully installed psutil 08:42:35 INFO - Cleaning up... 08:42:35 INFO - Return code: 0 08:42:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:35 INFO - 'HOME': '/Users/cltbld', 08:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:35 INFO - 'LOGNAME': 'cltbld', 08:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:35 INFO - 'MOZ_NO_REMOTE': '1', 08:42:35 INFO - 'NO_EM_RESTART': '1', 08:42:35 INFO - 'PAGER': '/bin/cat', 08:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:35 INFO - 'PWD': '/builds/slave/test', 08:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:35 INFO - 'SHELL': '/bin/bash', 08:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:35 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:35 INFO - 'USER': 'cltbld', 08:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:35 INFO - 'XPC_FLAGS': '0x0', 08:42:35 INFO - 'XPC_SERVICE_NAME': '0', 08:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:38 INFO - Installing collected packages: mozsystemmonitor 08:42:38 INFO - Running setup.py install for mozsystemmonitor 08:42:38 INFO - Successfully installed mozsystemmonitor 08:42:38 INFO - Cleaning up... 08:42:38 INFO - Return code: 0 08:42:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:38 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')]} 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:38 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')]} 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:38 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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:38 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 08:42:38 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 08:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:38 INFO - 'HOME': '/Users/cltbld', 08:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:38 INFO - 'LOGNAME': 'cltbld', 08:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:38 INFO - 'MOZ_NO_REMOTE': '1', 08:42:38 INFO - 'NO_EM_RESTART': '1', 08:42:38 INFO - 'PAGER': '/bin/cat', 08:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:38 INFO - 'PWD': '/builds/slave/test', 08:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:38 INFO - 'SHELL': '/bin/bash', 08:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:38 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:38 INFO - 'USER': 'cltbld', 08:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:38 INFO - 'XPC_FLAGS': '0x0', 08:42:38 INFO - 'XPC_SERVICE_NAME': '0', 08:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:38 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 08:42:38 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 08:42:38 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 08:42:38 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 08:42:38 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 08:42:38 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 08:42:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 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 08:42:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:41 INFO - warning: no files found matching '*.txt' 08:42:41 INFO - no previously-included directories found matching 'build' 08:42:41 INFO - no previously-included directories found matching 'dist' 08:42:41 INFO - no previously-included directories found matching '.git*' 08:42:41 INFO - Installing collected packages: jsonschema, functools32 08:42:41 INFO - Running setup.py install for functools32 08:42:41 INFO - warning: no files found matching '*.txt' 08:42:41 INFO - no previously-included directories found matching 'build' 08:42:41 INFO - no previously-included directories found matching 'dist' 08:42:41 INFO - no previously-included directories found matching '.git*' 08:42:41 INFO - Successfully installed jsonschema functools32 08:42:41 INFO - Cleaning up... 08:42:42 INFO - Return code: 0 08:42:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:42 INFO - 'HOME': '/Users/cltbld', 08:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:42 INFO - 'LOGNAME': 'cltbld', 08:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:42 INFO - 'MOZ_NO_REMOTE': '1', 08:42:42 INFO - 'NO_EM_RESTART': '1', 08:42:42 INFO - 'PAGER': '/bin/cat', 08:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:42 INFO - 'PWD': '/builds/slave/test', 08:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:42 INFO - 'SHELL': '/bin/bash', 08:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:42 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:42 INFO - 'USER': 'cltbld', 08:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:42 INFO - 'XPC_FLAGS': '0x0', 08:42:42 INFO - 'XPC_SERVICE_NAME': '0', 08:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:42 INFO - Cleaning up... 08:42:42 INFO - Return code: 0 08:42:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:42 INFO - 'HOME': '/Users/cltbld', 08:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:42 INFO - 'LOGNAME': 'cltbld', 08:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:42 INFO - 'MOZ_NO_REMOTE': '1', 08:42:42 INFO - 'NO_EM_RESTART': '1', 08:42:42 INFO - 'PAGER': '/bin/cat', 08:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:42 INFO - 'PWD': '/builds/slave/test', 08:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:42 INFO - 'SHELL': '/bin/bash', 08:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:42 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:42 INFO - 'USER': 'cltbld', 08:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:42 INFO - 'XPC_FLAGS': '0x0', 08:42:42 INFO - 'XPC_SERVICE_NAME': '0', 08:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:46 INFO - Downloading docopt-0.6.1.tar.gz 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:46 INFO - Running setup.py install for blobuploader 08:42:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:46 INFO - Running setup.py install for requests 08:42:47 INFO - Running setup.py install for docopt 08:42:47 INFO - Successfully installed blobuploader requests docopt 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:47 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 08:42:47 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 08:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:47 INFO - 'HOME': '/Users/cltbld', 08:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PAGER': '/bin/cat', 08:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:47 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - 'XPC_FLAGS': '0x0', 08:42:47 INFO - 'XPC_SERVICE_NAME': '0', 08:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-URhnPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-rH3ZsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Dof2hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ruxdkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:47 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-95bMhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eDoi64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-OW7oYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-i0MOfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Ts5Jqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dBRJZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-sB2akx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-3inRMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-9hWpYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:48 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-gQPnKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-xVHyc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ynA_uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:49 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-RMqIIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:49 INFO - Running setup.py install for manifestparser 08:42:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozcrash 08:42:49 INFO - Running setup.py install for mozdebug 08:42:49 INFO - Running setup.py install for mozdevice 08:42:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozfile 08:42:50 INFO - Running setup.py install for mozhttpd 08:42:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozinfo 08:42:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozInstall 08:42:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozleak 08:42:50 INFO - Running setup.py install for mozlog 08:42:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for moznetwork 08:42:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozprocess 08:42:51 INFO - Running setup.py install for mozprofile 08:42:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozrunner 08:42:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozscreenshot 08:42:51 INFO - Running setup.py install for moztest 08:42:51 INFO - Running setup.py install for mozversion 08:42:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:51 INFO - Cleaning up... 08:42:51 INFO - Return code: 0 08:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:51 INFO - 'HOME': '/Users/cltbld', 08:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:51 INFO - 'LOGNAME': 'cltbld', 08:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:51 INFO - 'MOZ_NO_REMOTE': '1', 08:42:51 INFO - 'NO_EM_RESTART': '1', 08:42:51 INFO - 'PAGER': '/bin/cat', 08:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:51 INFO - 'PWD': '/builds/slave/test', 08:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:51 INFO - 'SHELL': '/bin/bash', 08:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:51 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:51 INFO - 'USER': 'cltbld', 08:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:51 INFO - 'XPC_FLAGS': '0x0', 08:42:51 INFO - 'XPC_SERVICE_NAME': '0', 08:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-t_VKei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-m2iTQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-bdlvtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-b0QaQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 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)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-LNUE4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-L8gx2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-NiaPgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-enBMTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-XYQacj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-mzBlae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-A9GuBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-KHezwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-fwlsgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-fuRNF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-a7V4hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Xy5iDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-BxKHxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Downloading blessings-1.6.tar.gz 08:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:56 INFO - Installing collected packages: blessings 08:42:56 INFO - Running setup.py install for blessings 08:42:56 INFO - Successfully installed blessings 08:42:56 INFO - Cleaning up... 08:42:56 INFO - Return code: 0 08:42:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:57 INFO - Reading from file tmpfile_stdout 08:42:57 INFO - Current package versions: 08:42:57 INFO - blessings == 1.6 08:42:57 INFO - blobuploader == 1.2.4 08:42:57 INFO - docopt == 0.6.1 08:42:57 INFO - functools32 == 3.2.3-2 08:42:57 INFO - jsonschema == 2.5.1 08:42:57 INFO - manifestparser == 1.1 08:42:57 INFO - mozInstall == 1.12 08:42:57 INFO - mozcrash == 0.17 08:42:57 INFO - mozdebug == 0.1 08:42:57 INFO - mozdevice == 0.48 08:42:57 INFO - mozfile == 1.2 08:42:57 INFO - mozhttpd == 0.7 08:42:57 INFO - mozinfo == 0.9 08:42:57 INFO - mozleak == 0.1 08:42:57 INFO - mozlog == 3.4 08:42:57 INFO - moznetwork == 0.27 08:42:57 INFO - mozprocess == 0.23 08:42:57 INFO - mozprofile == 0.28 08:42:57 INFO - mozrunner == 6.12 08:42:57 INFO - mozscreenshot == 0.1 08:42:57 INFO - mozsystemmonitor == 0.3 08:42:57 INFO - moztest == 0.7 08:42:57 INFO - mozversion == 1.4 08:42:57 INFO - psutil == 3.1.1 08:42:57 INFO - requests == 1.2.3 08:42:57 INFO - wsgiref == 0.1.2 08:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 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 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:57 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 08:42:57 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 08:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:57 INFO - 'HOME': '/Users/cltbld', 08:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PAGER': '/bin/cat', 08:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:57 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - 'XPC_FLAGS': '0x0', 08:42:57 INFO - 'XPC_SERVICE_NAME': '0', 08:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cda570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd79cc8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, '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.pCXVKnSQga/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.ZYIBT84qZF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 08:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:57 INFO - 'HOME': '/Users/cltbld', 08:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PAGER': '/bin/cat', 08:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:42:57 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - 'XPC_FLAGS': '0x0', 08:42:57 INFO - 'XPC_SERVICE_NAME': '0', 08:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Running post-action listener: _resource_record_post_action 08:42:57 INFO - Running post-action listener: _start_resource_monitoring 08:42:57 INFO - Starting resource monitoring. 08:42:57 INFO - [mozharness: 2016-10-16 15:42:57.688821Z] Finished create-virtualenv step (success) 08:42:57 INFO - [mozharness: 2016-10-16 15:42:57.689810Z] Running install step. 08:42:57 INFO - Running pre-action listener: _resource_record_pre_action 08:42:57 INFO - Running main action method: install 08:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:57 INFO - Reading from file tmpfile_stdout 08:42:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:58 INFO - Reading from file tmpfile_stdout 08:42:58 INFO - Output received: 08:42:58 INFO - Usage: mozinstall [options] installer 08:42:58 INFO - Options: 08:42:58 INFO - -h, --help show this help message and exit 08:42:58 INFO - -d DEST, --destination=DEST 08:42:58 INFO - Directory to install application into. [default: 08:42:58 INFO - "/builds/slave/test"] 08:42:58 INFO - --app=APP Application being installed. [default: firefox] 08:42:58 INFO - mkdir: /builds/slave/test/build/application 08:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:43:31 INFO - Reading from file tmpfile_stdout 08:43:31 INFO - Output received: 08:43:31 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:43:31 INFO - Running post-action listener: _resource_record_post_action 08:43:31 INFO - [mozharness: 2016-10-16 15:43:31.129727Z] Finished install step (success) 08:43:31 INFO - [mozharness: 2016-10-16 15:43:31.129901Z] Running run-tests step. 08:43:31 INFO - Running pre-action listener: _resource_record_pre_action 08:43:31 INFO - Running main action method: run_tests 08:43:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:31 INFO - 2016-10-16 08:43:31.144 screenresolution[1943:17978] starting screenresolution argv=screenresolution get 08:43:31 INFO - 2016-10-16 08:43:31.146 screenresolution[1943:17978] Display 0: 1600x1200x32@60 08:43:31 INFO - 2016-10-16 08:43:31.152 screenresolution[1944:17980] starting screenresolution argv=screenresolution list 08:43:31 INFO - Available Modes on Display 0 08:43:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:31 INFO - Intel Iris: 08:43:31 INFO - Chipset Model: Intel Iris 08:43:31 INFO - Type: GPU 08:43:31 INFO - Bus: Built-In 08:43:31 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:31 INFO - Vendor: Intel (0x8086) 08:43:31 INFO - Device ID: 0x0a2e 08:43:31 INFO - Revision ID: 0x0009 08:43:31 INFO - Displays: 08:43:31 INFO - Display: 08:43:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:31 INFO - Display Serial Number: 1600x1200 60 08:43:31 INFO - Main Display: Yes 08:43:31 INFO - Mirror: Off 08:43:31 INFO - Online: Yes 08:43:31 INFO - Rotation: Supported 08:43:31 INFO - Return code: 0 08:43:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:31 INFO - Python 2.7.3 08:43:31 INFO - Return code: 0 08:43:31 INFO - grabbing minidump binary from tooltool 08:43:31 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')]} 08:43:31 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 0x106b78d30>, '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 0x1069dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b70b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:31 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 08:43:31 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 08:43:31 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 08:43:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:31 INFO - Return code: 0 08:43:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 08:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 08:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCXVKnSQga/Render', 08:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:31 INFO - 'HOME': '/Users/cltbld', 08:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:31 INFO - 'LOGNAME': 'cltbld', 08:43:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:31 INFO - 'MOZ_NO_REMOTE': '1', 08:43:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:31 INFO - 'NO_EM_RESTART': '1', 08:43:31 INFO - 'PAGER': '/bin/cat', 08:43:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:31 INFO - 'PWD': '/builds/slave/test', 08:43:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:31 INFO - 'SHELL': '/bin/bash', 08:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZYIBT84qZF/Listeners', 08:43:31 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 08:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:31 INFO - 'USER': 'cltbld', 08:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:31 INFO - 'XPC_FLAGS': '0x0', 08:43:31 INFO - 'XPC_SERVICE_NAME': '0', 08:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 08:43:31 INFO - mozversion application_buildid: 20161016061936 08:43:31 INFO - mozversion application_changeset: f0596b7956ec3ee2bd1e329c2abfcc183fbead50 08:43:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:43:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:31 INFO - mozversion application_name: Firefox 08:43:31 INFO - mozversion application_remotingname: firefox-dev 08:43:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:31 INFO - mozversion application_vendor: Mozilla 08:43:31 INFO - mozversion application_version: 51.0a2 08:43:31 INFO - mozversion platform_buildid: 20161016061936 08:43:31 INFO - mozversion platform_changeset: f0596b7956ec3ee2bd1e329c2abfcc183fbead50 08:43:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:31 INFO - mozversion platform_version: 51.0a2 08:43:31 INFO - using testdate: 1476632611 08:43:31 INFO - actual date: 1476632611 08:43:31 INFO - starting webserver on 'localhost:49649' 08:43:31 INFO - SUITE-START | Running 2 tests 08:43:31 INFO - TEST-START | dromaeo_css 08:43:31 INFO - operating with platform_type : mac_ 08:43:31 INFO - Initialising browser for dromaeo_css test... 08:43:31 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpN5wm5p/profile http://localhost:49649/getInfo.html) 08:43:34 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 08:43:34 INFO - PROCESS | 1954 | colorDepth:24 08:43:34 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 08:43:34 INFO - PROCESS | 1954 | __metrics 08:43:34 ERROR - PROCESS | 1954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:43:35 INFO - TEST-INFO | 1954: exit 0 08:43:35 INFO - Browser initialized. 08:43:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:35 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpN5wm5p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:47 INFO - PROCESS | 1957 | RSS: Main: 225169408 08:43:47 INFO - PROCESS | 1957 | 08:44:36 INFO - PROCESS | 1957 | 1476632676906 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] 08:46:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49649/tests/dromaeo/cssquery-ext.html) 08:46:50 INFO - PROCESS | 1957 | RSS: Main: 236716032 08:46:50 INFO - PROCESS | 1957 | 08:49:52 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-ext.html (next: http://localhost:49649/tests/dromaeo/cssquery-jquery.html) 08:49:53 INFO - PROCESS | 1957 | RSS: Main: 248578048 08:49:53 INFO - PROCESS | 1957 | 08:52:55 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49649/tests/dromaeo/cssquery-mootools.html) 08:52:56 INFO - PROCESS | 1957 | RSS: Main: 250474496 08:52:56 INFO - PROCESS | 1957 | 08:55:57 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49649/tests/dromaeo/cssquery-prototype.html) 08:55:58 INFO - PROCESS | 1957 | RSS: Main: 250671104 08:55:58 INFO - PROCESS | 1957 | 08:59:01 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49649/tests/dromaeo/cssquery-yui.html) 08:59:01 INFO - PROCESS | 1957 | RSS: Main: 256565248 08:59:01 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-yui.html (next: http://localhost:49649/tests/dromaeo/cssquery-dojo.html) 09:02:04 INFO - PROCESS | 1957 | RSS: Main: 258297856 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | __start_tp_report 09:02:04 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 09:02:04 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 09:02:04 INFO - PROCESS | 1957 | |i|pagename|runs| 09:02:04 INFO - PROCESS | 1957 | |0;dojo.html;3445.00094972458;3459.9135021624456;3483.8432270547837;3485.73856960728;3499.47507873819;5894.941050589493;5910.852228694284;5960.4039596040375;6009.789657361993;6025.7288422021;5986.820395388135;6049.455549000589;6058.454739073482;6073.817785466432;6075.33171351151;5380.488853558905;5432.348118225818;5452.073147564924;5478.808241711541;5561.860953476155;5464.590155738316;5480.588955828329;5484.698341591211;5498.890022199554;5499.532539734128;4451.777411129447;5343.812966546172;5366.382865970424;5492.780288788444;5542.224088627595;5400.702961337144;5420.403755586883;5464.863378415532;5470.152126420411;5525;5355.758990845421;5406.675599464044;5425.647332923348;5431.972840135774;5449.945500544984;4996.975015124937;5730.627509211888;6003.009503431928;6031.215941927521;6095.634261944253;6209.192804935375;6237.937620623827;6245.375462453719;6246.469050130744;6334.366563343675;5314.707691076989;6284.4344009039405;6293.653849038301;6311.589746666498;6354.205724284465;6083.9391606084255;6084.756609735561;6086.330503644595;6086.786962456293;6093.969530152365;6242.875142497124;6258.593191442542;6329.620222786648;6343.111964324999;6369.20384951881;6302;6303.086052522451;6307.810765677037;6324.430801227912;6332.556721029576;6308.179936608211;6314.526410519137;6335.556511044275;6342.904856427157;6462.159919210472;6189.071639254148;6242.438180563771;6249.500039996789;6288.088227207029;6303.401176888188;6260.342664020303;6275.341089185661;6293.276273228637;6304.275008374096;6313;4989.525995030466;5014.824481143142;5020.824271150492;5025.497450254945;5030.094582975026;4388.846390376321;4434.224010798098;4480.596746292849;4491.820327186876;4558.088382323548;6006.12911127884;6047.365026672136;6070.180525628984;6073;6090.939090609126;4852.0295940811975;5412.539934105566;5665.5467562594895;6322.367763223733;6329.2721337045905;4552.453705555355;5978.850528736816;5989.371116032841;6034;6062.878742425127;5540.2243685884005;5546.112621980545;5547.084731019418;5573.888522229533;5577.191307260506;6457.741690332428;6534.411902928759;6537.70580323877;6541.803745887631;6551.082848401227;5278;6126.6017708848785;6197.194364732556;6212.223472065992;6310.684465776784;5510.311211098613;6521.445677117498;6529.183852018497;6558.639274839738;6561.179852518435;6254.312025677081;6261.874762504815;6281.277653069773;6286.6856657166045;6352.68236588178;6195.2255968004;6227.346128656607;6297.653629050446;6337.524685648687;6338.492920566251;6191.25704915413;6305.085762564311;6313.116163737172;6322.620642761449;6329.30377658448;6300.936990630035;6303.9684801575695;6305.96847015762;6308.968455157695;6353.047042943411;5225.477452254744;5482.890342193054;6122.938770612237;6132.724027418866;6173.228346456693;6172.660503672161;6218.782342618168;6226.813195604139;6245.156903817927;6291.653959032297;6142.385761423822;6155.199824022849;6183.350748171377;6186.876262474635;6187.16473276102 09:02:04 INFO - PROCESS | 1957 | |1;ext.html;464.2456008985399;515.7493079282739;519.76350760404;544.9809256676016;545.7271364317841;39173.99999999996;41441.3783793243;41634;43365.56634433655;43387.78306108465;34050.97847064592;42147.57852421475;42390;42679;43039.139217215634;9742.756431089227;9778.462184579845;9832.754181145458;9882.851757223647;9928.10647041766;9818.50907454628;9968.850467242997;9993.650222242222;10000.399976001463;10056.547455364489;9910.90089099107;10020.549075291592;10037;10037.096661300482;10069.546870390814;9931.65239216624;9947.850782238273;9950.502474876228;9983.201343892471;9995.600175992988;9801.901980980241;9852.310338276324;9876.45679487628;9880.95059524705;9899.15857152143;40450;40911.772646820646;41047.589524104675;41137.588624113676;41329.58670413317;3313.453280208763;3446.1212390840174;3448.6723761242642;3461.671141241578;3462.3248466549035;30363.696363036306;30861.382772344426;30937.8453107733;31192;31409.371812563848;3036.9392612147635;3037.772167087477;3281.3273278977754;3285.5564498792596;3287.8356082195796;494872;499659;500754;501846;504037.4798126023;32936.835315823264;62402;62674.686626566574;63031.054534182025;63098.36901631017;33491;34785;34971;35132.297354053284;35166.824165879516;12483.50065997368;14954.102753834804;15062.096274223582;15098.773518397233;15123.092614443169;12623.242605443702;12710;12751.808722869164;12800.871991279968;12817.615471535868;7733;7752.641925537112;7765.689372425039;7809.609519524115;7862.8427431451055;3213.4858422652264;3216.5818443602184;3252.3495300939435;3260.7717459778064;3292.094673964631;935.854942483916;938.5635679409107;958.9568469418892;981.8379967305315;997.3517213811081;23263.53472930532;29504.704952950196;30579.2355191122;30994.535081973787;31386.52920206199;922.4649703172144;978.1392374710209;1041.7499800047933;1043.8538604595362;1065.0680654427376;14695.485658002133;15197.316120774592;15338.539843804703;15534;15625.984311019974;668763.656181716;681451;703202;703622;982765;58558.707206463696;59057.81884362289;59336.703316484;59472;59494.512637184416;1363.6454521824396;1367.6170672211797;1403.9508617198348;1408.5140626483847;1409.0770545292849;29874.402511950073;30978.69021309848;31156.040176183225;31163.53254701136;31513.8424307877;49775;50032.499675002786;50442.49557504525;50568.747156263984;50772.74613626908;582770;618864;620645;623288;626559;20933.162673493498;23720.88139559291;24730.25809225726;26992.865035674695;27431.17706468809;46856.062878742916;46877.2968405481;48559.51440485691;49187.50812491829;49215;35208;37111.628883710815;39869.800650996556;40224;41051.38422923599;39076.80461597674;39749.00627484336;39932.80033599814;40728;40796.79601601973;30802.845985769927;32410.675893240765;33293.33413331768;38035.04912377213;38915.61084389233;33672.831635842645;34850.128746781535;35350.46974295336;35702.821485892404;35715.10712232111;25875.482490350463;26280.4743905117;26405.867970660023;26449.33876653099;26731 09:02:04 INFO - PROCESS | 1957 | |2;jquery.html;364.64265020280124;373.1994871001703;377.18339794345246;384.96150384961527;395.8080331039445;19289.614207715855;21079.262225822098;21562.13751449944;21622.027008784604;21759.45601359963;20117.994100295;20289.49276268094;20787;20941;21029;5918.082697181922;5946.643201407907;6026.427489388523;6120.693965301717;6136.202293701835;3675.3016926783957;4159.376093585971;6031.336552979169;6058.121572372025;6131.264248290211;6412.551121421502;6681.699323530453;6755.729770809162;6808.6255255960905;6811.863762724743;6546.803595892131;6693.196816382041;6735.797926062226;6742.089817874573;6768.323167683241;5789.363170051291;5853.678047707374;5874.853128671774;5876.236089308405;5891.145783861316;25747;25993;26006;26269.949202032087;26314.079007234654;2119.7668256491775;2346.601077816775;2979.95530067047;3061.479548476764;3168.9207769805707;9975.90024099757;10361.740956476073;10461.372317660966;12694;15624.453144139901;1598.2568105830728;1767.6654126134815;1799.5591080185438;1808.7558179645712;1828.2504173289021;96569.9999999993;117730.6453870935;120952;121396;122985.38507307407;10208.642697505551;11026.724331891606;11466.713332166762;11924.224925379822;12019.939900300442;14706.705865882623;14710.779338309934;14751.92624036873;14755;14792.556223313102;8369.874451883226;8589.78525536854;8609.354298427643;8663.740087797376;8724.083971183061;8482.957585212158;8522.48865068098;8539.914600854036;8650.480971141751;8664.826703466022;4469.977650111794;4523;4540.841070562515;4594.471635761864;4621.283701026279;1323.7881938889732;1673.8995660260423;1903.5526651236949;1920.3950755512249;1963.4993076765334;817.264461984219;882.6601758323092;887.3389324952951;908.9045650206765;973.9756506087263;20415.489612759502;20451.079701413473;21563.353099407042;21712;21902.561948760937;917.6421195733669;924.5746956399997;930.6742640076054;951.0299494515693;965.3821554205314;10780.568777248822;11368.431578421212;11451.969322760991;11466.48400821965;11521.251118677426;483371;487107;491209;604289;630058;109581;112073.87926120634;121281;122385;129452.3527382357;954.4607296877242;1019.3781793106199;1020.357174979758;1027.825269704152;1084.8589683341115;19147;19522.60954780868;19590.412287631392;19677;19768.20927162955;36975.44536831896;37794.43308350432;46783.76608116938;53152.67118321918;55066.34800955978;70078.94881576882;71567.64216178886;76146.6192669033;76252.23747762451;76937;8028.1570435105805;8187.385946053951;8256.298214651822;8353.997520297604;8384.119667435076;10873.45632718345;13008.674783130118;13087.607371778862;13273.867261327263;13514.256715880721;11228.10175185967;11341.659750207507;11577.942110289394;11642.972827064854;11769.293842369485;9579.9042009579;11164.832527511931;11338;11425.714357141138;11434.599789007345;11573.768524629291;11661.80175136933;11687.88312116902;11822.34977076269;11873.228240164708;6746.291639377795;7981.960090199744;8033.558154301336;8222.958885205535;8254.504729716236;8796.296296296154;9303.813923721353;10362.222833287382;11225.60710375133;11627.88372116268 09:02:04 INFO - PROCESS | 1957 | |3;mootools.html;1391.2278685329643;1518.1194906953965;1729.3082766893242;1859.8140185981413;1882.3411805867956;8032.236937490929;8329.541875196861;8555.31557475402;9080.500572468512;9137.131972462614;7612.847743045136;8816.823663526726;8856.291496680265;8885.60014799334;8934.955325223382;2005.9498512537157;2355.6702061711376;2403.663487111806;2405.651180578815;2414.3843319953476;2386.940326491843;2398.1126983016306;2422.430728778744;2428.2472433545568;2434.9269521914284;2376.9762302376926;2406.109739396417;2422.2733180046002;2423.1761201191593;2425.757424257569;2381.2499062795337;2387.3792813868345;2399.064364897691;2405.4707964247923;2419.322589674894;2376.0733314007553;2377.0610608809598;2393.6050551658955;2395.4610212702178;2400.435897564071;9015.909840901639;9019.639214431414;9030.232430243437;9036.50299233542;9043.276537876955;4286.721363111388;5385.192221166817;5417.079096553595;5431.23962645226;5450.31871016123;3585.2470981094;3716.8699095531797;3736.7757934523743;3776.981115094407;3777.8111094445167;1071.2180108520824;1104.4588151805638;1112.238116889933;1113.6269349767838;1136.102479041556;11728.885755853265;11790.233634813796;11791.646250612495;11796.587119450778;11799.646010619696;4611.815527378867;4699.718016918996;4884.194107972145;4887.266909963463;4894.11905856942;9937.403755774532;10023.14803241718;10068.69793906184;10090.949545252226;10110.595576177018;5438.564914806806;5439.456054394529;5447.046766815792;5453.182022696627;5495.890082198333;4467.642588592905;4613.30800379939;4728.267118596623;4963.156263435225;4982.576480999156;3982.6614737747036;4011.498562679665;4106.240345536085;4143.19207754491;4149.066460046526;1318.8285522881963;1321.3327269728725;1329.2290471526492;1331.3010669398643;1347.7574036673493;818.5784321074651;844.6832437835811;855.8031652719909;891.7369376034086;925.2366797392178;5697.6296540724725;5848.473637372572;5926.4666180044005;5964.552658550626;5998.430149135826;446.8302045222795;454.2051410032443;454.5000499450644;461.40478782370366;462.4335189393034;3980.0845805464905;3983.7410568312966;3995.900102497461;4038.1116154445976;4095;10560.841587376195;10897.128229741602;10921.617743378943;10966.890331096747;10980.560777568968;10900.727481813017;10907.236493445384;10938.726531836608;10976;10987.39569323679;8246.38152138592;8301.667933282723;8316.459430137143;8364.832703346021;8405.579721013924;5816.70916454184;5875.14810352488;5882.705864706833;5988.910166347421;6037;9751.804963900824;10015.849762253427;10114.8482772757;10234.846477302995;10252;10375.94812025935;10412.583496660049;10433.008864157893;10439.739006524898;10468.057874791;6797.93202067973;7009.334113259232;7206.603636800026;7582.772516824504;7669.7315593953945;6535.934640653722;8265.297449716842;8306.377021723274;8416.284615807725;8523.019852717018;7426.74006409773;7583.582902940391;7599.506032107895;7599.620018998918;7665.156832748505;7350.228226036189;7451.143118541437;7453;7467.02928619276;7595.772126836204;6867.313268673292;6993.19578248508;7000.61496617691;7006.614636195059;7012.474064445289;4969.850904472872;5018.544622059562;5061.215511595708;5126.7180305083575;5159.664621799571;5075.746212689277;5108.208227724708;5150.510701483353;5201.817936372209;5202.101233049985 09:02:04 INFO - PROCESS | 1957 | |4;prototype.html;297.5358440832302;300.31528115895753;306.66726601637214;310.1470954874096;311.90954623159286;5368.731563421833;5554.777948851256;5631.662100273987;5648.89846479936;5707.942920570793;5357.276767636368;5396.163594642837;5473.534749546293;5503.724813759316;5538.806141785039;3574.6764603008123;4016;4027.1140349123148;4213.873583792476;4230.598093181143;4006.5793091725386;4146.859613606252;4214.66282697385;4253.340732186501;4289.721168124078;4083.8774836754947;4175.144095460423;4187.560306167854;4193.308104162809;4202.2856114460465;3864.516935383077;4202.558731333227;4217.680275848286;4249.575042495757;4251.872443826659;3323.966760332414;3625.29306785177;3671.9816400917825;3711.5175027246287;3715.1826598148637;4272.2950713132295;5309.256704061435;5315.44187860273;5361.356637203521;5385.542228910547;4391.890202744925;4573.794179261908;4728.527147285278;4808.61531077513;4896.6817156885045;5392.487713667196;5636.661800291996;5800.941990580082;5813.128030795372;5874.416605870459;3381.847816848223;4021.537523184842;4025.657819085381;4042.4340592316803;4091.631753142202;5625.971870140623;5852.756751355276;6133.44798968095;6140.324564297924;6142.324344322121;3115.8753649854207;3172.3655268946304;3975.542812576533;4082.6937979651643;4101.26177288085;3314.3537010283244;3974.5826688197903;4121.9381709274385;4143.523494798076;4148.979255103705;4811.446683631357;4813.326134341195;4819.349387832668;4843.564079232886;4870.805167793319;4983.6760610560195;5179.1195496764885;5614.438556144434;5836;5972;1214.4717048083935;1276.3745764575292;1279.7312564361403;1413.1732936232213;1414.7196786907864;711.3526690711428;806.4072906413782;829.7552222094497;866.3545658484469;867.7613656244457;4118.691098167649;4301.762444455552;4350.521442641307;4403.669724770655;4550;4549.658775591844;4583.312503124558;4901;5009.974950125299;5022.84931452057;4072.5971676710883;4201.6008479194425;4587.541245875385;4587.587117159405;4590.059037897223;2121.6157975159695;2388.952220955571;2458.8934979259047;2596.9610455843176;2642.3262068172494;4304.579488768699;4661.650376221797;5153.587712982952;5186.377634683862;5203.947960520422;4329.220740266719;4330.307150855848;4497.64018878489;4716.3632909557455;5195.948040519546;4534.057876914179;5064.8596321394;5068.518490743447;5180.740962951837;5192.8961420771375;4273.18809426208;5029.667138208304;5033.892543640393;5077.339945807169;5139.897202055863;4510.706804057726;4707.505711900201;4820.783064762024;4985.177445721415;5010.3737032870895;4285.528591854956;4310.4482386341515;4546;4941.527917234908;5172.663776854492;3434.3818112739946;3537.6816086551303;3538.84075216621;3557.982210088933;3572.5712914450432;4228.112096459655;4701.600363968964;5067.417247016493;5081.8475445736685;5837.445442682938;5312.707801070978;5336.22516291534;5584.692841893735;5744.253247077853;5888.352281249145;5861.589688721749;5879.676617785892;5884.205632239764;5898.1152827076285;5922.970385148046;4533.909321813611;5059.974700126476;5688.658680479184;5733.900261313014;5783.392743762012;4928.9156385595115;5298.70857102863;5645.491905728504;5901.085331773582;5921.881562368642;4622.907541849211;5125.79496820123;5782.2483077199695;5784.5083167929515;5836.533077353716 09:02:04 INFO - PROCESS | 1957 | |5;yui.html;723.1611330856206;733.5635296998286;762.1159455032164;765.6707615725239;785.956772377519;15016.723578495814;15279.847201527995;15575.987560808553;15606.609834754137;15720.056796592198;13917.512887048955;14108.576742697709;14115.647108822259;14135.78796318056;14175.362108705107;660.6663634864386;682.3926705232348;760.3157158557287;774.3263360876045;839.7732612194703;818.3575892924056;840.4663038970236;850.5279569838737;850.8000619854329;852.6035393542002;881.6649673124236;893.2630579771682;893.7318804358699;895.8253140637578;899.2895612466144;876.8027193881389;889.4574309671095;890.9465432074031;892.2460520859863;894.7315805258429;660.0693022837776;661.4774328280653;662.3343539742576;664.4219529009744;666.473485946102;14509.129452232793;14593.416263349452;14596.708065838624;14805.185714785683;14832.184229867353;14320.856791432056;14464.783028254584;14503.709925801424;14576;14755.26223688822;11127.72180695481;11609;11995.94002029993;12025.158238923279;12452.377381130998;3086.33643766589;3593.119685677;3817.5609804872515;3859.459675645412;3868.6905047596406;98328;116870;118188;122631.99999999911;125469;9814.65648702292;10804.405757683246;11239.494222759995;11313.773724525463;11597.100724818796;20791.960401980145;22899.31302060941;22952.426189345068;23014.8849255756;23071.653925191134;6544;7478.551286922802;7991.2807847294025;8050.879236811453;8202.876956845652;4369.650427965755;4453.532379100213;4453.755043472575;4507.88730281739;4576.542345765463;3480.9825950870086;3617.656322649344;3618.0231337539244;3631.4008188648577;3631.5279013728045;665.896785998171;668.0913957018452;676.0737789228788;678.1827897383641;695.7738734911175;581.6626356713097;616.5745635511482;621.176940553759;624.3475568031419;642.2485691740675;8655.6970506032;9048.864267035868;9156.313276504288;9242.399244049115;9327;604.0882944208871;611.3122736920964;615.1388056720538;620.2216218645661;634.8002275698933;3775.1505911169766;3810.504634397566;3870.632289932452;3926.509186351706;4469.486009108994;107993;169161;170904;171448.1427592854;176168.46686764937;144474.2776286112;146130.2693486547;147205;150232;155008;99015;99770.50114749525;129506;130375;132169.33915330362;9390.15003848419;9651.179649729851;9718.93593640174;9777.9367847791;9979.669935422125;58837.70581147067;59744.40255597388;60225.69887150536;62202;62604;69321.65339173272;90320.54839725759;91743;92519;93946;12869.613911582668;12948.287844168284;12951.5466958656;13251.271180085188;13363.39864706071;14189.787153192918;14487.85512144865;14688.926555367154;14817.110973341634;15103.4713785017;11661.9504244615;13628.70979759096;13648.454061837416;13741.175529468264;14013.929930350283;13736;13741.450341986209;13810.309484525935;14100.294985250901;14122.364493598017;12488.500459981498;12627.431765570755;12878.484860605471;12967.22196668203;13589.388477518338;10705.059793937971;11028.44857757125;11183.273087249303;11192.720181995515;12077.335746534025;10928.344299342065;11587.652370428901;11842.644720658394;11924.403779811148;11933.701657458632 09:02:04 INFO - PROCESS | 1957 | __end_tp_report 09:02:04 INFO - PROCESS | 1957 | __start_cc_report 09:02:04 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,371 09:02:04 INFO - PROCESS | 1957 | __end_cc_report 09:02:04 INFO - PROCESS | 1957 | __startTimestamp1476633724739__endTimestamp 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | ------- Summary: start ------- 09:02:04 INFO - PROCESS | 1957 | Number of tests: 6 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5851.94 Median:6095.63 stddev:657.84 (10.8%) stddev-sans-first:632.18 09:02:04 INFO - PROCESS | 1957 | Values: 3445.0 3459.9 3483.8 3485.7 3499.5 5894.9 5910.9 5960.4 6009.8 6025.7 5986.8 6049.5 6058.5 6073.8 6075.3 5380.5 5432.3 5452.1 5478.8 5561.9 5464.6 5480.6 5484.7 5498.9 5499.5 4451.8 5343.8 5366.4 5492.8 5542.2 5400.7 5420.4 5464.9 5470.2 5525.0 5355.8 5406.7 5425.6 5432.0 5449.9 4997.0 5730.6 6003.0 6031.2 6095.6 6209.2 6237.9 6245.4 6246.5 6334.4 5314.7 6284.4 6293.7 6311.6 6354.2 6083.9 6084.8 6086.3 6086.8 6094.0 6242.9 6258.6 6329.6 6343.1 6369.2 6302.0 6303.1 6307.8 6324.4 6332.6 6308.2 6314.5 6335.6 6342.9 6462.2 6189.1 6242.4 6249.5 6288.1 6303.4 6260.3 6275.3 6293.3 6304.3 6313.0 4989.5 5014.8 5020.8 5025.5 5030.1 4388.8 4434.2 4480.6 4491.8 4558.1 6006.1 6047.4 6070.2 6073.0 6090.9 4852.0 5412.5 5665.5 6322.4 6329.3 4552.5 5978.9 5989.4 6034.0 6062.9 5540.2 5546.1 5547.1 5573.9 5577.2 6457.7 6534.4 6537.7 6541.8 6551.1 5278.0 6126.6 6197.2 6212.2 6310.7 5510.3 6521.4 6529.2 6558.6 6561.2 6254.3 6261.9 6281.3 6286.7 6352.7 6195.2 6227.3 6297.7 6337.5 6338.5 6191.3 6305.1 6313.1 6322.6 6329.3 6300.9 6304.0 6306.0 6309.0 6353.0 5225.5 5482.9 6122.9 6132.7 6173.2 6172.7 6218.8 6226.8 6245.2 6291.7 6142.4 6155.2 6183.4 6186.9 6187.2 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:73328.05 Median:39809.40 stddev:170173.12 (427.5%) stddev-sans-first:170562.56 09:02:04 INFO - PROCESS | 1957 | Values: 464.2 515.7 519.8 545.0 545.7 39174.0 41441.4 41634.0 43365.6 43387.8 34051.0 42147.6 42390.0 42679.0 43039.1 9742.8 9778.5 9832.8 9882.9 9928.1 9818.5 9968.9 9993.7 10000.4 10056.5 9910.9 10020.5 10037.0 10037.1 10069.5 9931.7 9947.9 9950.5 9983.2 9995.6 9801.9 9852.3 9876.5 9881.0 9899.2 40450.0 40911.8 41047.6 41137.6 41329.6 3313.5 3446.1 3448.7 3461.7 3462.3 30363.7 30861.4 30937.8 31192.0 31409.4 3036.9 3037.8 3281.3 3285.6 3287.8 494872.0 499659.0 500754.0 501846.0 504037.5 32936.8 62402.0 62674.7 63031.1 63098.4 33491.0 34785.0 34971.0 35132.3 35166.8 12483.5 14954.1 15062.1 15098.8 15123.1 12623.2 12710.0 12751.8 12800.9 12817.6 7733.0 7752.6 7765.7 7809.6 7862.8 3213.5 3216.6 3252.3 3260.8 3292.1 935.9 938.6 959.0 981.8 997.4 23263.5 29504.7 30579.2 30994.5 31386.5 922.5 978.1 1041.7 1043.9 1065.1 14695.5 15197.3 15338.5 15534.0 15626.0 668763.7 681451.0 703202.0 703622.0 982765.0 58558.7 59057.8 59336.7 59472.0 59494.5 1363.6 1367.6 1404.0 1408.5 1409.1 29874.4 30978.7 31156.0 31163.5 31513.8 49775.0 50032.5 50442.5 50568.7 50772.7 582770.0 618864.0 620645.0 623288.0 626559.0 20933.2 23720.9 24730.3 26992.9 27431.2 46856.1 46877.3 48559.5 49187.5 49215.0 35208.0 37111.6 39869.8 40224.0 41051.4 39076.8 39749.0 39932.8 40728.0 40796.8 30802.8 32410.7 33293.3 38035.0 38915.6 33672.8 34850.1 35350.5 35702.8 35715.1 25875.5 26280.5 26405.9 26449.3 26731.0 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:32971.70 Median:14647.02 stddev:90824.46 (620.1%) stddev-sans-first:91046.25 09:02:04 INFO - PROCESS | 1957 | Values: 364.6 373.2 377.2 385.0 395.8 19289.6 21079.3 21562.1 21622.0 21759.5 20118.0 20289.5 20787.0 20941.0 21029.0 5918.1 5946.6 6026.4 6120.7 6136.2 3675.3 4159.4 6031.3 6058.1 6131.3 6412.6 6681.7 6755.7 6808.6 6811.9 6546.8 6693.2 6735.8 6742.1 6768.3 5789.4 5853.7 5874.9 5876.2 5891.1 25747.0 25993.0 26006.0 26269.9 26314.1 2119.8 2346.6 2980.0 3061.5 3168.9 9975.9 10361.7 10461.4 12694.0 15624.5 1598.3 1767.7 1799.6 1808.8 1828.3 96570.0 117730.6 120952.0 121396.0 122985.4 10208.6 11026.7 11466.7 11924.2 12019.9 14706.7 14710.8 14751.9 14755.0 14792.6 8369.9 8589.8 8609.4 8663.7 8724.1 8483.0 8522.5 8539.9 8650.5 8664.8 4470.0 4523.0 4540.8 4594.5 4621.3 1323.8 1673.9 1903.6 1920.4 1963.5 817.3 882.7 887.3 908.9 974.0 20415.5 20451.1 21563.4 21712.0 21902.6 917.6 924.6 930.7 951.0 965.4 10780.6 11368.4 11452.0 11466.5 11521.3 483371.0 487107.0 491209.0 604289.0 630058.0 109581.0 112073.9 121281.0 122385.0 129452.4 954.5 1019.4 1020.4 1027.8 1084.9 19147.0 19522.6 19590.4 19677.0 19768.2 36975.4 37794.4 46783.8 53152.7 55066.3 70078.9 71567.6 76146.6 76252.2 76937.0 8028.2 8187.4 8256.3 8354.0 8384.1 10873.5 13008.7 13087.6 13273.9 13514.3 11228.1 11341.7 11577.9 11643.0 11769.3 9579.9 11164.8 11338.0 11425.7 11434.6 11573.8 11661.8 11687.9 11822.3 11873.2 6746.3 7982.0 8033.6 8223.0 8254.5 8796.3 9303.8 10362.2 11225.6 11627.9 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:5761.53 Median:2537.87 stddev:3250.95 (128.1%) stddev-sans-first:3243.48 09:02:04 INFO - PROCESS | 1957 | Values: 1391.2 1518.1 1729.3 1859.8 1882.3 8032.2 8329.5 8555.3 9080.5 9137.1 7612.8 8816.8 8856.3 8885.6 8935.0 2005.9 2355.7 2403.7 2405.7 2414.4 2386.9 2398.1 2422.4 2428.2 2434.9 2377.0 2406.1 2422.3 2423.2 2425.8 2381.2 2387.4 2399.1 2405.5 2419.3 2376.1 2377.1 2393.6 2395.5 2400.4 9015.9 9019.6 9030.2 9036.5 9043.3 4286.7 5385.2 5417.1 5431.2 5450.3 3585.2 3716.9 3736.8 3777.0 3777.8 1071.2 1104.5 1112.2 1113.6 1136.1 11728.9 11790.2 11791.6 11796.6 11799.6 4611.8 4699.7 4884.2 4887.3 4894.1 9937.4 10023.1 10068.7 10090.9 10110.6 5438.6 5439.5 5447.0 5453.2 5495.9 4467.6 4613.3 4728.3 4963.2 4982.6 3982.7 4011.5 4106.2 4143.2 4149.1 1318.8 1321.3 1329.2 1331.3 1347.8 818.6 844.7 855.8 891.7 925.2 5697.6 5848.5 5926.5 5964.6 5998.4 446.8 454.2 454.5 461.4 462.4 3980.1 3983.7 3995.9 4038.1 4095.0 10560.8 10897.1 10921.6 10966.9 10980.6 10900.7 10907.2 10938.7 10976.0 10987.4 8246.4 8301.7 8316.5 8364.8 8405.6 5816.7 5875.1 5882.7 5988.9 6037.0 9751.8 10015.8 10114.8 10234.8 10252.0 10375.9 10412.6 10433.0 10439.7 10468.1 6797.9 7009.3 7206.6 7582.8 7669.7 6535.9 8265.3 8306.4 8416.3 8523.0 7426.7 7583.6 7599.5 7599.6 7665.2 7350.2 7451.1 7453.0 7467.0 7595.8 6867.3 6993.2 7000.6 7006.6 7012.5 4969.9 5018.5 5061.2 5126.7 5159.7 5075.7 5108.2 5150.5 5201.8 5202.1 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:4394.31 Median:4711.93 stddev:1352.29 (28.7%) stddev-sans-first:1320.66 09:02:04 INFO - PROCESS | 1957 | Values: 297.5 300.3 306.7 310.1 311.9 5368.7 5554.8 5631.7 5648.9 5707.9 5357.3 5396.2 5473.5 5503.7 5538.8 3574.7 4016.0 4027.1 4213.9 4230.6 4006.6 4146.9 4214.7 4253.3 4289.7 4083.9 4175.1 4187.6 4193.3 4202.3 3864.5 4202.6 4217.7 4249.6 4251.9 3324.0 3625.3 3672.0 3711.5 3715.2 4272.3 5309.3 5315.4 5361.4 5385.5 4391.9 4573.8 4728.5 4808.6 4896.7 5392.5 5636.7 5800.9 5813.1 5874.4 3381.8 4021.5 4025.7 4042.4 4091.6 5626.0 5852.8 6133.4 6140.3 6142.3 3115.9 3172.4 3975.5 4082.7 4101.3 3314.4 3974.6 4121.9 4143.5 4149.0 4811.4 4813.3 4819.3 4843.6 4870.8 4983.7 5179.1 5614.4 5836.0 5972.0 1214.5 1276.4 1279.7 1413.2 1414.7 711.4 806.4 829.8 866.4 867.8 4118.7 4301.8 4350.5 4403.7 4550.0 4549.7 4583.3 4901.0 5010.0 5022.8 4072.6 4201.6 4587.5 4587.6 4590.1 2121.6 2389.0 2458.9 2597.0 2642.3 4304.6 4661.7 5153.6 5186.4 5203.9 4329.2 4330.3 4497.6 4716.4 5195.9 4534.1 5064.9 5068.5 5180.7 5192.9 4273.2 5029.7 5033.9 5077.3 5139.9 4510.7 4707.5 4820.8 4985.2 5010.4 4285.5 4310.4 4546.0 4941.5 5172.7 3434.4 3537.7 3538.8 3558.0 3572.6 4228.1 4701.6 5067.4 5081.8 5837.4 5312.7 5336.2 5584.7 5744.3 5888.4 5861.6 5879.7 5884.2 5898.1 5923.0 4533.9 5060.0 5688.7 5733.9 5783.4 4928.9 5298.7 5645.5 5901.1 5921.9 4622.9 5125.8 5782.2 5784.5 5836.5 09:02:04 INFO - PROCESS | 1957 | 09:02:04 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:25948.74 Median:3624.71 stddev:43008.93 (1186.5%) stddev-sans-first:43087.87 09:02:04 INFO - PROCESS | 1957 | Values: 723.2 733.6 762.1 765.7 786.0 15016.7 15279.8 15576.0 15606.6 15720.1 13917.5 14108.6 14115.6 14135.8 14175.4 660.7 682.4 760.3 774.3 839.8 818.4 840.5 850.5 850.8 852.6 881.7 893.3 893.7 895.8 899.3 876.8 889.5 890.9 892.2 894.7 660.1 661.5 662.3 664.4 666.5 14509.1 14593.4 14596.7 14805.2 14832.2 14320.9 14464.8 14503.7 14576.0 14755.3 11127.7 11609.0 11995.9 12025.2 12452.4 3086.3 3593.1 3817.6 3859.5 3868.7 98328.0 116870.0 118188.0 122632.0 125469.0 9814.7 10804.4 11239.5 11313.8 11597.1 20792.0 22899.3 22952.4 23014.9 23071.7 6544.0 7478.6 7991.3 8050.9 8202.9 4369.7 4453.5 4453.8 4507.9 4576.5 3481.0 3617.7 3618.0 3631.4 3631.5 665.9 668.1 676.1 678.2 695.8 581.7 616.6 621.2 624.3 642.2 8655.7 9048.9 9156.3 9242.4 9327.0 604.1 611.3 615.1 620.2 634.8 3775.2 3810.5 3870.6 3926.5 4469.5 107993.0 169161.0 170904.0 171448.1 176168.5 144474.3 146130.3 147205.0 150232.0 155008.0 99015.0 99770.5 129506.0 130375.0 132169.3 9390.2 9651.2 9718.9 9777.9 9979.7 58837.7 59744.4 60225.7 62202.0 62604.0 69321.7 90320.5 91743.0 92519.0 93946.0 12869.6 12948.3 12951.5 13251.3 13363.4 14189.8 14487.9 14688.9 14817.1 15103.5 11662.0 13628.7 13648.5 13741.2 14013.9 13736.0 13741.5 13810.3 14100.3 14122.4 12488.5 12627.4 12878.5 12967.2 13589.4 10705.1 11028.4 11183.3 11192.7 12077.3 10928.3 11587.7 11842.6 11924.4 11933.7 09:02:04 INFO - PROCESS | 1957 | -------- Summary: end -------- 09:02:04 INFO - PROCESS | 1957 | 09:02:05 INFO - TEST-INFO | 1957: exit 0 09:02:05 INFO - TEST-OK | dromaeo_css | took 1113714ms 09:02:05 INFO - TEST-START | kraken 09:02:05 INFO - operating with platform_type : mac_ 09:02:05 INFO - Initialising browser for kraken test... 09:02:05 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpJ2_KZZ/profile http://localhost:49649/getInfo.html) 09:02:08 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 09:02:08 INFO - PROCESS | 1962 | colorDepth:24 09:02:08 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 09:02:08 INFO - PROCESS | 1962 | __metrics 09:02:08 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:02:08 INFO - TEST-INFO | 1962: exit 0 09:02:08 INFO - Browser initialized. 09:02:08 INFO - Running cycle 1/1 for kraken test... 09:02:08 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpJ2_KZZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:20 INFO - PROCESS | 1964 | RSS: Main: 224972800 09:02:20 INFO - PROCESS | 1964 | 09:02:23 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:24 INFO - PROCESS | 1964 | RSS: Main: 237428736 09:02:24 INFO - PROCESS | 1964 | 09:02:27 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-dft) 09:02:28 INFO - PROCESS | 1964 | RSS: Main: 246108160 09:02:28 INFO - PROCESS | 1964 | 09:02:31 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-fft) 09:02:32 INFO - PROCESS | 1964 | RSS: Main: 249118720 09:02:32 INFO - PROCESS | 1964 | 09:02:34 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator) 09:02:34 INFO - PROCESS | 1964 | RSS: Main: 249143296 09:02:34 INFO - PROCESS | 1964 | 09:02:36 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:37 INFO - PROCESS | 1964 | RSS: Main: 249171968 09:02:37 INFO - PROCESS | 1964 | 09:02:40 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:41 INFO - PROCESS | 1964 | RSS: Main: 249274368 09:02:41 INFO - PROCESS | 1964 | 09:02:44 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:45 INFO - PROCESS | 1964 | RSS: Main: 250753024 09:02:45 INFO - PROCESS | 1964 | 09:02:48 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial) 09:02:48 INFO - PROCESS | 1964 | RSS: Main: 250712064 09:02:48 INFO - PROCESS | 1964 | 09:02:50 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:51 INFO - PROCESS | 1964 | RSS: Main: 250585088 09:02:51 INFO - PROCESS | 1964 | 09:02:52 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:53 INFO - PROCESS | 1964 | RSS: Main: 250593280 09:02:53 INFO - PROCESS | 1964 | 09:02:55 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:56 INFO - PROCESS | 1964 | RSS: Main: 250712064 09:02:56 INFO - PROCESS | 1964 | 09:02:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:00 INFO - PROCESS | 1964 | RSS: Main: 251060224 09:03:00 INFO - PROCESS | 1964 | 09:03:02 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:03 INFO - PROCESS | 1964 | RSS: Main: 250810368 09:03:03 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49649/tests/kraken/driver.html?testName=ai-astar) 09:03:05 INFO - PROCESS | 1964 | RSS: Main: 252362752 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | __start_tp_report 09:03:05 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 09:03:05 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 09:03:05 INFO - PROCESS | 1964 | |i|pagename|runs| 09:03:05 INFO - PROCESS | 1964 | |0;ai-astar;106;120;159;140;116;120;122;119;117;117 09:03:05 INFO - PROCESS | 1964 | |1;audio-beat-detection;144;110;113;175;98;141;137;138;125;141 09:03:05 INFO - PROCESS | 1964 | |2;audio-dft;270;251;192;202;253;198;197;198;203;193 09:03:05 INFO - PROCESS | 1964 | |3;audio-fft;82;62;59;84;83;92;85;66;79;59 09:03:05 INFO - PROCESS | 1964 | |4;audio-oscillator;84;71;91;72;70;60;119;92;100;100 09:03:05 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;135;128;119;97;135;80;78;95;134;107 09:03:05 INFO - PROCESS | 1964 | |6;imaging-darkroom;101;105;137;173;102;136;109;132;132;100 09:03:05 INFO - PROCESS | 1964 | |7;imaging-desaturate;151;147;93;92;93;124;145;132;92;98 09:03:05 INFO - PROCESS | 1964 | |8;json-parse-financial;56;56;55;56;59;61;60;86;61;60 09:03:05 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;69;73;68;82;80;62;67;81;68;76 09:03:05 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;87;80;83;85;83;98;83;88;85;83 09:03:05 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;158;162;130;149;151;144;149;161;194;144 09:03:05 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;166;168;167;166;174;166;165;167;166;164 09:03:05 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;69;68;66;90;68;67;66;66;68;66 09:03:05 INFO - PROCESS | 1964 | __end_tp_report 09:03:05 INFO - PROCESS | 1964 | __start_cc_report 09:03:05 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,957 09:03:05 INFO - PROCESS | 1964 | __end_cc_report 09:03:05 INFO - PROCESS | 1964 | __startTimestamp1476633785452__endTimestamp 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | ------- Summary: start ------- 09:03:05 INFO - PROCESS | 1964 | Number of tests: 14 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:123.60 Median:120.00 stddev:15.01 (12.5%) stddev-sans-first:14.50 09:03:05 INFO - PROCESS | 1964 | Values: 106.0 120.0 159.0 140.0 116.0 120.0 122.0 119.0 117.0 117.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:141.00 stddev:21.77 (15.4%) stddev-sans-first:22.67 09:03:05 INFO - PROCESS | 1964 | Values: 144.0 110.0 113.0 175.0 98.0 141.0 137.0 138.0 125.0 141.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:215.70 Median:202.50 stddev:29.79 (14.7%) stddev-sans-first:24.27 09:03:05 INFO - PROCESS | 1964 | Values: 270.0 251.0 192.0 202.0 253.0 198.0 197.0 198.0 203.0 193.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:75.10 Median:82.50 stddev:12.30 (14.9%) stddev-sans-first:12.79 09:03:05 INFO - PROCESS | 1964 | Values: 82.0 62.0 59.0 84.0 83.0 92.0 85.0 66.0 79.0 59.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:71.50 stddev:17.95 (25.1%) stddev-sans-first:19.02 09:03:05 INFO - PROCESS | 1964 | Values: 84.0 71.0 91.0 72.0 70.0 60.0 119.0 92.0 100.0 100.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:106.50 stddev:22.49 (21.1%) stddev-sans-first:22.08 09:03:05 INFO - PROCESS | 1964 | Values: 135.0 128.0 119.0 97.0 135.0 80.0 78.0 95.0 134.0 107.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:122.70 Median:132.00 stddev:23.57 (17.9%) stddev-sans-first:23.66 09:03:05 INFO - PROCESS | 1964 | Values: 101.0 105.0 137.0 173.0 102.0 136.0 109.0 132.0 132.0 100.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:116.70 Median:92.00 stddev:25.55 (27.8%) stddev-sans-first:23.90 09:03:05 INFO - PROCESS | 1964 | Values: 151.0 147.0 93.0 92.0 93.0 124.0 145.0 132.0 92.0 98.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:60.00 stddev:9.08 (15.1%) stddev-sans-first:9.45 09:03:05 INFO - PROCESS | 1964 | Values: 56.0 56.0 55.0 56.0 59.0 61.0 60.0 86.0 61.0 60.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:74.50 stddev:6.87 (9.2%) stddev-sans-first:7.16 09:03:05 INFO - PROCESS | 1964 | Values: 69.0 73.0 68.0 82.0 80.0 62.0 67.0 81.0 68.0 76.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:4.95 (5.8%) stddev-sans-first:5.22 09:03:05 INFO - PROCESS | 1964 | Values: 87.0 80.0 83.0 85.0 83.0 98.0 83.0 88.0 85.0 83.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:154.50 stddev:16.88 (10.9%) stddev-sans-first:17.85 09:03:05 INFO - PROCESS | 1964 | Values: 158.0 162.0 130.0 149.0 151.0 144.0 149.0 161.0 194.0 144.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.50 stddev:2.73 (1.6%) stddev-sans-first:2.87 09:03:05 INFO - PROCESS | 1964 | Values: 166.0 168.0 167.0 166.0 174.0 166.0 165.0 167.0 166.0 164.0 09:03:05 INFO - PROCESS | 1964 | 09:03:05 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.00 stddev:7.32 (10.8%) stddev-sans-first:7.76 09:03:05 INFO - PROCESS | 1964 | Values: 69.0 68.0 66.0 90.0 68.0 67.0 66.0 66.0 68.0 66.0 09:03:05 INFO - PROCESS | 1964 | -------- Summary: end -------- 09:03:05 INFO - PROCESS | 1964 | 09:03:06 INFO - TEST-INFO | 1964: exit 0 09:03:06 INFO - TEST-OK | kraken | took 60794ms 09:03:06 INFO - SUITE-END | took 1174s 09:03:06 INFO - Completed test suite (00:19:34) 09:03:06 INFO - javascript benchmark 09:03:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7281.731240272406, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3445.00094972458, 3459.9135021624456, 3483.8432270547837, 3485.73856960728, 3499.47507873819, 5894.941050589493, 5910.852228694284, 5960.4039596040375, 6009.789657361993, 6025.7288422021, 5986.820395388135, 6049.455549000589, 6058.454739073482, 6073.817785466432, 6075.33171351151, 5380.488853558905, 5432.348118225818, 5452.073147564924, 5478.808241711541, 5561.860953476155, 5464.590155738316, 5480.588955828329, 5484.698341591211, 5498.890022199554, 5499.532539734128, 4451.777411129447, 5343.812966546172, 5366.382865970424, 5492.780288788444, 5542.224088627595, 5400.702961337144, 5420.403755586883, 5464.863378415532, 5470.152126420411, 5525.0, 5355.758990845421, 5406.675599464044, 5425.647332923348, 5431.972840135774, 5449.945500544984, 4996.975015124937, 5730.627509211888, 6003.009503431928, 6031.215941927521, 6095.634261944253, 6209.192804935375, 6237.937620623827, 6245.375462453719, 6246.469050130744, 6334.366563343675, 5314.707691076989, 6284.4344009039405, 6293.653849038301, 6311.589746666498, 6354.205724284465, 6083.9391606084255, 6084.756609735561, 6086.330503644595, 6086.786962456293, 6093.969530152365, 6242.875142497124, 6258.593191442542, 6329.620222786648, 6343.111964324999, 6369.20384951881, 6302.0, 6303.086052522451, 6307.810765677037, 6324.430801227912, 6332.556721029576, 6308.179936608211, 6314.526410519137, 6335.556511044275, 6342.904856427157, 6462.159919210472, 6189.071639254148, 6242.438180563771, 6249.500039996789, 6288.088227207029, 6303.401176888188, 6260.342664020303, 6275.341089185661, 6293.276273228637, 6304.275008374096, 6313.0, 4989.525995030466, 5014.824481143142, 5020.824271150492, 5025.497450254945, 5030.094582975026, 4388.846390376321, 4434.224010798098, 4480.596746292849, 4491.820327186876, 4558.088382323548, 6006.12911127884, 6047.365026672136, 6070.180525628984, 6073.0, 6090.939090609126, 4852.0295940811975, 5412.539934105566, 5665.5467562594895, 6322.367763223733, 6329.2721337045905, 4552.453705555355, 5978.850528736816, 5989.371116032841, 6034.0, 6062.878742425127, 5540.2243685884005, 5546.112621980545, 5547.084731019418, 5573.888522229533, 5577.191307260506, 6457.741690332428, 6534.411902928759, 6537.70580323877, 6541.803745887631, 6551.082848401227, 5278.0, 6126.6017708848785, 6197.194364732556, 6212.223472065992, 6310.684465776784, 5510.311211098613, 6521.445677117498, 6529.183852018497, 6558.639274839738, 6561.179852518435, 6254.312025677081, 6261.874762504815, 6281.277653069773, 6286.6856657166045, 6352.68236588178, 6195.2255968004, 6227.346128656607, 6297.653629050446, 6337.524685648687, 6338.492920566251, 6191.25704915413, 6305.085762564311, 6313.116163737172, 6322.620642761449, 6329.30377658448, 6300.936990630035, 6303.9684801575695, 6305.96847015762, 6308.968455157695, 6353.047042943411, 5225.477452254744, 5482.890342193054, 6122.938770612237, 6132.724027418866, 6173.228346456693, 6172.660503672161, 6218.782342618168, 6226.813195604139, 6245.156903817927, 6291.653959032297, 6142.385761423822, 6155.199824022849, 6183.350748171377, 6186.876262474635, 6187.16473276102], "value": 5812.937315692318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.2456008985399, 515.7493079282739, 519.76350760404, 544.9809256676016, 545.7271364317841, 39173.99999999996, 41441.3783793243, 41634.0, 43365.56634433655, 43387.78306108465, 34050.97847064592, 42147.57852421475, 42390.0, 42679.0, 43039.139217215634, 9742.756431089227, 9778.462184579845, 9832.754181145458, 9882.851757223647, 9928.10647041766, 9818.50907454628, 9968.850467242997, 9993.650222242222, 10000.399976001463, 10056.547455364489, 9910.90089099107, 10020.549075291592, 10037.0, 10037.096661300482, 10069.546870390814, 9931.65239216624, 9947.850782238273, 9950.502474876228, 9983.201343892471, 9995.600175992988, 9801.901980980241, 9852.310338276324, 9876.45679487628, 9880.95059524705, 9899.15857152143, 40450.0, 40911.772646820646, 41047.589524104675, 41137.588624113676, 41329.58670413317, 3313.453280208763, 3446.1212390840174, 3448.6723761242642, 3461.671141241578, 3462.3248466549035, 30363.696363036306, 30861.382772344426, 30937.8453107733, 31192.0, 31409.371812563848, 3036.9392612147635, 3037.772167087477, 3281.3273278977754, 3285.5564498792596, 3287.8356082195796, 494872.0, 499659.0, 500754.0, 501846.0, 504037.4798126023, 32936.835315823264, 62402.0, 62674.686626566574, 63031.054534182025, 63098.36901631017, 33491.0, 34785.0, 34971.0, 35132.297354053284, 35166.824165879516, 12483.50065997368, 14954.102753834804, 15062.096274223582, 15098.773518397233, 15123.092614443169, 12623.242605443702, 12710.0, 12751.808722869164, 12800.871991279968, 12817.615471535868, 7733.0, 7752.641925537112, 7765.689372425039, 7809.609519524115, 7862.8427431451055, 3213.4858422652264, 3216.5818443602184, 3252.3495300939435, 3260.7717459778064, 3292.094673964631, 935.854942483916, 938.5635679409107, 958.9568469418892, 981.8379967305315, 997.3517213811081, 23263.53472930532, 29504.704952950196, 30579.2355191122, 30994.535081973787, 31386.52920206199, 922.4649703172144, 978.1392374710209, 1041.7499800047933, 1043.8538604595362, 1065.0680654427376, 14695.485658002133, 15197.316120774592, 15338.539843804703, 15534.0, 15625.984311019974, 668763.656181716, 681451.0, 703202.0, 703622.0, 982765.0, 58558.707206463696, 59057.81884362289, 59336.703316484, 59472.0, 59494.512637184416, 1363.6454521824396, 1367.6170672211797, 1403.9508617198348, 1408.5140626483847, 1409.0770545292849, 29874.402511950073, 30978.69021309848, 31156.040176183225, 31163.53254701136, 31513.8424307877, 49775.0, 50032.499675002786, 50442.49557504525, 50568.747156263984, 50772.74613626908, 582770.0, 618864.0, 620645.0, 623288.0, 626559.0, 20933.162673493498, 23720.88139559291, 24730.25809225726, 26992.865035674695, 27431.17706468809, 46856.062878742916, 46877.2968405481, 48559.51440485691, 49187.50812491829, 49215.0, 35208.0, 37111.628883710815, 39869.800650996556, 40224.0, 41051.38422923599, 39076.80461597674, 39749.00627484336, 39932.80033599814, 40728.0, 40796.79601601973, 30802.845985769927, 32410.675893240765, 33293.33413331768, 38035.04912377213, 38915.61084389233, 33672.831635842645, 34850.128746781535, 35350.46974295336, 35702.821485892404, 35715.10712232111, 25875.482490350463, 26280.4743905117, 26405.867970660023, 26449.33876653099, 26731.0], "value": 18858.429879682204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.64265020280124, 373.1994871001703, 377.18339794345246, 384.96150384961527, 395.8080331039445, 19289.614207715855, 21079.262225822098, 21562.13751449944, 21622.027008784604, 21759.45601359963, 20117.994100295, 20289.49276268094, 20787.0, 20941.0, 21029.0, 5918.082697181922, 5946.643201407907, 6026.427489388523, 6120.693965301717, 6136.202293701835, 3675.3016926783957, 4159.376093585971, 6031.336552979169, 6058.121572372025, 6131.264248290211, 6412.551121421502, 6681.699323530453, 6755.729770809162, 6808.6255255960905, 6811.863762724743, 6546.803595892131, 6693.196816382041, 6735.797926062226, 6742.089817874573, 6768.323167683241, 5789.363170051291, 5853.678047707374, 5874.853128671774, 5876.236089308405, 5891.145783861316, 25747.0, 25993.0, 26006.0, 26269.949202032087, 26314.079007234654, 2119.7668256491775, 2346.601077816775, 2979.95530067047, 3061.479548476764, 3168.9207769805707, 9975.90024099757, 10361.740956476073, 10461.372317660966, 12694.0, 15624.453144139901, 1598.2568105830728, 1767.6654126134815, 1799.5591080185438, 1808.7558179645712, 1828.2504173289021, 96569.9999999993, 117730.6453870935, 120952.0, 121396.0, 122985.38507307407, 10208.642697505551, 11026.724331891606, 11466.713332166762, 11924.224925379822, 12019.939900300442, 14706.705865882623, 14710.779338309934, 14751.92624036873, 14755.0, 14792.556223313102, 8369.874451883226, 8589.78525536854, 8609.354298427643, 8663.740087797376, 8724.083971183061, 8482.957585212158, 8522.48865068098, 8539.914600854036, 8650.480971141751, 8664.826703466022, 4469.977650111794, 4523.0, 4540.841070562515, 4594.471635761864, 4621.283701026279, 1323.7881938889732, 1673.8995660260423, 1903.5526651236949, 1920.3950755512249, 1963.4993076765334, 817.264461984219, 882.6601758323092, 887.3389324952951, 908.9045650206765, 973.9756506087263, 20415.489612759502, 20451.079701413473, 21563.353099407042, 21712.0, 21902.561948760937, 917.6421195733669, 924.5746956399997, 930.6742640076054, 951.0299494515693, 965.3821554205314, 10780.568777248822, 11368.431578421212, 11451.969322760991, 11466.48400821965, 11521.251118677426, 483371.0, 487107.0, 491209.0, 604289.0, 630058.0, 109581.0, 112073.87926120634, 121281.0, 122385.0, 129452.3527382357, 954.4607296877242, 1019.3781793106199, 1020.357174979758, 1027.825269704152, 1084.8589683341115, 19147.0, 19522.60954780868, 19590.412287631392, 19677.0, 19768.20927162955, 36975.44536831896, 37794.43308350432, 46783.76608116938, 53152.67118321918, 55066.34800955978, 70078.94881576882, 71567.64216178886, 76146.6192669033, 76252.23747762451, 76937.0, 8028.1570435105805, 8187.385946053951, 8256.298214651822, 8353.997520297604, 8384.119667435076, 10873.45632718345, 13008.674783130118, 13087.607371778862, 13273.867261327263, 13514.256715880721, 11228.10175185967, 11341.659750207507, 11577.942110289394, 11642.972827064854, 11769.293842369485, 9579.9042009579, 11164.832527511931, 11338.0, 11425.714357141138, 11434.599789007345, 11573.768524629291, 11661.80175136933, 11687.88312116902, 11822.34977076269, 11873.228240164708, 6746.291639377795, 7981.960090199744, 8033.558154301336, 8222.958885205535, 8254.504729716236, 8796.296296296154, 9303.813923721353, 10362.222833287382, 11225.60710375133, 11627.88372116268], "value": 9627.795175080684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.2278685329643, 1518.1194906953965, 1729.3082766893242, 1859.8140185981413, 1882.3411805867956, 8032.236937490929, 8329.541875196861, 8555.31557475402, 9080.500572468512, 9137.131972462614, 7612.847743045136, 8816.823663526726, 8856.291496680265, 8885.60014799334, 8934.955325223382, 2005.9498512537157, 2355.6702061711376, 2403.663487111806, 2405.651180578815, 2414.3843319953476, 2386.940326491843, 2398.1126983016306, 2422.430728778744, 2428.2472433545568, 2434.9269521914284, 2376.9762302376926, 2406.109739396417, 2422.2733180046002, 2423.1761201191593, 2425.757424257569, 2381.2499062795337, 2387.3792813868345, 2399.064364897691, 2405.4707964247923, 2419.322589674894, 2376.0733314007553, 2377.0610608809598, 2393.6050551658955, 2395.4610212702178, 2400.435897564071, 9015.909840901639, 9019.639214431414, 9030.232430243437, 9036.50299233542, 9043.276537876955, 4286.721363111388, 5385.192221166817, 5417.079096553595, 5431.23962645226, 5450.31871016123, 3585.2470981094, 3716.8699095531797, 3736.7757934523743, 3776.981115094407, 3777.8111094445167, 1071.2180108520824, 1104.4588151805638, 1112.238116889933, 1113.6269349767838, 1136.102479041556, 11728.885755853265, 11790.233634813796, 11791.646250612495, 11796.587119450778, 11799.646010619696, 4611.815527378867, 4699.718016918996, 4884.194107972145, 4887.266909963463, 4894.11905856942, 9937.403755774532, 10023.14803241718, 10068.69793906184, 10090.949545252226, 10110.595576177018, 5438.564914806806, 5439.456054394529, 5447.046766815792, 5453.182022696627, 5495.890082198333, 4467.642588592905, 4613.30800379939, 4728.267118596623, 4963.156263435225, 4982.576480999156, 3982.6614737747036, 4011.498562679665, 4106.240345536085, 4143.19207754491, 4149.066460046526, 1318.8285522881963, 1321.3327269728725, 1329.2290471526492, 1331.3010669398643, 1347.7574036673493, 818.5784321074651, 844.6832437835811, 855.8031652719909, 891.7369376034086, 925.2366797392178, 5697.6296540724725, 5848.473637372572, 5926.4666180044005, 5964.552658550626, 5998.430149135826, 446.8302045222795, 454.2051410032443, 454.5000499450644, 461.40478782370366, 462.4335189393034, 3980.0845805464905, 3983.7410568312966, 3995.900102497461, 4038.1116154445976, 4095.0, 10560.841587376195, 10897.128229741602, 10921.617743378943, 10966.890331096747, 10980.560777568968, 10900.727481813017, 10907.236493445384, 10938.726531836608, 10976.0, 10987.39569323679, 8246.38152138592, 8301.667933282723, 8316.459430137143, 8364.832703346021, 8405.579721013924, 5816.70916454184, 5875.14810352488, 5882.705864706833, 5988.910166347421, 6037.0, 9751.804963900824, 10015.849762253427, 10114.8482772757, 10234.846477302995, 10252.0, 10375.94812025935, 10412.583496660049, 10433.008864157893, 10439.739006524898, 10468.057874791, 6797.93202067973, 7009.334113259232, 7206.603636800026, 7582.772516824504, 7669.7315593953945, 6535.934640653722, 8265.297449716842, 8306.377021723274, 8416.284615807725, 8523.019852717018, 7426.74006409773, 7583.582902940391, 7599.506032107895, 7599.620018998918, 7665.156832748505, 7350.228226036189, 7451.143118541437, 7453.0, 7467.02928619276, 7595.772126836204, 6867.313268673292, 6993.19578248508, 7000.61496617691, 7006.614636195059, 7012.474064445289, 4969.850904472872, 5018.544622059562, 5061.215511595708, 5126.7180305083575, 5159.664621799571, 5075.746212689277, 5108.208227724708, 5150.510701483353, 5201.817936372209, 5202.101233049985], "value": 4556.207121647545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5358440832302, 300.31528115895753, 306.66726601637214, 310.1470954874096, 311.90954623159286, 5368.731563421833, 5554.777948851256, 5631.662100273987, 5648.89846479936, 5707.942920570793, 5357.276767636368, 5396.163594642837, 5473.534749546293, 5503.724813759316, 5538.806141785039, 3574.6764603008123, 4016.0, 4027.1140349123148, 4213.873583792476, 4230.598093181143, 4006.5793091725386, 4146.859613606252, 4214.66282697385, 4253.340732186501, 4289.721168124078, 4083.8774836754947, 4175.144095460423, 4187.560306167854, 4193.308104162809, 4202.2856114460465, 3864.516935383077, 4202.558731333227, 4217.680275848286, 4249.575042495757, 4251.872443826659, 3323.966760332414, 3625.29306785177, 3671.9816400917825, 3711.5175027246287, 3715.1826598148637, 4272.2950713132295, 5309.256704061435, 5315.44187860273, 5361.356637203521, 5385.542228910547, 4391.890202744925, 4573.794179261908, 4728.527147285278, 4808.61531077513, 4896.6817156885045, 5392.487713667196, 5636.661800291996, 5800.941990580082, 5813.128030795372, 5874.416605870459, 3381.847816848223, 4021.537523184842, 4025.657819085381, 4042.4340592316803, 4091.631753142202, 5625.971870140623, 5852.756751355276, 6133.44798968095, 6140.324564297924, 6142.324344322121, 3115.8753649854207, 3172.3655268946304, 3975.542812576533, 4082.6937979651643, 4101.26177288085, 3314.3537010283244, 3974.5826688197903, 4121.9381709274385, 4143.523494798076, 4148.979255103705, 4811.446683631357, 4813.326134341195, 4819.349387832668, 4843.564079232886, 4870.805167793319, 4983.6760610560195, 5179.1195496764885, 5614.438556144434, 5836.0, 5972.0, 1214.4717048083935, 1276.3745764575292, 1279.7312564361403, 1413.1732936232213, 1414.7196786907864, 711.3526690711428, 806.4072906413782, 829.7552222094497, 866.3545658484469, 867.7613656244457, 4118.691098167649, 4301.762444455552, 4350.521442641307, 4403.669724770655, 4550.0, 4549.658775591844, 4583.312503124558, 4901.0, 5009.974950125299, 5022.84931452057, 4072.5971676710883, 4201.6008479194425, 4587.541245875385, 4587.587117159405, 4590.059037897223, 2121.6157975159695, 2388.952220955571, 2458.8934979259047, 2596.9610455843176, 2642.3262068172494, 4304.579488768699, 4661.650376221797, 5153.587712982952, 5186.377634683862, 5203.947960520422, 4329.220740266719, 4330.307150855848, 4497.64018878489, 4716.3632909557455, 5195.948040519546, 4534.057876914179, 5064.8596321394, 5068.518490743447, 5180.740962951837, 5192.8961420771375, 4273.18809426208, 5029.667138208304, 5033.892543640393, 5077.339945807169, 5139.897202055863, 4510.706804057726, 4707.505711900201, 4820.783064762024, 4985.177445721415, 5010.3737032870895, 4285.528591854956, 4310.4482386341515, 4546.0, 4941.527917234908, 5172.663776854492, 3434.3818112739946, 3537.6816086551303, 3538.84075216621, 3557.982210088933, 3572.5712914450432, 4228.112096459655, 4701.600363968964, 5067.417247016493, 5081.8475445736685, 5837.445442682938, 5312.707801070978, 5336.22516291534, 5584.692841893735, 5744.253247077853, 5888.352281249145, 5861.589688721749, 5879.676617785892, 5884.205632239764, 5898.1152827076285, 5922.970385148046, 4533.909321813611, 5059.974700126476, 5688.658680479184, 5733.900261313014, 5783.392743762012, 4928.9156385595115, 5298.70857102863, 5645.491905728504, 5901.085331773582, 5921.881562368642, 4622.907541849211, 5125.79496820123, 5782.2483077199695, 5784.5083167929515, 5836.533077353716], "value": 3963.985415366271, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.1611330856206, 733.5635296998286, 762.1159455032164, 765.6707615725239, 785.956772377519, 15016.723578495814, 15279.847201527995, 15575.987560808553, 15606.609834754137, 15720.056796592198, 13917.512887048955, 14108.576742697709, 14115.647108822259, 14135.78796318056, 14175.362108705107, 660.6663634864386, 682.3926705232348, 760.3157158557287, 774.3263360876045, 839.7732612194703, 818.3575892924056, 840.4663038970236, 850.5279569838737, 850.8000619854329, 852.6035393542002, 881.6649673124236, 893.2630579771682, 893.7318804358699, 895.8253140637578, 899.2895612466144, 876.8027193881389, 889.4574309671095, 890.9465432074031, 892.2460520859863, 894.7315805258429, 660.0693022837776, 661.4774328280653, 662.3343539742576, 664.4219529009744, 666.473485946102, 14509.129452232793, 14593.416263349452, 14596.708065838624, 14805.185714785683, 14832.184229867353, 14320.856791432056, 14464.783028254584, 14503.709925801424, 14576.0, 14755.26223688822, 11127.72180695481, 11609.0, 11995.94002029993, 12025.158238923279, 12452.377381130998, 3086.33643766589, 3593.119685677, 3817.5609804872515, 3859.459675645412, 3868.6905047596406, 98328.0, 116870.0, 118188.0, 122631.99999999911, 125469.0, 9814.65648702292, 10804.405757683246, 11239.494222759995, 11313.773724525463, 11597.100724818796, 20791.960401980145, 22899.31302060941, 22952.426189345068, 23014.8849255756, 23071.653925191134, 6544.0, 7478.551286922802, 7991.2807847294025, 8050.879236811453, 8202.876956845652, 4369.650427965755, 4453.532379100213, 4453.755043472575, 4507.88730281739, 4576.542345765463, 3480.9825950870086, 3617.656322649344, 3618.0231337539244, 3631.4008188648577, 3631.5279013728045, 665.896785998171, 668.0913957018452, 676.0737789228788, 678.1827897383641, 695.7738734911175, 581.6626356713097, 616.5745635511482, 621.176940553759, 624.3475568031419, 642.2485691740675, 8655.6970506032, 9048.864267035868, 9156.313276504288, 9242.399244049115, 9327.0, 604.0882944208871, 611.3122736920964, 615.1388056720538, 620.2216218645661, 634.8002275698933, 3775.1505911169766, 3810.504634397566, 3870.632289932452, 3926.509186351706, 4469.486009108994, 107993.0, 169161.0, 170904.0, 171448.1427592854, 176168.46686764937, 144474.2776286112, 146130.2693486547, 147205.0, 150232.0, 155008.0, 99015.0, 99770.50114749525, 129506.0, 130375.0, 132169.33915330362, 9390.15003848419, 9651.179649729851, 9718.93593640174, 9777.9367847791, 9979.669935422125, 58837.70581147067, 59744.40255597388, 60225.69887150536, 62202.0, 62604.0, 69321.65339173272, 90320.54839725759, 91743.0, 92519.0, 93946.0, 12869.613911582668, 12948.287844168284, 12951.5466958656, 13251.271180085188, 13363.39864706071, 14189.787153192918, 14487.85512144865, 14688.926555367154, 14817.110973341634, 15103.4713785017, 11661.9504244615, 13628.70979759096, 13648.454061837416, 13741.175529468264, 14013.929930350283, 13736.0, 13741.450341986209, 13810.309484525935, 14100.294985250901, 14122.364493598017, 12488.500459981498, 12627.431765570755, 12878.484860605471, 12967.22196668203, 13589.388477518338, 10705.059793937971, 11028.44857757125, 11183.273087249303, 11192.720181995515, 12077.335746534025, 10928.344299342065, 11587.652370428901, 11842.644720658394, 11924.403779811148, 11933.701657458632], "value": 7819.859503883321, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 159.0, 140.0, 116.0, 120.0, 122.0, 119.0, 117.0, 117.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 113.0, 175.0, 98.0, 141.0, 137.0, 138.0, 125.0, 141.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [270.0, 251.0, 192.0, 202.0, 253.0, 198.0, 197.0, 198.0, 203.0, 193.0], "value": 215.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 59.0, 84.0, 83.0, 92.0, 85.0, 66.0, 79.0, 59.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 91.0, 72.0, 70.0, 60.0, 119.0, 92.0, 100.0, 100.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 119.0, 97.0, 135.0, 80.0, 78.0, 95.0, 134.0, 107.0], "value": 110.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 105.0, 137.0, 173.0, 102.0, 136.0, 109.0, 132.0, 132.0, 100.0], "value": 122.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 93.0, 92.0, 93.0, 124.0, 145.0, 132.0, 92.0, 98.0], "value": 116.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 59.0, 61.0, 60.0, 86.0, 61.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 82.0, 80.0, 62.0, 67.0, 81.0, 68.0, 76.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 83.0, 85.0, 83.0, 98.0, 83.0, 88.0, 85.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 130.0, 149.0, 151.0, 144.0, 149.0, 161.0, 194.0, 144.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 167.0, 166.0, 174.0, 166.0, 165.0, 167.0, 166.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 90.0, 68.0, 67.0, 66.0, 66.0, 68.0, 66.0], "value": 69.4, "unit": "score"}]}]} 09:03:06 INFO - Return code: 0 09:03:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:06 ERROR - # TBPL SUCCESS # 09:03:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:06 INFO - 2016-10-16 09:03:06.769 screenresolution[1969:20978] starting screenresolution argv=screenresolution get 09:03:06 INFO - 2016-10-16 09:03:06.772 screenresolution[1969:20978] Display 0: 1600x1200x32@60 09:03:06 INFO - 2016-10-16 09:03:06.778 screenresolution[1970:20981] starting screenresolution argv=screenresolution list 09:03:06 INFO - Available Modes on Display 0 09:03:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:07 INFO - Intel Iris: 09:03:07 INFO - Chipset Model: Intel Iris 09:03:07 INFO - Type: GPU 09:03:07 INFO - Bus: Built-In 09:03:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:07 INFO - Vendor: Intel (0x8086) 09:03:07 INFO - Device ID: 0x0a2e 09:03:07 INFO - Revision ID: 0x0009 09:03:07 INFO - Displays: 09:03:07 INFO - Display: 09:03:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:07 INFO - Display Serial Number: 1600x1200 60 09:03:07 INFO - Main Display: Yes 09:03:07 INFO - Mirror: Off 09:03:07 INFO - Online: Yes 09:03:07 INFO - Rotation: Supported 09:03:07 INFO - Return code: 0 09:03:07 INFO - Running post-action listener: _resource_record_post_action 09:03:07 INFO - [mozharness: 2016-10-16 16:03:07.013587Z] Finished run-tests step (success) 09:03:07 INFO - Running post-run listener: _resource_record_post_run 09:03:07 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 548864; Write bytes: 666695168; Read time: 6; Write time: 1927 09:03:07 INFO - TinderboxPrint: CPU usage
54.6% 09:03:07 INFO - TinderboxPrint: I/O read bytes / time
548,864 / 6 09:03:07 INFO - TinderboxPrint: I/O write bytes / time
666,695,168 / 1,927 09:03:07 INFO - TinderboxPrint: CPU idle
2,195.1 (45.4%) 09:03:07 INFO - TinderboxPrint: CPU system
983.5 (20.3%) 09:03:07 INFO - TinderboxPrint: CPU user
1,655.2 (34.2%) 09:03:07 INFO - TinderboxPrint: Swap in / out
363,724,800 / 0 09:03:07 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 358363648; Write bytes: 355841536; Read time: 28619; Write time: 736 09:03:07 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 548864; Write bytes: 299728896; Read time: 6; Write time: 1151 09:03:07 INFO - Running post-run listener: _upload_blobber_files 09:03:07 INFO - Blob upload gear active. 09:03:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:07 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 09:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:09 INFO - (blobuploader) - INFO - Done attempting. 09:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:10 INFO - (blobuploader) - INFO - Done attempting. 09:03:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:12 INFO - (blobuploader) - INFO - Done attempting. 09:03:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:12 INFO - Return code: 0 09:03:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c1992e82343964d972b57ba3869639641dfb25d83fc1fbcd308d647ca6e984a062d019712ec1ccdd1f5c69b24dc837f5d9bde4215bb2929b0a88e4410cbfdef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c97da42d3c3a208853f2e32aa584ee82485638c472416082c50013e5b6998c8a1f1260845f125dc5371cd238e6a8796df6fc4b7ca69abc7bc4e4d6be40f74acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec813b0ca4373be3b49259caa40aab9bea470f191177b29a2253a8b55eab99737ba8679a16444bef3ff056dca7dfc068f1859a09e0ee533fd4b29f78626c98bf"} 09:03:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:12 INFO - Contents: 09:03:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c1992e82343964d972b57ba3869639641dfb25d83fc1fbcd308d647ca6e984a062d019712ec1ccdd1f5c69b24dc837f5d9bde4215bb2929b0a88e4410cbfdef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c97da42d3c3a208853f2e32aa584ee82485638c472416082c50013e5b6998c8a1f1260845f125dc5371cd238e6a8796df6fc4b7ca69abc7bc4e4d6be40f74acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec813b0ca4373be3b49259caa40aab9bea470f191177b29a2253a8b55eab99737ba8679a16444bef3ff056dca7dfc068f1859a09e0ee533fd4b29f78626c98bf"} 09:03:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:12 INFO - Copying logs to upload dir... 09:03:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.476966 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-16 09:03:12.198154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 09:03:12.202353) ========= 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.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-Aurora/sha512/0c1992e82343964d972b57ba3869639641dfb25d83fc1fbcd308d647ca6e984a062d019712ec1ccdd1f5c69b24dc837f5d9bde4215bb2929b0a88e4410cbfdef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c97da42d3c3a208853f2e32aa584ee82485638c472416082c50013e5b6998c8a1f1260845f125dc5371cd238e6a8796df6fc4b7ca69abc7bc4e4d6be40f74acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec813b0ca4373be3b49259caa40aab9bea470f191177b29a2253a8b55eab99737ba8679a16444bef3ff056dca7dfc068f1859a09e0ee533fd4b29f78626c98bf"} build_url:https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/a1-WM7l-SsCwgAZp7XoqLg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c1992e82343964d972b57ba3869639641dfb25d83fc1fbcd308d647ca6e984a062d019712ec1ccdd1f5c69b24dc837f5d9bde4215bb2929b0a88e4410cbfdef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c97da42d3c3a208853f2e32aa584ee82485638c472416082c50013e5b6998c8a1f1260845f125dc5371cd238e6a8796df6fc4b7ca69abc7bc4e4d6be40f74acf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec813b0ca4373be3b49259caa40aab9bea470f191177b29a2253a8b55eab99737ba8679a16444bef3ff056dca7dfc068f1859a09e0ee533fd4b29f78626c98bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 09:03:12.234919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 09:03:12.238233) ========= 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.pCXVKnSQga/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.ZYIBT84qZF/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.005247 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 09:03:12.286416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 09:03:12.286693) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 09:03:12.290014) ========= ========= Total master_lag: 0.22 =========