builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0162 starttime: 1474797643.73 results: success (0) buildid: 20160925004010 builduid: eedd3bf1102b479e82080aaa7d0b1a54 revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.729469) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.729887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.730320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.777774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.778407) ========= 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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-09-25 03:00:43-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-09-25 03:00:43 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179307 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.982897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.983200) ========= 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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.027978 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.032017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.032312) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --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 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-09-25 03:00:44,108 truncating revision to first 12 chars 2016-09-25 03:00:44,108 Setting DEBUG logging. 2016-09-25 03:00:44,108 attempt 1/10 2016-09-25 03:00:44,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1fee8de1111f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 03:00:44,740 unpacking tar archive at: mozilla-aurora-1fee8de1111f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.974798) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.975211) ========= script_repo_revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.975805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.976214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:44.997166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-25 03:00:44.997657) ========= /tools/buildbot/bin/python 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', '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:00:45 INFO - MultiFileLogger online at 20160925 03:00:45 in /builds/slave/test 03:00:45 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 03:00:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:45 INFO - {'append_to_log': False, 03:00:45 INFO - 'base_work_dir': '/builds/slave/test', 03:00:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:00:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:45 INFO - 'branch': 'Mozilla-Aurora', 03:00:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:45 INFO - 'config_files': ('talos/mac_config.py',), 03:00:45 INFO - 'default_actions': ('clobber', 03:00:45 INFO - 'read-buildbot-config', 03:00:45 INFO - 'download-and-extract', 03:00:45 INFO - 'populate-webroot', 03:00:45 INFO - 'create-virtualenv', 03:00:45 INFO - 'install', 03:00:45 INFO - 'run-tests'), 03:00:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:45 INFO - 'download_minidump_stackwalk': True, 03:00:45 INFO - 'download_symbols': 'ondemand', 03:00:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:45 INFO - 'installer_path': 'installer.exe', 03:00:45 INFO - 'log_level': 'info', 03:00:45 INFO - 'log_name': 'talos', 03:00:45 INFO - 'log_to_console': True, 03:00:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:45 INFO - 'opt_config_files': (), 03:00:45 INFO - 'pip_index': False, 03:00:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:45 INFO - 'cmd': ('bash', 03:00:45 INFO - '-c', 03:00:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:45 INFO - 'enabled': True, 03:00:45 INFO - 'halt_on_failure': False, 03:00:45 INFO - 'name': 'check_screen_resolution'},), 03:00:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:45 INFO - 'cmd': ('bash', 03:00:45 INFO - '-c', 03:00:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:45 INFO - 'enabled': True, 03:00:45 INFO - 'halt_on_failure': False, 03:00:45 INFO - 'name': 'check_screen_resolution'},), 03:00:45 INFO - 'run_cmd_checks_enabled': True, 03:00:45 INFO - 'sps_profile': False, 03:00:45 INFO - 'sps_profile_interval': 0, 03:00:45 INFO - 'suite': 'dromaeojs-e10s', 03:00:45 INFO - 'system_bits': '32', 03:00:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:45 INFO - 'title': 't-yosemite-r7-0162', 03:00:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:45 INFO - 'use_talos_json': True, 03:00:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:45 INFO - 'work_dir': 'build'} 03:00:45 INFO - [mozharness: 2016-09-25 10:00:45.197307Z] Running clobber step. 03:00:45 INFO - Running pre-action listener: _resource_record_pre_action 03:00:45 INFO - Running main action method: clobber 03:00:45 INFO - rmtree: /builds/slave/test/build 03:00:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:47 INFO - Running post-action listener: _resource_record_post_action 03:00:47 INFO - [mozharness: 2016-09-25 10:00:47.318834Z] Finished clobber step (success) 03:00:47 INFO - [mozharness: 2016-09-25 10:00:47.319019Z] Running read-buildbot-config step. 03:00:47 INFO - Running pre-action listener: _resource_record_pre_action 03:00:47 INFO - Running main action method: read_buildbot_config 03:00:47 INFO - Using buildbot properties: 03:00:47 INFO - { 03:00:47 INFO - "project": "", 03:00:47 INFO - "product": "firefox", 03:00:47 INFO - "script_repo_revision": "production", 03:00:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:00:47 INFO - "repository": "", 03:00:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:00:47 INFO - "buildid": "20160925004010", 03:00:47 INFO - "stage_platform": "macosx64", 03:00:47 INFO - "basedir": "/builds/slave/test", 03:00:47 INFO - "nightly_build": "True", 03:00:47 INFO - "buildnumber": 0, 03:00:47 INFO - "slavename": "t-yosemite-r7-0162", 03:00:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:00:47 INFO - "platform": "yosemite_r7", 03:00:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:00:47 INFO - "branch": "mozilla-aurora", 03:00:47 INFO - "repo_path": "releases/mozilla-aurora", 03:00:47 INFO - "revision": "1fee8de1111fdcc6fb5d95d4afef92c913fc87f2", 03:00:47 INFO - "pgo_build": "False", 03:00:47 INFO - "builduid": "eedd3bf1102b479e82080aaa7d0b1a54", 03:00:47 INFO - "slavebuilddir": "test" 03:00:47 INFO - } 03:00:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:00:47 INFO - Running post-action listener: _resource_record_post_action 03:00:47 INFO - [mozharness: 2016-09-25 10:00:47.324989Z] Finished read-buildbot-config step (success) 03:00:47 INFO - [mozharness: 2016-09-25 10:00:47.325223Z] Running download-and-extract step. 03:00:47 INFO - Running pre-action listener: _resource_record_pre_action 03:00:47 INFO - Running main action method: download_and_extract 03:00:47 INFO - mkdir: /builds/slave/test/build/tests 03:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:47 INFO - trying https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:00:47 INFO - Downloading https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/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 03:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/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 03:00:48 INFO - Downloaded 1199 bytes. 03:00:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:00:48 INFO - Using the following test package requirements: 03:00:48 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:00:48 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:00:48 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:00:48 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'jsshell-mac.zip'], 03:00:48 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:00:48 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:00:48 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:00:48 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:00:48 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:00:48 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:00:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:00:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:00:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:00:48 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:00:49 INFO - Expected file size: 16430922 03:00:56 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 03:00:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:00:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:00:56 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:00:56 INFO - Expected file size: 16430922 03:01:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:01:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:01:03 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:01:03 INFO - Expected file size: 14414059 03:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:04 INFO - trying https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:04 INFO - Downloading https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/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 03:01:08 INFO - Downloaded 115380170 bytes. 03:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:08 INFO - mkdir: /builds/slave/test/properties 03:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:08 INFO - Contents: 03:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:09 INFO - Running post-action listener: _resource_record_post_action 03:01:09 INFO - Running post-action listener: set_extra_try_arguments 03:01:09 INFO - [mozharness: 2016-09-25 10:01:09.155663Z] Finished download-and-extract step (success) 03:01:09 INFO - [mozharness: 2016-09-25 10:01:09.155797Z] Running populate-webroot step. 03:01:09 INFO - Running pre-action listener: _resource_record_pre_action 03:01:09 INFO - Running main action method: populate_webroot 03:01:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:09 INFO - '--tppagecycles', 03:01:09 INFO - '7'], 03:01:09 INFO - 'tests': ['tsvgm']}}, 03:01:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:01:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:01:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:01:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['damp', 'tps']}, 03:01:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'tests': ['damp', 'tps']}, 03:01:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['dromaeo_dom']}, 03:01:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['basic_compositor_video']}, 03:01:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:01:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'other-e10s': {'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['a11yr', 03:01:09 INFO - 'ts_paint', 03:01:09 INFO - 'tpaint', 03:01:09 INFO - 'sessionrestore', 03:01:09 INFO - 'sessionrestore_no_auto_restore', 03:01:09 INFO - 'tabpaint']}, 03:01:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['tsvgx', 03:01:09 INFO - 'tsvgr_opacity', 03:01:09 INFO - 'tart', 03:01:09 INFO - 'tscrollx', 03:01:09 INFO - 'cart']}, 03:01:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:01:09 INFO - 'tsvgr_opacity', 03:01:09 INFO - 'tart', 03:01:09 INFO - 'tscrollx', 03:01:09 INFO - 'cart']}, 03:01:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'talos_options': ['--disable-e10s'], 03:01:09 INFO - 'tests': ['tp5o']}, 03:01:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'tests': ['tp5o']}, 03:01:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'talos_options': ['--disable-e10s', 03:01:09 INFO - '--xperf_path', 03:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:09 INFO - 'tests': ['tp5n']}, 03:01:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:09 INFO - 'talos_options': ['--xperf_path', 03:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:09 INFO - 'tests': ['tp5n']}}, 03:01:09 INFO - 'talos.zip': {'path': '', 03:01:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:09 INFO - Running post-action listener: _resource_record_post_action 03:01:09 INFO - [mozharness: 2016-09-25 10:01:09.174230Z] Finished populate-webroot step (success) 03:01:09 INFO - [mozharness: 2016-09-25 10:01:09.174335Z] Running create-virtualenv step. 03:01:09 INFO - Running pre-action listener: _resource_record_pre_action 03:01:09 INFO - Running main action method: create_virtualenv 03:01:09 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:01:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:09 INFO - Using real prefix '/tools/python27' 03:01:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:12 INFO - Installing pip.................done. 03:01:12 INFO - Return code: 0 03:01:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:12 INFO - 'HOME': '/Users/cltbld', 03:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:12 INFO - 'LOGNAME': 'cltbld', 03:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:12 INFO - 'MOZ_NO_REMOTE': '1', 03:01:12 INFO - 'NO_EM_RESTART': '1', 03:01:12 INFO - 'PAGER': '/bin/cat', 03:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:12 INFO - 'PWD': '/builds/slave/test', 03:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:12 INFO - 'SHELL': '/bin/bash', 03:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:12 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:12 INFO - 'USER': 'cltbld', 03:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:12 INFO - 'XPC_FLAGS': '0x0', 03:01:12 INFO - 'XPC_SERVICE_NAME': '0', 03:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:01:13 INFO - Cleaning up... 03:01:13 INFO - Return code: 0 03:01:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:13 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:13 INFO - 'HOME': '/Users/cltbld', 03:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:13 INFO - 'LOGNAME': 'cltbld', 03:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:13 INFO - 'MOZ_NO_REMOTE': '1', 03:01:13 INFO - 'NO_EM_RESTART': '1', 03:01:13 INFO - 'PAGER': '/bin/cat', 03:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:13 INFO - 'PWD': '/builds/slave/test', 03:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:13 INFO - 'SHELL': '/bin/bash', 03:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:13 INFO - 'USER': 'cltbld', 03:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:13 INFO - 'XPC_FLAGS': '0x0', 03:01:13 INFO - 'XPC_SERVICE_NAME': '0', 03:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:13 INFO - Downloading/unpacking psutil>=3.1.1 03:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:16 INFO - Installing collected packages: psutil 03:01:16 INFO - Running setup.py install for psutil 03:01:17 INFO - building 'psutil._psutil_osx' extension 03:01:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:01:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:01:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:01:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:01:17 INFO - building 'psutil._psutil_posix' extension 03:01:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:01:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:01:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:01:17 INFO - ^ 03:01:17 INFO - 1 warning generated. 03:01:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:18 INFO - Successfully installed psutil 03:01:18 INFO - Cleaning up... 03:01:18 INFO - Return code: 0 03:01:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:18 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:01:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:18 INFO - 'HOME': '/Users/cltbld', 03:01:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:18 INFO - 'LOGNAME': 'cltbld', 03:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:18 INFO - 'MOZ_NO_REMOTE': '1', 03:01:18 INFO - 'NO_EM_RESTART': '1', 03:01:18 INFO - 'PAGER': '/bin/cat', 03:01:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:18 INFO - 'PWD': '/builds/slave/test', 03:01:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:18 INFO - 'SHELL': '/bin/bash', 03:01:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:18 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:18 INFO - 'USER': 'cltbld', 03:01:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:18 INFO - 'XPC_FLAGS': '0x0', 03:01:18 INFO - 'XPC_SERVICE_NAME': '0', 03:01:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:21 INFO - Installing collected packages: mozsystemmonitor 03:01:21 INFO - Running setup.py install for mozsystemmonitor 03:01:21 INFO - Successfully installed mozsystemmonitor 03:01:21 INFO - Cleaning up... 03:01:21 INFO - Return code: 0 03:01:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:21 INFO - 'HOME': '/Users/cltbld', 03:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:21 INFO - 'LOGNAME': 'cltbld', 03:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:21 INFO - 'MOZ_NO_REMOTE': '1', 03:01:21 INFO - 'NO_EM_RESTART': '1', 03:01:21 INFO - 'PAGER': '/bin/cat', 03:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:21 INFO - 'PWD': '/builds/slave/test', 03:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:21 INFO - 'SHELL': '/bin/bash', 03:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:21 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:21 INFO - 'USER': 'cltbld', 03:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:21 INFO - 'XPC_FLAGS': '0x0', 03:01:21 INFO - 'XPC_SERVICE_NAME': '0', 03:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:24 INFO - warning: no files found matching '*.txt' 03:01:24 INFO - no previously-included directories found matching 'build' 03:01:24 INFO - no previously-included directories found matching 'dist' 03:01:24 INFO - no previously-included directories found matching '.git*' 03:01:24 INFO - Installing collected packages: jsonschema, functools32 03:01:24 INFO - Running setup.py install for functools32 03:01:24 INFO - warning: no files found matching '*.txt' 03:01:24 INFO - no previously-included directories found matching 'build' 03:01:24 INFO - no previously-included directories found matching 'dist' 03:01:24 INFO - no previously-included directories found matching '.git*' 03:01:24 INFO - Successfully installed jsonschema functools32 03:01:24 INFO - Cleaning up... 03:01:24 INFO - Return code: 0 03:01:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:24 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:24 INFO - 'HOME': '/Users/cltbld', 03:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:24 INFO - 'LOGNAME': 'cltbld', 03:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:24 INFO - 'MOZ_NO_REMOTE': '1', 03:01:24 INFO - 'NO_EM_RESTART': '1', 03:01:24 INFO - 'PAGER': '/bin/cat', 03:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:24 INFO - 'PWD': '/builds/slave/test', 03:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:24 INFO - 'SHELL': '/bin/bash', 03:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:24 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:24 INFO - 'USER': 'cltbld', 03:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:24 INFO - 'XPC_FLAGS': '0x0', 03:01:24 INFO - 'XPC_SERVICE_NAME': '0', 03:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:01:24 INFO - Cleaning up... 03:01:24 INFO - Return code: 0 03:01:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:24 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:24 INFO - 'HOME': '/Users/cltbld', 03:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:24 INFO - 'LOGNAME': 'cltbld', 03:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:24 INFO - 'MOZ_NO_REMOTE': '1', 03:01:24 INFO - 'NO_EM_RESTART': '1', 03:01:24 INFO - 'PAGER': '/bin/cat', 03:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:24 INFO - 'PWD': '/builds/slave/test', 03:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:24 INFO - 'SHELL': '/bin/bash', 03:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:24 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:24 INFO - 'USER': 'cltbld', 03:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:24 INFO - 'XPC_FLAGS': '0x0', 03:01:24 INFO - 'XPC_SERVICE_NAME': '0', 03:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:28 INFO - Downloading docopt-0.6.1.tar.gz 03:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:28 INFO - Running setup.py install for blobuploader 03:01:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:29 INFO - Running setup.py install for requests 03:01:29 INFO - Running setup.py install for docopt 03:01:29 INFO - Successfully installed blobuploader requests docopt 03:01:29 INFO - Cleaning up... 03:01:29 INFO - Return code: 0 03:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:29 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:29 INFO - 'HOME': '/Users/cltbld', 03:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:29 INFO - 'LOGNAME': 'cltbld', 03:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:29 INFO - 'MOZ_NO_REMOTE': '1', 03:01:29 INFO - 'NO_EM_RESTART': '1', 03:01:29 INFO - 'PAGER': '/bin/cat', 03:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:29 INFO - 'PWD': '/builds/slave/test', 03:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:29 INFO - 'SHELL': '/bin/bash', 03:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:29 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:29 INFO - 'USER': 'cltbld', 03:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:29 INFO - 'XPC_FLAGS': '0x0', 03:01:29 INFO - 'XPC_SERVICE_NAME': '0', 03:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:29 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9L8PLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GQO0q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-HFMoBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-6srYJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-RGtR3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-T3wbgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-86ecr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-QldTZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0S7VUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:30 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-dPVYKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-EbJfqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MIcbPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ojXMYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-tZfGQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-63NMJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-IvQrZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:31 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LJsH4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:31 INFO - Running setup.py install for manifestparser 03:01:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Running setup.py install for mozcrash 03:01:32 INFO - Running setup.py install for mozdebug 03:01:32 INFO - Running setup.py install for mozdevice 03:01:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozfile 03:01:32 INFO - Running setup.py install for mozhttpd 03:01:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozinfo 03:01:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozInstall 03:01:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozleak 03:01:33 INFO - Running setup.py install for mozlog 03:01:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Running setup.py install for moznetwork 03:01:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Running setup.py install for mozprocess 03:01:33 INFO - Running setup.py install for mozprofile 03:01:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Running setup.py install for mozrunner 03:01:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Running setup.py install for mozscreenshot 03:01:33 INFO - Running setup.py install for moztest 03:01:34 INFO - Running setup.py install for mozversion 03:01:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:34 INFO - Cleaning up... 03:01:34 INFO - Return code: 0 03:01:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:34 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:34 INFO - 'HOME': '/Users/cltbld', 03:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:34 INFO - 'LOGNAME': 'cltbld', 03:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:34 INFO - 'MOZ_NO_REMOTE': '1', 03:01:34 INFO - 'NO_EM_RESTART': '1', 03:01:34 INFO - 'PAGER': '/bin/cat', 03:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:34 INFO - 'PWD': '/builds/slave/test', 03:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:34 INFO - 'SHELL': '/bin/bash', 03:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:34 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:34 INFO - 'USER': 'cltbld', 03:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:34 INFO - 'XPC_FLAGS': '0x0', 03:01:34 INFO - 'XPC_SERVICE_NAME': '0', 03:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:34 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-70Vkqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:34 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-P3Donr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:34 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-OkhEEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:34 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_3m2Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lwHJWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-U9zsN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7vx2EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-OxdvcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-S9i2iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-PIt0y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-a_mbki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ns3B1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:35 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)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-kgsOpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:35 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0WO1zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:36 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)) 03:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:36 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-X06SP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:36 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GkEpTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:36 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)) 03:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:36 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-dbNL80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:01:36 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)) 03:01:36 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)) 03:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:01:36 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)) 03:01:36 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)) 03:01:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:38 INFO - Downloading blessings-1.6.tar.gz 03:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:38 INFO - Installing collected packages: blessings 03:01:38 INFO - Running setup.py install for blessings 03:01:39 INFO - Successfully installed blessings 03:01:39 INFO - Cleaning up... 03:01:39 INFO - Return code: 0 03:01:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:39 INFO - Reading from file tmpfile_stdout 03:01:39 INFO - Current package versions: 03:01:39 INFO - blessings == 1.6 03:01:39 INFO - blobuploader == 1.2.4 03:01:39 INFO - docopt == 0.6.1 03:01:39 INFO - functools32 == 3.2.3-2 03:01:39 INFO - jsonschema == 2.5.1 03:01:39 INFO - manifestparser == 1.1 03:01:39 INFO - mozInstall == 1.12 03:01:39 INFO - mozcrash == 0.17 03:01:39 INFO - mozdebug == 0.1 03:01:39 INFO - mozdevice == 0.48 03:01:39 INFO - mozfile == 1.2 03:01:39 INFO - mozhttpd == 0.7 03:01:39 INFO - mozinfo == 0.9 03:01:39 INFO - mozleak == 0.1 03:01:39 INFO - mozlog == 3.4 03:01:39 INFO - moznetwork == 0.27 03:01:39 INFO - mozprocess == 0.23 03:01:39 INFO - mozprofile == 0.28 03:01:39 INFO - mozrunner == 6.12 03:01:39 INFO - mozscreenshot == 0.1 03:01:39 INFO - mozsystemmonitor == 0.3 03:01:39 INFO - moztest == 0.7 03:01:39 INFO - mozversion == 1.4 03:01:39 INFO - psutil == 3.1.1 03:01:39 INFO - requests == 1.2.3 03:01:39 INFO - wsgiref == 0.1.2 03:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:39 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 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:39 INFO - 'HOME': '/Users/cltbld', 03:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:39 INFO - 'LOGNAME': 'cltbld', 03:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:39 INFO - 'MOZ_NO_REMOTE': '1', 03:01:39 INFO - 'NO_EM_RESTART': '1', 03:01:39 INFO - 'PAGER': '/bin/cat', 03:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:39 INFO - 'PWD': '/builds/slave/test', 03:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:39 INFO - 'SHELL': '/bin/bash', 03:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:39 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:39 INFO - 'USER': 'cltbld', 03:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:39 INFO - 'XPC_FLAGS': '0x0', 03:01:39 INFO - 'XPC_SERVICE_NAME': '0', 03:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:01:39 INFO - Cleaning up... 03:01:39 INFO - Return code: 0 03:01:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100773490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006e9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7785a45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, '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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:39 INFO - 'HOME': '/Users/cltbld', 03:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:39 INFO - 'LOGNAME': 'cltbld', 03:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:39 INFO - 'MOZ_NO_REMOTE': '1', 03:01:39 INFO - 'NO_EM_RESTART': '1', 03:01:39 INFO - 'PAGER': '/bin/cat', 03:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:39 INFO - 'PWD': '/builds/slave/test', 03:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:39 INFO - 'SHELL': '/bin/bash', 03:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:01:39 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:39 INFO - 'USER': 'cltbld', 03:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:39 INFO - 'XPC_FLAGS': '0x0', 03:01:39 INFO - 'XPC_SERVICE_NAME': '0', 03:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:40 INFO - Cleaning up... 03:01:40 INFO - Return code: 0 03:01:40 INFO - Running post-action listener: _resource_record_post_action 03:01:40 INFO - Running post-action listener: _start_resource_monitoring 03:01:40 INFO - Starting resource monitoring. 03:01:40 INFO - [mozharness: 2016-09-25 10:01:40.078959Z] Finished create-virtualenv step (success) 03:01:40 INFO - [mozharness: 2016-09-25 10:01:40.079892Z] Running install step. 03:01:40 INFO - Running pre-action listener: _resource_record_pre_action 03:01:40 INFO - Running main action method: install 03:01:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:40 INFO - Reading from file tmpfile_stdout 03:01:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:40 INFO - Reading from file tmpfile_stdout 03:01:40 INFO - Output received: 03:01:40 INFO - Usage: mozinstall [options] installer 03:01:40 INFO - Options: 03:01:40 INFO - -h, --help show this help message and exit 03:01:40 INFO - -d DEST, --destination=DEST 03:01:40 INFO - Directory to install application into. [default: 03:01:40 INFO - "/builds/slave/test"] 03:01:40 INFO - --app=APP Application being installed. [default: firefox] 03:01:40 INFO - mkdir: /builds/slave/test/build/application 03:01:40 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'] 03:01:40 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 03:02:13 INFO - Reading from file tmpfile_stdout 03:02:13 INFO - Output received: 03:02:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:02:13 INFO - Running post-action listener: _resource_record_post_action 03:02:13 INFO - [mozharness: 2016-09-25 10:02:13.003204Z] Finished install step (success) 03:02:13 INFO - [mozharness: 2016-09-25 10:02:13.003387Z] Running run-tests step. 03:02:13 INFO - Running pre-action listener: _resource_record_pre_action 03:02:13 INFO - Running main action method: run_tests 03:02:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:02:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:02:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:02:13 INFO - 2016-09-25 03:02:13.018 screenresolution[1648:11414] starting screenresolution argv=screenresolution get 03:02:13 INFO - 2016-09-25 03:02:13.021 screenresolution[1648:11414] Display 0: 1600x1200x32@60 03:02:13 INFO - 2016-09-25 03:02:13.027 screenresolution[1649:11418] starting screenresolution argv=screenresolution list 03:02:13 INFO - Available Modes on Display 0 03:02:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:02:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:02:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:02:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:02:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:02:13 INFO - Intel Iris: 03:02:13 INFO - Chipset Model: Intel Iris 03:02:13 INFO - Type: GPU 03:02:13 INFO - Bus: Built-In 03:02:13 INFO - VRAM (Dynamic, Max): 1536 MB 03:02:13 INFO - Vendor: Intel (0x8086) 03:02:13 INFO - Device ID: 0x0a2e 03:02:13 INFO - Revision ID: 0x0009 03:02:13 INFO - Displays: 03:02:13 INFO - Display: 03:02:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:02:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:02:13 INFO - Display Serial Number: 1600x1200 60 03:02:13 INFO - Main Display: Yes 03:02:13 INFO - Mirror: Off 03:02:13 INFO - Online: Yes 03:02:13 INFO - Rotation: Supported 03:02:13 INFO - Return code: 0 03:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:13 INFO - Python 2.7.3 03:02:13 INFO - Return code: 0 03:02:13 INFO - grabbing minidump binary from tooltool 03:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:13 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 0x100587d30>, '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 0x1003eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10057fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:02:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:02:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:02:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:13 INFO - Return code: 0 03:02:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:02:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:02:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:13 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 03:02:13 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 03:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lHmO4SjB4f/Render', 03:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:13 INFO - 'HOME': '/Users/cltbld', 03:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:13 INFO - 'LOGNAME': 'cltbld', 03:02:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:13 INFO - 'MOZ_NO_REMOTE': '1', 03:02:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:13 INFO - 'NO_EM_RESTART': '1', 03:02:13 INFO - 'PAGER': '/bin/cat', 03:02:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:13 INFO - 'PWD': '/builds/slave/test', 03:02:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:13 INFO - 'SHELL': '/bin/bash', 03:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fysUw9eeoZ/Listeners', 03:02:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 03:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:13 INFO - 'USER': 'cltbld', 03:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:13 INFO - 'XPC_FLAGS': '0x0', 03:02:13 INFO - 'XPC_SERVICE_NAME': '0', 03:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:13 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 03:02:13 INFO - mozversion application_buildid: 20160925004010 03:02:13 INFO - mozversion application_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 03:02:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:02:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:13 INFO - mozversion application_name: Firefox 03:02:13 INFO - mozversion application_remotingname: firefox-dev 03:02:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:13 INFO - mozversion application_vendor: Mozilla 03:02:13 INFO - mozversion application_version: 51.0a2 03:02:13 INFO - mozversion platform_buildid: 20160925004010 03:02:13 INFO - mozversion platform_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 03:02:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:13 INFO - mozversion platform_version: 51.0a2 03:02:13 INFO - using testdate: 1474797733 03:02:13 INFO - actual date: 1474797733 03:02:13 INFO - starting webserver on 'localhost:49275' 03:02:13 INFO - SUITE-START | Running 2 tests 03:02:13 INFO - TEST-START | dromaeo_css 03:02:13 INFO - operating with platform_type : mac_ 03:02:13 INFO - Initialising browser for dromaeo_css test... 03:02:13 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp8vmRV0/profile http://localhost:49275/getInfo.html) 03:02:16 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:02:16 INFO - PROCESS | 1659 | colorDepth:24 03:02:16 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:02:16 INFO - PROCESS | 1659 | __metrics 03:02:16 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:02:17 INFO - TEST-INFO | 1659: exit 0 03:02:17 INFO - Browser initialized. 03:02:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:17 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp8vmRV0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:29 INFO - PROCESS | 1664 | RSS: Main: 225009664 03:02:29 INFO - PROCESS | 1664 | 03:03:19 INFO - PROCESS | 1664 | 1474797799152 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] 03:05:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:05:33 INFO - PROCESS | 1664 | RSS: Main: 238817280 03:05:33 INFO - PROCESS | 1664 | 03:08:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:08:36 INFO - PROCESS | 1664 | RSS: Main: 247918592 03:08:36 INFO - PROCESS | 1664 | 03:11:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:11:38 INFO - PROCESS | 1664 | RSS: Main: 250863616 03:11:38 INFO - PROCESS | 1664 | 03:14:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:14:41 INFO - PROCESS | 1664 | RSS: Main: 250966016 03:14:41 INFO - PROCESS | 1664 | 03:17:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:17:44 INFO - PROCESS | 1664 | RSS: Main: 255455232 03:17:44 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:20:47 INFO - PROCESS | 1664 | RSS: Main: 257200128 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | __start_tp_report 03:20:47 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 03:20:47 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 03:20:47 INFO - PROCESS | 1664 | |i|pagename|runs| 03:20:47 INFO - PROCESS | 1664 | |0;dojo.html;3455.2053027803604;3456.0668619472744;3475.9826200869;3496.1958749487603;3508.9999350185203;5737.225474560933;5812.070068788984;5820.981328267558;5839.883202335956;5840.795572154975;5839.503642190408;5848.093545500444;5895.380984996567;5905.527557795377;5915.08316210988;5228.398734145574;5347.59893008024;5361.812336568221;5363.168708850135;5383.057964856134;5376.91934620979;5392.649477783951;5395.7032363220005;5411.161270003156;5422.186671999212;5246.68519888806;5249.396319423277;5370.006548788467;5389.973050134744;5424.403315635297;5113.284140220372;5259.631825772198;5271.604629652791;5277.894442111136;5333.813316533941;5230.34620672416;5272.657277276965;5279.5512381447625;5351.973240133774;5391.48780865821;5623.746931388097;5884.470397664188;5943.31651860033;5955.434233747787;6069.484093852028;6120.843333897677;6139.921477737053;6188.133661287423;6204.627722336674;6243.406876346739;6230.2523697156175;6268.1851359323455;6273.811785646438;6275.780347687854;6306.0225665022;4484.461864576239;4967.7019378837385;5405.4324295949145;5817.883642327172;5971.820845374646;5265.183896496049;5510.228568000483;6312.24253089623;6325.14610527582;6343.777967771106;6197.380261973766;6223.502119830403;6242.563020588515;6258.624482531062;6270.529710271748;5270.245424685598;6158.261008678987;6269.435750782361;6270.467010304175;6302.023186406114;6194.225721784777;6194.4115309045565;6213.068039793977;6222.81331560054;6235.220597425322;6208.782692605737;6239.563230573816;6263.185785847811;6287.339829317947;6296.685165741695;4885.780139893714;4940.407151141814;4942.20924652054;4952.47998960104;4955.331030310934;4413.8234470621455;4424.269995450779;4425.800838962255;4438.533953934855;4458.519560710555;5924.259467566554;5985.820425387158;6006.489448396936;6008.54935879802;6008.729607167688;6198.287196972406;6232.376762323732;6254;6265;6267.874642507124;4889.3888263967;5884.117382392676;5973.820785376446;6016.879662406727;6059.757609695651;4582.518835522222;5493.395726470085;5499.862503437446;5510.862228444241;5517.613767036269;6442.613443193423;6462.063000864849;6467.288598254094;6467.385598368148;6496.837579060372;6114.816555503342;6137.263528376623;6171.506279497539;6198.349173336735;6212.782552610637;6483.967580162258;6492.253390860112;6499.2200935887995;6506;6513.54405191632;6239.188905442264;6242.750289988349;6248.906266406098;6252.280987686292;6266.279377871603;6136.120845438751;6186;6192.349803270772;6255.124282600348;6282.1519094921605;6038.094285857156;6182.103594978793;6239.563230573816;6242;6245;6166.630002199882;6181.938180618136;6201.379862013762;6218.06728990655;6229.065640154013;5665.518430933252;5685.459881311269;5905.970470147622;5998.970005149947;6074.149619053248;4732.621390288699;5846.5615078870105;5861.648301101947;5869.295684517885;5885.558583106199;5634.549236061187;5672.858178545404;5693.174489699053;5705.828825135252;5738.368779434342 03:20:47 INFO - PROCESS | 1664 | |1;ext.html;478.96407769417294;488.1140729575821;527.4277409011223;551.4816072891484;556.9470900264473;37415.812920935394;39506.40740388897;39525.40711889324;39557.80221098898;39601.80199099004;40846.38730419046;41340;41460.75617731465;41507.96230094249;41533.37699934503;9550.379225350365;9684.467354295512;9699.563519641633;9799.706008819747;9821.803563928717;8862.291016718647;9678.467684277362;9688.079632434907;9705;9727.805443891119;9767.609295628166;9775.462349570806;9812.46031468269;9815.165710914582;9835.852462213037;9719.999999999965;9779.315447918649;9786.314957952945;9794.118529332394;9795.804083918352;9706.757331066709;9777.608895644165;9778.119969202806;9792.21662267017;9814.46020468874;39382.80308598468;39444.80277598594;39680.404793928115;39735.60264397377;39737;3205.1666566692593;3431.5367425397503;3614.4759009943673;3699.8705045323554;3798.1833905710128;29593;29624.111276661733;29679.406411871856;30397.392052159055;30581;2663.6270922070926;3277.8033318000757;3344.180675734436;3385.0691059958463;3385.9830700846583;416541.9172904146;443537;462636.06045909337;482713;512999;31637.52543711846;33133.17167070843;48399.82200800972;54102;56473.71763141158;34410.655893441246;34493;34527;34792.13019674528;34833.12917177091;12865.871341286655;14527.418903243752;15001.099934003994;15110.773338399933;15157.848421515644;12872.970162386986;12934.288614126126;12955.287459189834;12981.350932453339;13045.021623378285;7510.924890751132;7573.318401343906;7608.429367797437;7692.846143077107;7727.613619319011;2836.432713457317;3181.3001139749217;3230.82230477326;3237.2716138869037;3250.3174333390252;941.4445477168504;942.2509105261333;961.4904100826573;1077.7036315013434;1086.6685660873352;29709.554356684668;30074.248143796143;30093.849530752643;30129.246768830955;30598.69401306003;983.9176905404141;988.7429268390126;1086.875009373932;1112.4437781109445;1174.7826652069396;15196.933425956762;15445.382184712711;15650.530484085495;15825.604359891095;15876;672171;676405;679584;679705;682415;56556;56608.150877736865;57104.714476427354;57123.42876571181;57343.42656573381;1376.8072469854228;1396.553103007028;1396.5740449163102;1397.3432486731017;1398.4126666799968;25133.87433062823;26187.821548030002;29708.702912970595;30171.849140755035;30182.69817301799;47442;48523.02953940972;48727.0254594899;48899.755501222266;48944;574506;575412;576071;577155;578558;25948.09181678632;26123.869380652974;26235;26550.86724566365;26593.734062659125;38196.42705359366;46264.768676156404;47176.29235561401;47473.52526474691;47797.283040755116;32128.67871321257;38751.224975500896;39641.60358396379;40531;40783.1843363137;39347.606523934395;39414;39952.00119997023;40224;40276.59723402846;32629.021129366156;32681.509777352883;35806;38035.858924232314;38581.614183857804;27545.862270688518;28634.284142896595;29595.964141255816;30862;34682.82658586691;23478.64782028305;26089.478210435307;26196.345091372867;26321.919171809524;26514.337141570843 03:20:47 INFO - PROCESS | 1664 | |2;jquery.html;379.3323750199648;381.4469019921114;388.4115564919148;391.45978549601546;408.93048181809087;17745.29018839245;19115.904420477895;21355.25256616015;21478.570428591418;21766.238181663626;20005.099770510325;20016.399508014747;20848.37454876356;20926.790732092675;21166.365009049714;5988.802239552086;5991.550633702468;6115.724792384353;6164.938350616504;6242.656653884034;4261.722988005769;4491.505934347219;6096.664683442409;6186.597871138384;6199.876002479948;6645.534812563123;6927;6988.685509152075;7072.717091316341;7074.257202993663;6610.834729131786;6964.9999999999745;6979.092717946685;7039.929600703978;7059.964700176518;5971.193888824996;6129.988551888933;6183.505319574469;6201.069839524062;6215.627062376227;13260.933695331558;13432.664183395396;13475;13482.05625606208;20041.39875803728;2175.8585691929975;2198.9120435182735;2221.5334779696122;2230.60964331243;2318.698569185995;10018.849717254247;10031.648892288807;10167.288289819715;10566.31318964265;10608.310459820086;1880.5956719305277;1954.140178321534;1964.9705254421194;1979.0500559731265;1988.6818109102473;98890;119510;127277.36361318319;128463.35768321191;129104;11589;11722.827717228209;12021.939890300493;12031.63905082849;12114.909658130811;14811.629709257355;14942.40230390794;14945.850541494663;14946.252687365806;14984.775228371584;7878.660627693306;8267.545285009262;8491.448055876348;8699.173578510032;8879.24526415262;7280.344768970712;7364.96317518409;8781.824363512822;8819.779505512413;8907.821843563092;4529.252673308933;4624.907501849944;4628.051249493846;4652.97673511637;4702.764861756898;1591.6180116772123;1670.2400407814657;1772.3708083630127;1953.3749200256066;1974.3978086683699;767.7926959720955;981.1652210366517;993.3493561717087;1007.3754272351042;1008.85371621116;20714.689279660815;21391;21620;21622.78377216239;21823.490298615863;941.5433514745343;944.8299306124826;965.830979578585;986.1617625018677;1011.1304278320638;11053.336799792038;11299.604513842141;11491.310521368745;11527.250728702775;11549.018333441583;510563;597531;606262;611444;630490;117387.41306293584;117718;130772.34451912822;130803;134714;983.7098056073476;991.5736233419699;1004.8643433136433;1004.9397036177853;1006.1648831469862;17681.204345804214;18486.537836554195;18835.529111771768;19033.428997130108;19150.61698765989;54237.72881135727;54739;55589.444105558425;56287.74849005994;56404.717976409855;76942.6152869232;78731.2126878724;81196;81220;81603.95990100295;6357.8728425432155;7188.209296977224;7475.626218689153;7564.810879728051;7595.164531901376;10283.537240824331;10616.256862019893;10983;11911.821322679993;12973.09188356806;9896.851547226941;10920.836187457036;11069.391183484986;11105.111591072857;11151.442427878736;10560.841587376042;10622.256442048982;10780.29928054674;11286.379249141377;11431.485583148944;11307.265027773168;11513.366764828015;11650.184487085822;11970.042396608425;12008.459619317326;7382.224866389167;7581.12817026027;7608.8478230433975;7623.705552089831;7668.539887606761;11203.887961120285;11365.374904380338;11412.972832445119;11592.768144636892;11709.88290117122 03:20:47 INFO - PROCESS | 1664 | |3;mootools.html;1470.470630572994;1506.3597970862384;1705.1048199695158;1837.3201915291345;1849.556106534432;8170.060443049051;8402.705905293316;8638.870416943742;9212.907870921288;9234.90765092349;8648.567571621425;8912.777180570489;8940.955295223515;8951.776205594864;9017.504037277948;2403.891824867885;2422.539717453687;2424.284835973392;2427.647991041298;2431.3313838694326;2393.293978276404;2400.099962514057;2418.661387405765;2428.781409673129;2437.305367970129;2093.748750149984;2419.177479656916;2422.878856057199;2425.442148305891;2427.4052857050046;2389.4623709665275;2395.2335252719135;2397.5924092904247;2408.783209511135;2416.867072311022;2360.1031607989025;2380.5595964746576;2392.97607023931;2394.317619478458;2394.724606670238;8928.776780580472;9063;9092.363534552584;9099.1810737034;9139.811824462777;4558.883073646978;5239.580833533309;5281.735913204325;5470.753816078286;5481.862953426156;3462.7576069675133;3642.562892452896;3647.908802279938;3682;3682.116292089906;925.8657494663236;1085.8099832529356;1090.3131027452732;1104.5526561742506;1113.204059097749;10975.341479511175;11331.03686186675;11780.11649126319;11940.582079627258;11983.64049078529;4824.228123500293;4841.15279826029;4867.513248675175;4950.331705219749;4981.850544483671;10265.589376425009;10269.897301026895;10273.486325683685;10288;10338.37969721804;5483.122700367922;5508.55931525477;5510.421405752339;5519.116941289374;5525.668459892419;4204.495460544754;4364.934525982113;4451.6883818133065;4581.427321584802;4960.702357858468;3409.829508524564;3766.152615661509;4068.3287257602165;4136.937945930814;4190.20386126635;1248.4694005047818;1315.329182117108;1333.6665833541615;1334.8932085433141;1345.374400903565;711.4592909388798;869.4956924983494;882.3558802074522;954.4464210757744;964.5563041001218;6021.217241758631;6037.641530655567;6056.152138700585;6230.06549017651;6421.678916054178;952.6094301336419;956.6316967967243;975.7219192530094;1008.3445760255746;1037.6575730009079;3937.625925537069;4013.3979903014783;4017.799110044486;4057.6753859691153;4157.625813676784;10697.786044279072;11112.944435277772;11139.498722557504;11144.777104457866;11164.776704465865;10893.400862952614;10944;11000.889991099986;11017.83473247902;11022.732385775578;6509.967450162813;8246.670133194724;8279.172082791792;8315.667373305;8373.95813020931;6018.909716354346;6098.969505152446;6134.509239260759;6228.22147231596;6287.74849006053;9993.650222242186;10301.381917084998;10356.741081473023;10511.57953681844;10541;10338.379697218192;10379.01399367059;10564.207684423853;10611.734706632396;10648;7010.579365238102;7174.246704095995;7592.4305677075545;7717.884231736416;7735;8540.40217184791;8547.529885856338;8561.400701950804;8576.271016963628;8766.517841518778;7673.961630191813;7778.766637000899;7831.060272767304;7834.020747406575;7935.801604959691;7041.929580704333;7494.662740176815;7624.923750762421;7653.502522336253;7679.232076792499;6311.305756366888;7165.426765858823;7222.699914015528;7251.782446526613;7288.744893928687;5043.117454445384;5094.6688465249645;5132.79468821243;5189.247559103985;5281.683099013918;5080.602834220471;5123.205903085028;5274.7098909560345;5378.220158076979;5412.648177868426 03:20:47 INFO - PROCESS | 1664 | |4;prototype.html;289.91882272963574;300.11915029388746;301.35058947967127;304.68160771993263;306.4178061682804;4587.564181402766;4607.216773148564;4997.30037794709;5569.498745112939;5639.436056394358;4740.5970492508095;5161.509656582628;5501.284832971718;5504.504594586487;5574.581906357019;3153.5427363032345;3965.8611948581733;4079.3065178919505;4121.104292025657;4214.367844823286;4150;4155.231282212801;4191.5748645460535;4196.832126714943;4210.221109094828;3488.494168345588;4171.582841715835;4177.415161877339;4181.477315335583;4196.559361267054;3945.8027098644952;4063.430620887811;4065.4918135233097;4119.82584963287;4219.9578004219875;3565.5008298838184;3577.83899724513;3581.606023337431;3608.566971963355;3646.6717995380545;5358.437364076754;5361.81233656824;5365.356157261114;5378.354597448292;5406.837794866121;4370.673033696649;4476.8880777980485;4791.401074865642;4800.879978000578;4814.66297359185;5377.784888604451;5428.941356435496;5482.517482517483;5933.643981361089;5978.970105149447;3950.8419663213435;3960.683145348365;3962;3963.801809909493;3977.8209980550946;5382.085045542228;5868.794592189295;6105.8324294875565;6192.575707587235;6223.782167624111;3325.7505687073567;3546.29074185164;3866.3427217373114;3963.8810835674976;3994.9613100594056;3373.7638365314683;3450.810205438725;3662.3407786598136;3994.580569040267;4074.0629655179473;4032.778197199182;4190.066953132819;4739.644526660514;4759.524047595212;4768.260919557474;5042.798288068436;5872.941270587239;5942.851428714231;5953.404659534099;5958.672273025025;1385.0650810702734;1389.7567925612977;1392.011671713095;1400.9929950350183;1403.8979401170031;745.4185735126609;816.1838161838161;835.3526017336492;851.3827475080641;864.7535452396037;5117.8720531987;5313.8937221255355;5379.354477462652;5587.70903929387;5596.860078497989;5178.197379406198;5389.27244821944;5657.783576531066;5663.178839068312;6213.378662133841;4704.835330763407;5343.182639607431;5506.229127922094;5564.916526252109;5584.246126772915;3144.402563512925;3174.1114037148322;3202.903912882617;3207.0378886334006;3238.077148012805;5370.3287089113865;5582.665040097607;5927.170196172539;6057.909576276313;6385.923191063116;5083.38999320084;6257.843553911189;6331.303556608769;6356.269029061625;6421.229452465734;5667.603267771216;6403.327650596713;6471.352864713491;6485.513586481033;6500.479961603155;5419.34967803866;5595.776168953196;5789.768409263583;5897.790952854741;6094.695265236809;5399.622026458267;5605.467480589337;5773.8556536086935;6036.426539478743;6050.184944516539;5640.5769567281795;5910.640552672823;6028.728707208098;6364.331745166691;6448.742050317935;3945.8421663133154;3997.8400863965117;4024.215278020758;4035.489124461737;4069.5116586009867;5295.920561191662;5637.5489960802215;5911.379305173067;6218.657973811484;6233.532485063729;4961.8511444656715;5602.747876345656;5896.469317761422;5919.7040147991565;6004.519638429003;4945.727984960861;5212.244224587489;5910.7931222407005;5952.732127054206;6011.398860113954;5278.249575382187;5486.396496385315;5747.712614369181;5828.475437210672;5873.795871846176;4828.5412885775795;5076.619253555924;5454.181872718965;5643.576731745217;5935.584509084322;5228.960705325002;5476.726163691879;5774.682392468455;5816.982028145142;5821.505172060422 03:20:47 INFO - PROCESS | 1664 | |5;yui.html;700.8353037036298;711.9003339532463;726.93457588817;783.2676447521568;815.571824791984;15300.387984480622;15661.686766264682;16013.599660008476;16031.519054428356;16047.438339658114;12945.805812912813;12946.676333091678;12988.220706757602;12997.61007169784;13020.47918083278;559.3008739076155;653.150903825028;676.4149011105408;826.7974346285154;842.5071333270014;812.1513018895239;840.6427268410931;846.7036537211957;846.7713717296326;847.0174597466939;895.5566994337779;895.83427065993;896.7040876510769;898.0166717444388;900.4102312984973;893.6112790935964;896.7354630384052;897.5960817632059;897.6768363389175;907.2923119966437;664.4617859533793;664.5149041199951;664.9958562570505;665;668.615546061012;14920;15295.15876626785;15324.387024519006;15363.923180384027;15379.846201537954;14898.702025959421;14901.105933643908;14904.850951490564;14909;14937.551873443814;11658.883411165949;11715.472803723853;11724;11981.46083426248;12306.753864922652;3867.9226415471535;3869.187470631171;3935.645791878716;4000.899977500557;4019.77891215983;123168.38415807953;126334;129030;129344.99999999905;129896;11258;11564.248323858923;11586.073114150848;11608.709782255342;11728.530858765555;23175.652365214537;24018.639720404208;24067.398315042265;24410.389740256636;24452;8059.798505037304;8258.793530161674;8275.8344833103;8336.374771892133;8515.659373625109;4497.190505708938;4528.207563676344;4564.612007979293;4631.328457373662;4700.153972284953;3618.674319311222;3681.226942342138;3687.797171155612;3710.406334986389;3728.217074414403;667.889142328966;668.391763495217;671.5601281160848;674.5885010143809;678.7658257901016;599.838043728191;606.5663050918527;610.0300522169771;652.2238536141975;676.8883134282788;9713.174380177623;9722.75693107678;9756.170725488271;9817.312788104764;10100.747481313027;558.488982580942;605.5186127029023;622.5206590925053;650.8015055408146;664.5879554676035;4569.327470124992;4842.951570484321;4849.684770489906;4904.779284932187;4927.0884886295435;105478;121851;141178.2941085288;165066;175522;140722;141631;144059;144268.27865860602;145793;119259;120882.79117208891;125296;126233;129197;9275.30435217348;9279.62881484733;9305;9353.81292374135;9372.343935924693;55406.72296638491;66871.66564167148;68033;69125;70622;76395.61802190954;82417.58791206006;101063;104388.95611044097;105477.47261263644;12882.09825312219;13146.60560183196;13183.604491865259;13271.535496257584;13478.730425391634;14159.716805664035;14808.7778683322;14912.478063267734;15774.97462664969;15800.683986320439;13824.239666818421;13877.722445551235;14457.349419276368;14645.41418343297;14740.705185896008;13772.03595748288;13985.860141398456;14012.019158658795;14518.63703407381;14600.342984565508;13387.531436399679;13539.729205415639;13670;14061.36723847409;14275.072120312147;11277;11391;11507.712307192387;11813.704657383634;11881.287122772661;11262;11335.319880807177;11571.537138514364;11811.586594469496;11870 03:20:47 INFO - PROCESS | 1664 | __end_tp_report 03:20:47 INFO - PROCESS | 1664 | __start_cc_report 03:20:47 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,366 03:20:47 INFO - PROCESS | 1664 | __end_cc_report 03:20:47 INFO - PROCESS | 1664 | __startTimestamp1474798847543__endTimestamp 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | ------- Summary: start ------- 03:20:47 INFO - PROCESS | 1664 | Number of tests: 6 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5759.03 Median:5971.82 stddev:651.15 (10.9%) stddev-sans-first:627.57 03:20:47 INFO - PROCESS | 1664 | Values: 3455.2 3456.1 3476.0 3496.2 3509.0 5737.2 5812.1 5821.0 5839.9 5840.8 5839.5 5848.1 5895.4 5905.5 5915.1 5228.4 5347.6 5361.8 5363.2 5383.1 5376.9 5392.6 5395.7 5411.2 5422.2 5246.7 5249.4 5370.0 5390.0 5424.4 5113.3 5259.6 5271.6 5277.9 5333.8 5230.3 5272.7 5279.6 5352.0 5391.5 5623.7 5884.5 5943.3 5955.4 6069.5 6120.8 6139.9 6188.1 6204.6 6243.4 6230.3 6268.2 6273.8 6275.8 6306.0 4484.5 4967.7 5405.4 5817.9 5971.8 5265.2 5510.2 6312.2 6325.1 6343.8 6197.4 6223.5 6242.6 6258.6 6270.5 5270.2 6158.3 6269.4 6270.5 6302.0 6194.2 6194.4 6213.1 6222.8 6235.2 6208.8 6239.6 6263.2 6287.3 6296.7 4885.8 4940.4 4942.2 4952.5 4955.3 4413.8 4424.3 4425.8 4438.5 4458.5 5924.3 5985.8 6006.5 6008.5 6008.7 6198.3 6232.4 6254.0 6265.0 6267.9 4889.4 5884.1 5973.8 6016.9 6059.8 4582.5 5493.4 5499.9 5510.9 5517.6 6442.6 6462.1 6467.3 6467.4 6496.8 6114.8 6137.3 6171.5 6198.3 6212.8 6484.0 6492.3 6499.2 6506.0 6513.5 6239.2 6242.8 6248.9 6252.3 6266.3 6136.1 6186.0 6192.3 6255.1 6282.2 6038.1 6182.1 6239.6 6242.0 6245.0 6166.6 6181.9 6201.4 6218.1 6229.1 5665.5 5685.5 5906.0 5999.0 6074.1 4732.6 5846.6 5861.6 5869.3 5885.6 5634.5 5672.9 5693.2 5705.8 5738.4 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:68498.25 Median:39515.91 stddev:155470.34 (393.4%) stddev-sans-first:155822.60 03:20:47 INFO - PROCESS | 1664 | Values: 479.0 488.1 527.4 551.5 556.9 37415.8 39506.4 39525.4 39557.8 39601.8 40846.4 41340.0 41460.8 41508.0 41533.4 9550.4 9684.5 9699.6 9799.7 9821.8 8862.3 9678.5 9688.1 9705.0 9727.8 9767.6 9775.5 9812.5 9815.2 9835.9 9720.0 9779.3 9786.3 9794.1 9795.8 9706.8 9777.6 9778.1 9792.2 9814.5 39382.8 39444.8 39680.4 39735.6 39737.0 3205.2 3431.5 3614.5 3699.9 3798.2 29593.0 29624.1 29679.4 30397.4 30581.0 2663.6 3277.8 3344.2 3385.1 3386.0 416541.9 443537.0 462636.1 482713.0 512999.0 31637.5 33133.2 48399.8 54102.0 56473.7 34410.7 34493.0 34527.0 34792.1 34833.1 12865.9 14527.4 15001.1 15110.8 15157.8 12873.0 12934.3 12955.3 12981.4 13045.0 7510.9 7573.3 7608.4 7692.8 7727.6 2836.4 3181.3 3230.8 3237.3 3250.3 941.4 942.3 961.5 1077.7 1086.7 29709.6 30074.2 30093.8 30129.2 30598.7 983.9 988.7 1086.9 1112.4 1174.8 15196.9 15445.4 15650.5 15825.6 15876.0 672171.0 676405.0 679584.0 679705.0 682415.0 56556.0 56608.2 57104.7 57123.4 57343.4 1376.8 1396.6 1396.6 1397.3 1398.4 25133.9 26187.8 29708.7 30171.8 30182.7 47442.0 48523.0 48727.0 48899.8 48944.0 574506.0 575412.0 576071.0 577155.0 578558.0 25948.1 26123.9 26235.0 26550.9 26593.7 38196.4 46264.8 47176.3 47473.5 47797.3 32128.7 38751.2 39641.6 40531.0 40783.2 39347.6 39414.0 39952.0 40224.0 40276.6 32629.0 32681.5 35806.0 38035.9 38581.6 27545.9 28634.3 29596.0 30862.0 34682.8 23478.6 26089.5 26196.3 26321.9 26514.3 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34749.40 Median:21621.39 stddev:99103.12 (458.4%) stddev-sans-first:99347.53 03:20:47 INFO - PROCESS | 1664 | Values: 379.3 381.4 388.4 391.5 408.9 17745.3 19115.9 21355.3 21478.6 21766.2 20005.1 20016.4 20848.4 20926.8 21166.4 5988.8 5991.6 6115.7 6164.9 6242.7 4261.7 4491.5 6096.7 6186.6 6199.9 6645.5 6927.0 6988.7 7072.7 7074.3 6610.8 6965.0 6979.1 7039.9 7060.0 5971.2 6130.0 6183.5 6201.1 6215.6 13260.9 13432.7 13475.0 13482.1 20041.4 2175.9 2198.9 2221.5 2230.6 2318.7 10018.8 10031.6 10167.3 10566.3 10608.3 1880.6 1954.1 1965.0 1979.1 1988.7 98890.0 119510.0 127277.4 128463.4 129104.0 11589.0 11722.8 12021.9 12031.6 12114.9 14811.6 14942.4 14945.9 14946.3 14984.8 7878.7 8267.5 8491.4 8699.2 8879.2 7280.3 7365.0 8781.8 8819.8 8907.8 4529.3 4624.9 4628.1 4653.0 4702.8 1591.6 1670.2 1772.4 1953.4 1974.4 767.8 981.2 993.3 1007.4 1008.9 20714.7 21391.0 21620.0 21622.8 21823.5 941.5 944.8 965.8 986.2 1011.1 11053.3 11299.6 11491.3 11527.3 11549.0 510563.0 597531.0 606262.0 611444.0 630490.0 117387.4 117718.0 130772.3 130803.0 134714.0 983.7 991.6 1004.9 1004.9 1006.2 17681.2 18486.5 18835.5 19033.4 19150.6 54237.7 54739.0 55589.4 56287.7 56404.7 76942.6 78731.2 81196.0 81220.0 81604.0 6357.9 7188.2 7475.6 7564.8 7595.2 10283.5 10616.3 10983.0 11911.8 12973.1 9896.9 10920.8 11069.4 11105.1 11151.4 10560.8 10622.3 10780.3 11286.4 11431.5 11307.3 11513.4 11650.2 11970.0 12008.5 7382.2 7581.1 7608.8 7623.7 7668.5 11203.9 11365.4 11413.0 11592.8 11709.9 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5836.30 Median:4832.69 stddev:3280.31 (67.9%) stddev-sans-first:3273.10 03:20:47 INFO - PROCESS | 1664 | Values: 1470.5 1506.4 1705.1 1837.3 1849.6 8170.1 8402.7 8638.9 9212.9 9234.9 8648.6 8912.8 8941.0 8951.8 9017.5 2403.9 2422.5 2424.3 2427.6 2431.3 2393.3 2400.1 2418.7 2428.8 2437.3 2093.7 2419.2 2422.9 2425.4 2427.4 2389.5 2395.2 2397.6 2408.8 2416.9 2360.1 2380.6 2393.0 2394.3 2394.7 8928.8 9063.0 9092.4 9099.2 9139.8 4558.9 5239.6 5281.7 5470.8 5481.9 3462.8 3642.6 3647.9 3682.0 3682.1 925.9 1085.8 1090.3 1104.6 1113.2 10975.3 11331.0 11780.1 11940.6 11983.6 4824.2 4841.2 4867.5 4950.3 4981.9 10265.6 10269.9 10273.5 10288.0 10338.4 5483.1 5508.6 5510.4 5519.1 5525.7 4204.5 4364.9 4451.7 4581.4 4960.7 3409.8 3766.2 4068.3 4136.9 4190.2 1248.5 1315.3 1333.7 1334.9 1345.4 711.5 869.5 882.4 954.4 964.6 6021.2 6037.6 6056.2 6230.1 6421.7 952.6 956.6 975.7 1008.3 1037.7 3937.6 4013.4 4017.8 4057.7 4157.6 10697.8 11112.9 11139.5 11144.8 11164.8 10893.4 10944.0 11000.9 11017.8 11022.7 6510.0 8246.7 8279.2 8315.7 8374.0 6018.9 6099.0 6134.5 6228.2 6287.7 9993.7 10301.4 10356.7 10511.6 10541.0 10338.4 10379.0 10564.2 10611.7 10648.0 7010.6 7174.2 7592.4 7717.9 7735.0 8540.4 8547.5 8561.4 8576.3 8766.5 7674.0 7778.8 7831.1 7834.0 7935.8 7041.9 7494.7 7624.9 7653.5 7679.2 6311.3 7165.4 7222.7 7251.8 7288.7 5043.1 5094.7 5132.8 5189.2 5281.7 5080.6 5123.2 5274.7 5378.2 5412.6 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4700.74 Median:5360.12 stddev:1475.37 (27.5%) stddev-sans-first:1441.88 03:20:47 INFO - PROCESS | 1664 | Values: 289.9 300.1 301.4 304.7 306.4 4587.6 4607.2 4997.3 5569.5 5639.4 4740.6 5161.5 5501.3 5504.5 5574.6 3153.5 3965.9 4079.3 4121.1 4214.4 4150.0 4155.2 4191.6 4196.8 4210.2 3488.5 4171.6 4177.4 4181.5 4196.6 3945.8 4063.4 4065.5 4119.8 4220.0 3565.5 3577.8 3581.6 3608.6 3646.7 5358.4 5361.8 5365.4 5378.4 5406.8 4370.7 4476.9 4791.4 4800.9 4814.7 5377.8 5428.9 5482.5 5933.6 5979.0 3950.8 3960.7 3962.0 3963.8 3977.8 5382.1 5868.8 6105.8 6192.6 6223.8 3325.8 3546.3 3866.3 3963.9 3995.0 3373.8 3450.8 3662.3 3994.6 4074.1 4032.8 4190.1 4739.6 4759.5 4768.3 5042.8 5872.9 5942.9 5953.4 5958.7 1385.1 1389.8 1392.0 1401.0 1403.9 745.4 816.2 835.4 851.4 864.8 5117.9 5313.9 5379.4 5587.7 5596.9 5178.2 5389.3 5657.8 5663.2 6213.4 4704.8 5343.2 5506.2 5564.9 5584.2 3144.4 3174.1 3202.9 3207.0 3238.1 5370.3 5582.7 5927.2 6057.9 6385.9 5083.4 6257.8 6331.3 6356.3 6421.2 5667.6 6403.3 6471.4 6485.5 6500.5 5419.3 5595.8 5789.8 5897.8 6094.7 5399.6 5605.5 5773.9 6036.4 6050.2 5640.6 5910.6 6028.7 6364.3 6448.7 3945.8 3997.8 4024.2 4035.5 4069.5 5295.9 5637.5 5911.4 6218.7 6233.5 4961.9 5602.7 5896.5 5919.7 6004.5 4945.7 5212.2 5910.8 5952.7 6011.4 5278.2 5486.4 5747.7 5828.5 5873.8 4828.5 5076.6 5454.2 5643.6 5935.6 5229.0 5476.7 5774.7 5817.0 5821.5 03:20:47 INFO - PROCESS | 1664 | 03:20:47 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:26334.70 Median:24043.02 stddev:42529.47 (176.9%) stddev-sans-first:42605.22 03:20:47 INFO - PROCESS | 1664 | Values: 700.8 711.9 726.9 783.3 815.6 15300.4 15661.7 16013.6 16031.5 16047.4 12945.8 12946.7 12988.2 12997.6 13020.5 559.3 653.2 676.4 826.8 842.5 812.2 840.6 846.7 846.8 847.0 895.6 895.8 896.7 898.0 900.4 893.6 896.7 897.6 897.7 907.3 664.5 664.5 665.0 665.0 668.6 14920.0 15295.2 15324.4 15363.9 15379.8 14898.7 14901.1 14904.9 14909.0 14937.6 11658.9 11715.5 11724.0 11981.5 12306.8 3867.9 3869.2 3935.6 4000.9 4019.8 123168.4 126334.0 129030.0 129345.0 129896.0 11258.0 11564.2 11586.1 11608.7 11728.5 23175.7 24018.6 24067.4 24410.4 24452.0 8059.8 8258.8 8275.8 8336.4 8515.7 4497.2 4528.2 4564.6 4631.3 4700.2 3618.7 3681.2 3687.8 3710.4 3728.2 667.9 668.4 671.6 674.6 678.8 599.8 606.6 610.0 652.2 676.9 9713.2 9722.8 9756.2 9817.3 10100.7 558.5 605.5 622.5 650.8 664.6 4569.3 4843.0 4849.7 4904.8 4927.1 105478.0 121851.0 141178.3 165066.0 175522.0 140722.0 141631.0 144059.0 144268.3 145793.0 119259.0 120882.8 125296.0 126233.0 129197.0 9275.3 9279.6 9305.0 9353.8 9372.3 55406.7 66871.7 68033.0 69125.0 70622.0 76395.6 82417.6 101063.0 104389.0 105477.5 12882.1 13146.6 13183.6 13271.5 13478.7 14159.7 14808.8 14912.5 15775.0 15800.7 13824.2 13877.7 14457.3 14645.4 14740.7 13772.0 13985.9 14012.0 14518.6 14600.3 13387.5 13539.7 13670.0 14061.4 14275.1 11277.0 11391.0 11507.7 11813.7 11881.3 11262.0 11335.3 11571.5 11811.6 11870.0 03:20:47 INFO - PROCESS | 1664 | -------- Summary: end -------- 03:20:47 INFO - PROCESS | 1664 | 03:20:48 INFO - TEST-INFO | 1664: exit 0 03:20:48 INFO - TEST-OK | dromaeo_css | took 1114534ms 03:20:48 INFO - TEST-START | kraken 03:20:48 INFO - operating with platform_type : mac_ 03:20:48 INFO - Initialising browser for kraken test... 03:20:48 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpsr1dGJ/profile http://localhost:49275/getInfo.html) 03:20:50 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 03:20:50 INFO - PROCESS | 1672 | colorDepth:24 03:20:50 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 03:20:50 INFO - PROCESS | 1672 | __metrics 03:20:51 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:20:51 INFO - TEST-INFO | 1672: exit 0 03:20:51 INFO - Browser initialized. 03:20:51 INFO - Running cycle 1/1 for kraken test... 03:20:51 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpsr1dGJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:03 INFO - PROCESS | 1675 | RSS: Main: 224833536 03:21:03 INFO - PROCESS | 1675 | 03:21:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:08 INFO - PROCESS | 1675 | RSS: Main: 237584384 03:21:08 INFO - PROCESS | 1675 | 03:21:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:21:11 INFO - PROCESS | 1675 | RSS: Main: 244977664 03:21:11 INFO - PROCESS | 1675 | 03:21:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:21:15 INFO - PROCESS | 1675 | RSS: Main: 248692736 03:21:15 INFO - PROCESS | 1675 | 03:21:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:21:17 INFO - PROCESS | 1675 | RSS: Main: 249974784 03:21:17 INFO - PROCESS | 1675 | 03:21:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:20 INFO - PROCESS | 1675 | RSS: Main: 250359808 03:21:20 INFO - PROCESS | 1675 | 03:21:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:23 INFO - PROCESS | 1675 | RSS: Main: 250503168 03:21:23 INFO - PROCESS | 1675 | 03:21:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:27 INFO - PROCESS | 1675 | RSS: Main: 250437632 03:21:27 INFO - PROCESS | 1675 | 03:21:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:21:30 INFO - PROCESS | 1675 | RSS: Main: 250843136 03:21:30 INFO - PROCESS | 1675 | 03:21:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:33 INFO - PROCESS | 1675 | RSS: Main: 250626048 03:21:33 INFO - PROCESS | 1675 | 03:21:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:35 INFO - PROCESS | 1675 | RSS: Main: 250855424 03:21:35 INFO - PROCESS | 1675 | 03:21:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:38 INFO - PROCESS | 1675 | RSS: Main: 250724352 03:21:38 INFO - PROCESS | 1675 | 03:21:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:42 INFO - PROCESS | 1675 | RSS: Main: 250621952 03:21:42 INFO - PROCESS | 1675 | 03:21:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:45 INFO - PROCESS | 1675 | RSS: Main: 251019264 03:21:45 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:21:47 INFO - PROCESS | 1675 | RSS: Main: 252596224 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | __start_tp_report 03:21:47 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 03:21:47 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 03:21:47 INFO - PROCESS | 1675 | |i|pagename|runs| 03:21:47 INFO - PROCESS | 1675 | |0;ai-astar;108;172;119;117;121;146;171;150;117;118 03:21:47 INFO - PROCESS | 1675 | |1;audio-beat-detection;141;111;109;140;111;112;116;139;131;141 03:21:47 INFO - PROCESS | 1675 | |2;audio-dft;199;196;197;200;194;198;203;199;219;195 03:21:47 INFO - PROCESS | 1675 | |3;audio-fft;73;64;49;86;74;52;60;83;101;82 03:21:47 INFO - PROCESS | 1675 | |4;audio-oscillator;122;68;90;57;65;77;124;101;55;91 03:21:47 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;88;91;86;90;109;90;87;93;89 03:21:47 INFO - PROCESS | 1675 | |6;imaging-darkroom;115;119;96;95;96;96;105;96;97;95 03:21:47 INFO - PROCESS | 1675 | |7;imaging-desaturate;89;96;90;92;95;91;93;102;91;99 03:21:47 INFO - PROCESS | 1675 | |8;json-parse-financial;57;56;55;57;60;58;58;62;67;89 03:21:47 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;70;73;77;78;84;75;71;68;67;71 03:21:47 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;87;86;85;85;86;81;87;88;88;86 03:21:47 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;138;143;158;151;155;153;150;156;195;135 03:21:47 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;162;232;163;165;210;179;168;222;159;175 03:21:47 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;69;66;69;67;69;66;67;68;67;64 03:21:47 INFO - PROCESS | 1675 | __end_tp_report 03:21:47 INFO - PROCESS | 1675 | __start_cc_report 03:21:47 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,947 03:21:47 INFO - PROCESS | 1675 | __end_cc_report 03:21:47 INFO - PROCESS | 1675 | __startTimestamp1474798907604__endTimestamp 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | ------- Summary: start ------- 03:21:47 INFO - PROCESS | 1675 | Number of tests: 14 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:133.90 Median:133.50 stddev:23.84 (17.9%) stddev-sans-first:23.38 03:21:47 INFO - PROCESS | 1675 | Values: 108.0 172.0 119.0 117.0 121.0 146.0 171.0 150.0 117.0 118.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:135.00 stddev:14.40 (10.7%) stddev-sans-first:14.08 03:21:47 INFO - PROCESS | 1675 | Values: 141.0 111.0 109.0 140.0 111.0 112.0 116.0 139.0 131.0 141.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:200.00 Median:199.00 stddev:7.16 (3.6%) stddev-sans-first:7.59 03:21:47 INFO - PROCESS | 1675 | Values: 199.0 196.0 197.0 200.0 194.0 198.0 203.0 199.0 219.0 195.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:72.40 Median:73.50 stddev:16.32 (22.2%) stddev-sans-first:17.31 03:21:47 INFO - PROCESS | 1675 | Values: 73.0 64.0 49.0 86.0 74.0 52.0 60.0 83.0 101.0 82.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:66.50 stddev:25.04 (37.7%) stddev-sans-first:22.70 03:21:47 INFO - PROCESS | 1675 | Values: 122.0 68.0 90.0 57.0 65.0 77.0 124.0 101.0 55.0 91.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:90.00 stddev:6.53 (7.3%) stddev-sans-first:6.91 03:21:47 INFO - PROCESS | 1675 | Values: 90.0 88.0 91.0 86.0 90.0 109.0 90.0 87.0 93.0 89.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:96.00 stddev:8.97 (9.3%) stddev-sans-first:7.95 03:21:47 INFO - PROCESS | 1675 | Values: 115.0 119.0 96.0 95.0 96.0 96.0 105.0 96.0 97.0 95.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:92.50 stddev:4.18 (4.5%) stddev-sans-first:4.06 03:21:47 INFO - PROCESS | 1675 | Values: 89.0 96.0 90.0 92.0 95.0 91.0 93.0 102.0 91.0 99.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:59.00 stddev:10.14 (17.2%) stddev-sans-first:10.60 03:21:47 INFO - PROCESS | 1675 | Values: 57.0 56.0 55.0 57.0 60.0 58.0 58.0 62.0 67.0 89.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:74.00 stddev:5.19 (7.0%) stddev-sans-first:5.36 03:21:47 INFO - PROCESS | 1675 | Values: 70.0 73.0 77.0 78.0 84.0 75.0 71.0 68.0 67.0 71.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:2.02 (2.3%) stddev-sans-first:2.11 03:21:47 INFO - PROCESS | 1675 | Values: 87.0 86.0 85.0 85.0 86.0 81.0 87.0 88.0 88.0 86.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:154.00 stddev:16.54 (10.7%) stddev-sans-first:16.58 03:21:47 INFO - PROCESS | 1675 | Values: 138.0 143.0 158.0 151.0 155.0 153.0 150.0 156.0 195.0 135.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:177.00 stddev:27.27 (15.4%) stddev-sans-first:27.80 03:21:47 INFO - PROCESS | 1675 | Values: 162.0 232.0 163.0 165.0 210.0 179.0 168.0 222.0 159.0 175.0 03:21:47 INFO - PROCESS | 1675 | 03:21:47 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.62 (2.4%) stddev-sans-first:1.58 03:21:47 INFO - PROCESS | 1675 | Values: 69.0 66.0 69.0 67.0 69.0 66.0 67.0 68.0 67.0 64.0 03:21:47 INFO - PROCESS | 1675 | -------- Summary: end -------- 03:21:47 INFO - PROCESS | 1675 | 03:21:48 INFO - TEST-INFO | 1675: exit 0 03:21:48 INFO - TEST-OK | kraken | took 60262ms 03:21:48 INFO - SUITE-END | took 1174s 03:21:48 INFO - Completed test suite (00:19:35) 03:21:48 INFO - javascript benchmark 03:21:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.553266112745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.2053027803604, 3456.0668619472744, 3475.9826200869, 3496.1958749487603, 3508.9999350185203, 5737.225474560933, 5812.070068788984, 5820.981328267558, 5839.883202335956, 5840.795572154975, 5839.503642190408, 5848.093545500444, 5895.380984996567, 5905.527557795377, 5915.08316210988, 5228.398734145574, 5347.59893008024, 5361.812336568221, 5363.168708850135, 5383.057964856134, 5376.91934620979, 5392.649477783951, 5395.7032363220005, 5411.161270003156, 5422.186671999212, 5246.68519888806, 5249.396319423277, 5370.006548788467, 5389.973050134744, 5424.403315635297, 5113.284140220372, 5259.631825772198, 5271.604629652791, 5277.894442111136, 5333.813316533941, 5230.34620672416, 5272.657277276965, 5279.5512381447625, 5351.973240133774, 5391.48780865821, 5623.746931388097, 5884.470397664188, 5943.31651860033, 5955.434233747787, 6069.484093852028, 6120.843333897677, 6139.921477737053, 6188.133661287423, 6204.627722336674, 6243.406876346739, 6230.2523697156175, 6268.1851359323455, 6273.811785646438, 6275.780347687854, 6306.0225665022, 4484.461864576239, 4967.7019378837385, 5405.4324295949145, 5817.883642327172, 5971.820845374646, 5265.183896496049, 5510.228568000483, 6312.24253089623, 6325.14610527582, 6343.777967771106, 6197.380261973766, 6223.502119830403, 6242.563020588515, 6258.624482531062, 6270.529710271748, 5270.245424685598, 6158.261008678987, 6269.435750782361, 6270.467010304175, 6302.023186406114, 6194.225721784777, 6194.4115309045565, 6213.068039793977, 6222.81331560054, 6235.220597425322, 6208.782692605737, 6239.563230573816, 6263.185785847811, 6287.339829317947, 6296.685165741695, 4885.780139893714, 4940.407151141814, 4942.20924652054, 4952.47998960104, 4955.331030310934, 4413.8234470621455, 4424.269995450779, 4425.800838962255, 4438.533953934855, 4458.519560710555, 5924.259467566554, 5985.820425387158, 6006.489448396936, 6008.54935879802, 6008.729607167688, 6198.287196972406, 6232.376762323732, 6254.0, 6265.0, 6267.874642507124, 4889.3888263967, 5884.117382392676, 5973.820785376446, 6016.879662406727, 6059.757609695651, 4582.518835522222, 5493.395726470085, 5499.862503437446, 5510.862228444241, 5517.613767036269, 6442.613443193423, 6462.063000864849, 6467.288598254094, 6467.385598368148, 6496.837579060372, 6114.816555503342, 6137.263528376623, 6171.506279497539, 6198.349173336735, 6212.782552610637, 6483.967580162258, 6492.253390860112, 6499.2200935887995, 6506.0, 6513.54405191632, 6239.188905442264, 6242.750289988349, 6248.906266406098, 6252.280987686292, 6266.279377871603, 6136.120845438751, 6186.0, 6192.349803270772, 6255.124282600348, 6282.1519094921605, 6038.094285857156, 6182.103594978793, 6239.563230573816, 6242.0, 6245.0, 6166.630002199882, 6181.938180618136, 6201.379862013762, 6218.06728990655, 6229.065640154013, 5665.518430933252, 5685.459881311269, 5905.970470147622, 5998.970005149947, 6074.149619053248, 4732.621390288699, 5846.5615078870105, 5861.648301101947, 5869.295684517885, 5885.558583106199, 5634.549236061187, 5672.858178545404, 5693.174489699053, 5705.828825135252, 5738.368779434342], "value": 5720.10574585925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.96407769417294, 488.1140729575821, 527.4277409011223, 551.4816072891484, 556.9470900264473, 37415.812920935394, 39506.40740388897, 39525.40711889324, 39557.80221098898, 39601.80199099004, 40846.38730419046, 41340.0, 41460.75617731465, 41507.96230094249, 41533.37699934503, 9550.379225350365, 9684.467354295512, 9699.563519641633, 9799.706008819747, 9821.803563928717, 8862.291016718647, 9678.467684277362, 9688.079632434907, 9705.0, 9727.805443891119, 9767.609295628166, 9775.462349570806, 9812.46031468269, 9815.165710914582, 9835.852462213037, 9719.999999999965, 9779.315447918649, 9786.314957952945, 9794.118529332394, 9795.804083918352, 9706.757331066709, 9777.608895644165, 9778.119969202806, 9792.21662267017, 9814.46020468874, 39382.80308598468, 39444.80277598594, 39680.404793928115, 39735.60264397377, 39737.0, 3205.1666566692593, 3431.5367425397503, 3614.4759009943673, 3699.8705045323554, 3798.1833905710128, 29593.0, 29624.111276661733, 29679.406411871856, 30397.392052159055, 30581.0, 2663.6270922070926, 3277.8033318000757, 3344.180675734436, 3385.0691059958463, 3385.9830700846583, 416541.9172904146, 443537.0, 462636.06045909337, 482713.0, 512999.0, 31637.52543711846, 33133.17167070843, 48399.82200800972, 54102.0, 56473.71763141158, 34410.655893441246, 34493.0, 34527.0, 34792.13019674528, 34833.12917177091, 12865.871341286655, 14527.418903243752, 15001.099934003994, 15110.773338399933, 15157.848421515644, 12872.970162386986, 12934.288614126126, 12955.287459189834, 12981.350932453339, 13045.021623378285, 7510.924890751132, 7573.318401343906, 7608.429367797437, 7692.846143077107, 7727.613619319011, 2836.432713457317, 3181.3001139749217, 3230.82230477326, 3237.2716138869037, 3250.3174333390252, 941.4445477168504, 942.2509105261333, 961.4904100826573, 1077.7036315013434, 1086.6685660873352, 29709.554356684668, 30074.248143796143, 30093.849530752643, 30129.246768830955, 30598.69401306003, 983.9176905404141, 988.7429268390126, 1086.875009373932, 1112.4437781109445, 1174.7826652069396, 15196.933425956762, 15445.382184712711, 15650.530484085495, 15825.604359891095, 15876.0, 672171.0, 676405.0, 679584.0, 679705.0, 682415.0, 56556.0, 56608.150877736865, 57104.714476427354, 57123.42876571181, 57343.42656573381, 1376.8072469854228, 1396.553103007028, 1396.5740449163102, 1397.3432486731017, 1398.4126666799968, 25133.87433062823, 26187.821548030002, 29708.702912970595, 30171.849140755035, 30182.69817301799, 47442.0, 48523.02953940972, 48727.0254594899, 48899.755501222266, 48944.0, 574506.0, 575412.0, 576071.0, 577155.0, 578558.0, 25948.09181678632, 26123.869380652974, 26235.0, 26550.86724566365, 26593.734062659125, 38196.42705359366, 46264.768676156404, 47176.29235561401, 47473.52526474691, 47797.283040755116, 32128.67871321257, 38751.224975500896, 39641.60358396379, 40531.0, 40783.1843363137, 39347.606523934395, 39414.0, 39952.00119997023, 40224.0, 40276.59723402846, 32629.021129366156, 32681.509777352883, 35806.0, 38035.858924232314, 38581.614183857804, 27545.862270688518, 28634.284142896595, 29595.964141255816, 30862.0, 34682.82658586691, 23478.64782028305, 26089.478210435307, 26196.345091372867, 26321.919171809524, 26514.337141570843], "value": 18409.25185053925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3323750199648, 381.4469019921114, 388.4115564919148, 391.45978549601546, 408.93048181809087, 17745.29018839245, 19115.904420477895, 21355.25256616015, 21478.570428591418, 21766.238181663626, 20005.099770510325, 20016.399508014747, 20848.37454876356, 20926.790732092675, 21166.365009049714, 5988.802239552086, 5991.550633702468, 6115.724792384353, 6164.938350616504, 6242.656653884034, 4261.722988005769, 4491.505934347219, 6096.664683442409, 6186.597871138384, 6199.876002479948, 6645.534812563123, 6927.0, 6988.685509152075, 7072.717091316341, 7074.257202993663, 6610.834729131786, 6964.9999999999745, 6979.092717946685, 7039.929600703978, 7059.964700176518, 5971.193888824996, 6129.988551888933, 6183.505319574469, 6201.069839524062, 6215.627062376227, 13260.933695331558, 13432.664183395396, 13475.0, 13482.05625606208, 20041.39875803728, 2175.8585691929975, 2198.9120435182735, 2221.5334779696122, 2230.60964331243, 2318.698569185995, 10018.849717254247, 10031.648892288807, 10167.288289819715, 10566.31318964265, 10608.310459820086, 1880.5956719305277, 1954.140178321534, 1964.9705254421194, 1979.0500559731265, 1988.6818109102473, 98890.0, 119510.0, 127277.36361318319, 128463.35768321191, 129104.0, 11589.0, 11722.827717228209, 12021.939890300493, 12031.63905082849, 12114.909658130811, 14811.629709257355, 14942.40230390794, 14945.850541494663, 14946.252687365806, 14984.775228371584, 7878.660627693306, 8267.545285009262, 8491.448055876348, 8699.173578510032, 8879.24526415262, 7280.344768970712, 7364.96317518409, 8781.824363512822, 8819.779505512413, 8907.821843563092, 4529.252673308933, 4624.907501849944, 4628.051249493846, 4652.97673511637, 4702.764861756898, 1591.6180116772123, 1670.2400407814657, 1772.3708083630127, 1953.3749200256066, 1974.3978086683699, 767.7926959720955, 981.1652210366517, 993.3493561717087, 1007.3754272351042, 1008.85371621116, 20714.689279660815, 21391.0, 21620.0, 21622.78377216239, 21823.490298615863, 941.5433514745343, 944.8299306124826, 965.830979578585, 986.1617625018677, 1011.1304278320638, 11053.336799792038, 11299.604513842141, 11491.310521368745, 11527.250728702775, 11549.018333441583, 510563.0, 597531.0, 606262.0, 611444.0, 630490.0, 117387.41306293584, 117718.0, 130772.34451912822, 130803.0, 134714.0, 983.7098056073476, 991.5736233419699, 1004.8643433136433, 1004.9397036177853, 1006.1648831469862, 17681.204345804214, 18486.537836554195, 18835.529111771768, 19033.428997130108, 19150.61698765989, 54237.72881135727, 54739.0, 55589.444105558425, 56287.74849005994, 56404.717976409855, 76942.6152869232, 78731.2126878724, 81196.0, 81220.0, 81603.95990100295, 6357.8728425432155, 7188.209296977224, 7475.626218689153, 7564.810879728051, 7595.164531901376, 10283.537240824331, 10616.256862019893, 10983.0, 11911.821322679993, 12973.09188356806, 9896.851547226941, 10920.836187457036, 11069.391183484986, 11105.111591072857, 11151.442427878736, 10560.841587376042, 10622.256442048982, 10780.29928054674, 11286.379249141377, 11431.485583148944, 11307.265027773168, 11513.366764828015, 11650.184487085822, 11970.042396608425, 12008.459619317326, 7382.224866389167, 7581.12817026027, 7608.8478230433975, 7623.705552089831, 7668.539887606761, 11203.887961120285, 11365.374904380338, 11412.972832445119, 11592.768144636892, 11709.88290117122], "value": 9533.970767002404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.470630572994, 1506.3597970862384, 1705.1048199695158, 1837.3201915291345, 1849.556106534432, 8170.060443049051, 8402.705905293316, 8638.870416943742, 9212.907870921288, 9234.90765092349, 8648.567571621425, 8912.777180570489, 8940.955295223515, 8951.776205594864, 9017.504037277948, 2403.891824867885, 2422.539717453687, 2424.284835973392, 2427.647991041298, 2431.3313838694326, 2393.293978276404, 2400.099962514057, 2418.661387405765, 2428.781409673129, 2437.305367970129, 2093.748750149984, 2419.177479656916, 2422.878856057199, 2425.442148305891, 2427.4052857050046, 2389.4623709665275, 2395.2335252719135, 2397.5924092904247, 2408.783209511135, 2416.867072311022, 2360.1031607989025, 2380.5595964746576, 2392.97607023931, 2394.317619478458, 2394.724606670238, 8928.776780580472, 9063.0, 9092.363534552584, 9099.1810737034, 9139.811824462777, 4558.883073646978, 5239.580833533309, 5281.735913204325, 5470.753816078286, 5481.862953426156, 3462.7576069675133, 3642.562892452896, 3647.908802279938, 3682.0, 3682.116292089906, 925.8657494663236, 1085.8099832529356, 1090.3131027452732, 1104.5526561742506, 1113.204059097749, 10975.341479511175, 11331.03686186675, 11780.11649126319, 11940.582079627258, 11983.64049078529, 4824.228123500293, 4841.15279826029, 4867.513248675175, 4950.331705219749, 4981.850544483671, 10265.589376425009, 10269.897301026895, 10273.486325683685, 10288.0, 10338.37969721804, 5483.122700367922, 5508.55931525477, 5510.421405752339, 5519.116941289374, 5525.668459892419, 4204.495460544754, 4364.934525982113, 4451.6883818133065, 4581.427321584802, 4960.702357858468, 3409.829508524564, 3766.152615661509, 4068.3287257602165, 4136.937945930814, 4190.20386126635, 1248.4694005047818, 1315.329182117108, 1333.6665833541615, 1334.8932085433141, 1345.374400903565, 711.4592909388798, 869.4956924983494, 882.3558802074522, 954.4464210757744, 964.5563041001218, 6021.217241758631, 6037.641530655567, 6056.152138700585, 6230.06549017651, 6421.678916054178, 952.6094301336419, 956.6316967967243, 975.7219192530094, 1008.3445760255746, 1037.6575730009079, 3937.625925537069, 4013.3979903014783, 4017.799110044486, 4057.6753859691153, 4157.625813676784, 10697.786044279072, 11112.944435277772, 11139.498722557504, 11144.777104457866, 11164.776704465865, 10893.400862952614, 10944.0, 11000.889991099986, 11017.83473247902, 11022.732385775578, 6509.967450162813, 8246.670133194724, 8279.172082791792, 8315.667373305, 8373.95813020931, 6018.909716354346, 6098.969505152446, 6134.509239260759, 6228.22147231596, 6287.74849006053, 9993.650222242186, 10301.381917084998, 10356.741081473023, 10511.57953681844, 10541.0, 10338.379697218192, 10379.01399367059, 10564.207684423853, 10611.734706632396, 10648.0, 7010.579365238102, 7174.246704095995, 7592.4305677075545, 7717.884231736416, 7735.0, 8540.40217184791, 8547.529885856338, 8561.400701950804, 8576.271016963628, 8766.517841518778, 7673.961630191813, 7778.766637000899, 7831.060272767304, 7834.020747406575, 7935.801604959691, 7041.929580704333, 7494.662740176815, 7624.923750762421, 7653.502522336253, 7679.232076792499, 6311.305756366888, 7165.426765858823, 7222.699914015528, 7251.782446526613, 7288.744893928687, 5043.117454445384, 5094.6688465249645, 5132.79468821243, 5189.247559103985, 5281.683099013918, 5080.602834220471, 5123.205903085028, 5274.7098909560345, 5378.220158076979, 5412.648177868426], "value": 4683.834051470507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.91882272963574, 300.11915029388746, 301.35058947967127, 304.68160771993263, 306.4178061682804, 4587.564181402766, 4607.216773148564, 4997.30037794709, 5569.498745112939, 5639.436056394358, 4740.5970492508095, 5161.509656582628, 5501.284832971718, 5504.504594586487, 5574.581906357019, 3153.5427363032345, 3965.8611948581733, 4079.3065178919505, 4121.104292025657, 4214.367844823286, 4150.0, 4155.231282212801, 4191.5748645460535, 4196.832126714943, 4210.221109094828, 3488.494168345588, 4171.582841715835, 4177.415161877339, 4181.477315335583, 4196.559361267054, 3945.8027098644952, 4063.430620887811, 4065.4918135233097, 4119.82584963287, 4219.9578004219875, 3565.5008298838184, 3577.83899724513, 3581.606023337431, 3608.566971963355, 3646.6717995380545, 5358.437364076754, 5361.81233656824, 5365.356157261114, 5378.354597448292, 5406.837794866121, 4370.673033696649, 4476.8880777980485, 4791.401074865642, 4800.879978000578, 4814.66297359185, 5377.784888604451, 5428.941356435496, 5482.517482517483, 5933.643981361089, 5978.970105149447, 3950.8419663213435, 3960.683145348365, 3962.0, 3963.801809909493, 3977.8209980550946, 5382.085045542228, 5868.794592189295, 6105.8324294875565, 6192.575707587235, 6223.782167624111, 3325.7505687073567, 3546.29074185164, 3866.3427217373114, 3963.8810835674976, 3994.9613100594056, 3373.7638365314683, 3450.810205438725, 3662.3407786598136, 3994.580569040267, 4074.0629655179473, 4032.778197199182, 4190.066953132819, 4739.644526660514, 4759.524047595212, 4768.260919557474, 5042.798288068436, 5872.941270587239, 5942.851428714231, 5953.404659534099, 5958.672273025025, 1385.0650810702734, 1389.7567925612977, 1392.011671713095, 1400.9929950350183, 1403.8979401170031, 745.4185735126609, 816.1838161838161, 835.3526017336492, 851.3827475080641, 864.7535452396037, 5117.8720531987, 5313.8937221255355, 5379.354477462652, 5587.70903929387, 5596.860078497989, 5178.197379406198, 5389.27244821944, 5657.783576531066, 5663.178839068312, 6213.378662133841, 4704.835330763407, 5343.182639607431, 5506.229127922094, 5564.916526252109, 5584.246126772915, 3144.402563512925, 3174.1114037148322, 3202.903912882617, 3207.0378886334006, 3238.077148012805, 5370.3287089113865, 5582.665040097607, 5927.170196172539, 6057.909576276313, 6385.923191063116, 5083.38999320084, 6257.843553911189, 6331.303556608769, 6356.269029061625, 6421.229452465734, 5667.603267771216, 6403.327650596713, 6471.352864713491, 6485.513586481033, 6500.479961603155, 5419.34967803866, 5595.776168953196, 5789.768409263583, 5897.790952854741, 6094.695265236809, 5399.622026458267, 5605.467480589337, 5773.8556536086935, 6036.426539478743, 6050.184944516539, 5640.5769567281795, 5910.640552672823, 6028.728707208098, 6364.331745166691, 6448.742050317935, 3945.8421663133154, 3997.8400863965117, 4024.215278020758, 4035.489124461737, 4069.5116586009867, 5295.920561191662, 5637.5489960802215, 5911.379305173067, 6218.657973811484, 6233.532485063729, 4961.8511444656715, 5602.747876345656, 5896.469317761422, 5919.7040147991565, 6004.519638429003, 4945.727984960861, 5212.244224587489, 5910.7931222407005, 5952.732127054206, 6011.398860113954, 5278.249575382187, 5486.396496385315, 5747.712614369181, 5828.475437210672, 5873.795871846176, 4828.5412885775795, 5076.619253555924, 5454.181872718965, 5643.576731745217, 5935.584509084322, 5228.960705325002, 5476.726163691879, 5774.682392468455, 5816.982028145142, 5821.505172060422], "value": 4220.233048356241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8353037036298, 711.9003339532463, 726.93457588817, 783.2676447521568, 815.571824791984, 15300.387984480622, 15661.686766264682, 16013.599660008476, 16031.519054428356, 16047.438339658114, 12945.805812912813, 12946.676333091678, 12988.220706757602, 12997.61007169784, 13020.47918083278, 559.3008739076155, 653.150903825028, 676.4149011105408, 826.7974346285154, 842.5071333270014, 812.1513018895239, 840.6427268410931, 846.7036537211957, 846.7713717296326, 847.0174597466939, 895.5566994337779, 895.83427065993, 896.7040876510769, 898.0166717444388, 900.4102312984973, 893.6112790935964, 896.7354630384052, 897.5960817632059, 897.6768363389175, 907.2923119966437, 664.4617859533793, 664.5149041199951, 664.9958562570505, 665.0, 668.615546061012, 14920.0, 15295.15876626785, 15324.387024519006, 15363.923180384027, 15379.846201537954, 14898.702025959421, 14901.105933643908, 14904.850951490564, 14909.0, 14937.551873443814, 11658.883411165949, 11715.472803723853, 11724.0, 11981.46083426248, 12306.753864922652, 3867.9226415471535, 3869.187470631171, 3935.645791878716, 4000.899977500557, 4019.77891215983, 123168.38415807953, 126334.0, 129030.0, 129344.99999999905, 129896.0, 11258.0, 11564.248323858923, 11586.073114150848, 11608.709782255342, 11728.530858765555, 23175.652365214537, 24018.639720404208, 24067.398315042265, 24410.389740256636, 24452.0, 8059.798505037304, 8258.793530161674, 8275.8344833103, 8336.374771892133, 8515.659373625109, 4497.190505708938, 4528.207563676344, 4564.612007979293, 4631.328457373662, 4700.153972284953, 3618.674319311222, 3681.226942342138, 3687.797171155612, 3710.406334986389, 3728.217074414403, 667.889142328966, 668.391763495217, 671.5601281160848, 674.5885010143809, 678.7658257901016, 599.838043728191, 606.5663050918527, 610.0300522169771, 652.2238536141975, 676.8883134282788, 9713.174380177623, 9722.75693107678, 9756.170725488271, 9817.312788104764, 10100.747481313027, 558.488982580942, 605.5186127029023, 622.5206590925053, 650.8015055408146, 664.5879554676035, 4569.327470124992, 4842.951570484321, 4849.684770489906, 4904.779284932187, 4927.0884886295435, 105478.0, 121851.0, 141178.2941085288, 165066.0, 175522.0, 140722.0, 141631.0, 144059.0, 144268.27865860602, 145793.0, 119259.0, 120882.79117208891, 125296.0, 126233.0, 129197.0, 9275.30435217348, 9279.62881484733, 9305.0, 9353.81292374135, 9372.343935924693, 55406.72296638491, 66871.66564167148, 68033.0, 69125.0, 70622.0, 76395.61802190954, 82417.58791206006, 101063.0, 104388.95611044097, 105477.47261263644, 12882.09825312219, 13146.60560183196, 13183.604491865259, 13271.535496257584, 13478.730425391634, 14159.716805664035, 14808.7778683322, 14912.478063267734, 15774.97462664969, 15800.683986320439, 13824.239666818421, 13877.722445551235, 14457.349419276368, 14645.41418343297, 14740.705185896008, 13772.03595748288, 13985.860141398456, 14012.019158658795, 14518.63703407381, 14600.342984565508, 13387.531436399679, 13539.729205415639, 13670.0, 14061.36723847409, 14275.072120312147, 11277.0, 11391.0, 11507.712307192387, 11813.704657383634, 11881.287122772661, 11262.0, 11335.319880807177, 11571.537138514364, 11811.586594469496, 11870.0], "value": 8019.068671168143, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 172.0, 119.0, 117.0, 121.0, 146.0, 171.0, 150.0, 117.0, 118.0], "value": 133.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 109.0, 140.0, 111.0, 112.0, 116.0, 139.0, 131.0, 141.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 197.0, 200.0, 194.0, 198.0, 203.0, 199.0, 219.0, 195.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 49.0, 86.0, 74.0, 52.0, 60.0, 83.0, 101.0, 82.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 68.0, 90.0, 57.0, 65.0, 77.0, 124.0, 101.0, 55.0, 91.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 86.0, 90.0, 109.0, 90.0, 87.0, 93.0, 89.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 119.0, 96.0, 95.0, 96.0, 96.0, 105.0, 96.0, 97.0, 95.0], "value": 101.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 90.0, 92.0, 95.0, 91.0, 93.0, 102.0, 91.0, 99.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 57.0, 60.0, 58.0, 58.0, 62.0, 67.0, 89.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 77.0, 78.0, 84.0, 75.0, 71.0, 68.0, 67.0, 71.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 85.0, 86.0, 81.0, 87.0, 88.0, 88.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 158.0, 151.0, 155.0, 153.0, 150.0, 156.0, 195.0, 135.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 232.0, 163.0, 165.0, 210.0, 179.0, 168.0, 222.0, 159.0, 175.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 67.0, 69.0, 66.0, 67.0, 68.0, 67.0, 64.0], "value": 67.2, "unit": "score"}]}]} 03:21:48 INFO - Return code: 0 03:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:48 ERROR - # TBPL SUCCESS # 03:21:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:48 INFO - 2016-09-25 03:21:48.921 screenresolution[1680:14294] starting screenresolution argv=screenresolution get 03:21:48 INFO - 2016-09-25 03:21:48.923 screenresolution[1680:14294] Display 0: 1600x1200x32@60 03:21:48 INFO - 2016-09-25 03:21:48.929 screenresolution[1681:14297] starting screenresolution argv=screenresolution list 03:21:48 INFO - Available Modes on Display 0 03:21:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:49 INFO - Intel Iris: 03:21:49 INFO - Chipset Model: Intel Iris 03:21:49 INFO - Type: GPU 03:21:49 INFO - Bus: Built-In 03:21:49 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:49 INFO - Vendor: Intel (0x8086) 03:21:49 INFO - Device ID: 0x0a2e 03:21:49 INFO - Revision ID: 0x0009 03:21:49 INFO - Displays: 03:21:49 INFO - Display: 03:21:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:49 INFO - Display Serial Number: 1600x1200 60 03:21:49 INFO - Main Display: Yes 03:21:49 INFO - Mirror: Off 03:21:49 INFO - Online: Yes 03:21:49 INFO - Rotation: Supported 03:21:49 INFO - Return code: 0 03:21:49 INFO - Running post-action listener: _resource_record_post_action 03:21:49 INFO - [mozharness: 2016-09-25 10:21:49.163748Z] Finished run-tests step (success) 03:21:49 INFO - Running post-run listener: _resource_record_post_run 03:21:49 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32234496; Write bytes: 665368064; Read time: 307; Write time: 1962 03:21:49 INFO - TinderboxPrint: CPU usage
54.2% 03:21:49 INFO - TinderboxPrint: I/O read bytes / time
32,234,496 / 307 03:21:49 INFO - TinderboxPrint: I/O write bytes / time
665,368,064 / 1,962 03:21:49 INFO - TinderboxPrint: CPU idle
2,212.0 (45.8%) 03:21:49 INFO - TinderboxPrint: CPU system
977.3 (20.2%) 03:21:49 INFO - TinderboxPrint: CPU user
1,644.4 (34.0%) 03:21:49 INFO - TinderboxPrint: Swap in / out
391,229,440 / 0 03:21:49 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 353870336; Write bytes: 356624384; Read time: 27591; Write time: 670 03:21:49 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31300608; Write bytes: 298561024; Read time: 292; Write time: 1258 03:21:49 INFO - Running post-run listener: _upload_blobber_files 03:21:49 INFO - Blob upload gear active. 03:21:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:21:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:50 INFO - (blobuploader) - INFO - Done attempting. 03:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:51 INFO - (blobuploader) - INFO - Done attempting. 03:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:54 INFO - (blobuploader) - INFO - Done attempting. 03:21:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:54 INFO - Return code: 0 03:21:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/730d4581fda86fdcb92ddc9b7e9f16616a01bf41e3ddfad568b5c6fe9ab5f301628edfc238cf28e5ac6aa679c0eb316506b311e60e58e9bb34b4c98ea89ef4d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d5119bbb86a90f2459885ecf45c4b9f42f43fda7884c3d04bbd387c61ed16588bd366b3b45028bf408d5f5e9af20a3d8a073dedc6ffffdce57e9d53c956e3c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a8f9538411afd6d176bf13f0df6a1646fc2e2a3c220cc23563253082dc24b632527c129f3b93878f754a0ab23e9930fddb71f4cce5ccbf4bf24332db55a3d5"} 03:21:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:54 INFO - Contents: 03:21:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/730d4581fda86fdcb92ddc9b7e9f16616a01bf41e3ddfad568b5c6fe9ab5f301628edfc238cf28e5ac6aa679c0eb316506b311e60e58e9bb34b4c98ea89ef4d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d5119bbb86a90f2459885ecf45c4b9f42f43fda7884c3d04bbd387c61ed16588bd366b3b45028bf408d5f5e9af20a3d8a073dedc6ffffdce57e9d53c956e3c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a8f9538411afd6d176bf13f0df6a1646fc2e2a3c220cc23563253082dc24b632527c129f3b93878f754a0ab23e9930fddb71f4cce5ccbf4bf24332db55a3d5"} 03:21:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:54 INFO - Copying logs to upload dir... 03:21:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.636232 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-25 03:21:54.859285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.864850) ========= 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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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/730d4581fda86fdcb92ddc9b7e9f16616a01bf41e3ddfad568b5c6fe9ab5f301628edfc238cf28e5ac6aa679c0eb316506b311e60e58e9bb34b4c98ea89ef4d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d5119bbb86a90f2459885ecf45c4b9f42f43fda7884c3d04bbd387c61ed16588bd366b3b45028bf408d5f5e9af20a3d8a073dedc6ffffdce57e9d53c956e3c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a8f9538411afd6d176bf13f0df6a1646fc2e2a3c220cc23563253082dc24b632527c129f3b93878f754a0ab23e9930fddb71f4cce5ccbf4bf24332db55a3d5"} build_url:https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/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/730d4581fda86fdcb92ddc9b7e9f16616a01bf41e3ddfad568b5c6fe9ab5f301628edfc238cf28e5ac6aa679c0eb316506b311e60e58e9bb34b4c98ea89ef4d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d5119bbb86a90f2459885ecf45c4b9f42f43fda7884c3d04bbd387c61ed16588bd366b3b45028bf408d5f5e9af20a3d8a073dedc6ffffdce57e9d53c956e3c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02a8f9538411afd6d176bf13f0df6a1646fc2e2a3c220cc23563253082dc24b632527c129f3b93878f754a0ab23e9930fddb71f4cce5ccbf4bf24332db55a3d5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.902689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.903065) ========= 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.lHmO4SjB4f/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.fysUw9eeoZ/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005172 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.955214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:21:54.958569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:21:54.958907) ========= ========= Total master_lag: 0.37 =========