builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1475543345.46 results: success (0) buildid: 20161003155858 builduid: 969b9eaeb81d49d3bdb3c2161832dee1 revision: 6414a3001705218a78ca1a24b7ddffd689742ed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.459571) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.460076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.460394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.484106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.484747) ========= 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.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-03 18:09:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.76M=0.001s 2016-10-03 18:09:05 (7.76 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124270 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.636023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.636784) ========= 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.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.021390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.688217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 18:09:05.688641) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6414a3001705218a78ca1a24b7ddffd689742ed3 --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 6414a3001705218a78ca1a24b7ddffd689742ed3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-03 18:09:05,760 truncating revision to first 12 chars 2016-10-03 18:09:05,760 Setting DEBUG logging. 2016-10-03 18:09:05,760 attempt 1/10 2016-10-03 18:09:05,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6414a3001705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 18:09:06,986 unpacking tar archive at: mozilla-aurora-6414a3001705/testing/mozharness/ program finished with exit code 0 elapsedTime=1.490163 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 18:09:07.204748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:07.205581) ========= script_repo_revision: 6414a3001705218a78ca1a24b7ddffd689742ed3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:07.206641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:07.207486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:07.227870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-03 18:09:07.228805) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:07 INFO - MultiFileLogger online at 20161003 18:09:07 in /builds/slave/test 18:09:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:09:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:07 INFO - {'append_to_log': False, 18:09:07 INFO - 'base_work_dir': '/builds/slave/test', 18:09:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:09:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:07 INFO - 'branch': 'Mozilla-Aurora', 18:09:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:07 INFO - 'config_files': ('talos/mac_config.py',), 18:09:07 INFO - 'default_actions': ('clobber', 18:09:07 INFO - 'read-buildbot-config', 18:09:07 INFO - 'download-and-extract', 18:09:07 INFO - 'populate-webroot', 18:09:07 INFO - 'create-virtualenv', 18:09:07 INFO - 'install', 18:09:07 INFO - 'run-tests'), 18:09:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:07 INFO - 'download_minidump_stackwalk': True, 18:09:07 INFO - 'download_symbols': 'ondemand', 18:09:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:07 INFO - 'installer_path': 'installer.exe', 18:09:07 INFO - 'log_level': 'info', 18:09:07 INFO - 'log_name': 'talos', 18:09:07 INFO - 'log_to_console': True, 18:09:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:07 INFO - 'opt_config_files': (), 18:09:07 INFO - 'pip_index': False, 18:09:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:07 INFO - 'cmd': ('bash', 18:09:07 INFO - '-c', 18:09:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:07 INFO - 'enabled': True, 18:09:07 INFO - 'halt_on_failure': False, 18:09:07 INFO - 'name': 'check_screen_resolution'},), 18:09:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:07 INFO - 'cmd': ('bash', 18:09:07 INFO - '-c', 18:09:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:07 INFO - 'enabled': True, 18:09:07 INFO - 'halt_on_failure': False, 18:09:07 INFO - 'name': 'check_screen_resolution'},), 18:09:07 INFO - 'run_cmd_checks_enabled': True, 18:09:07 INFO - 'sps_profile': False, 18:09:07 INFO - 'sps_profile_interval': 0, 18:09:07 INFO - 'suite': 'dromaeojs', 18:09:07 INFO - 'system_bits': '32', 18:09:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:07 INFO - 'title': 't-yosemite-r7-0158', 18:09:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:07 INFO - 'use_talos_json': True, 18:09:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:07 INFO - 'work_dir': 'build'} 18:09:07 INFO - [mozharness: 2016-10-04 01:09:07.421458Z] Running clobber step. 18:09:07 INFO - Running pre-action listener: _resource_record_pre_action 18:09:07 INFO - Running main action method: clobber 18:09:07 INFO - rmtree: /builds/slave/test/build 18:09:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:07 INFO - Running post-action listener: _resource_record_post_action 18:09:07 INFO - [mozharness: 2016-10-04 01:09:07.612242Z] Finished clobber step (success) 18:09:07 INFO - [mozharness: 2016-10-04 01:09:07.612408Z] Running read-buildbot-config step. 18:09:07 INFO - Running pre-action listener: _resource_record_pre_action 18:09:07 INFO - Running main action method: read_buildbot_config 18:09:07 INFO - Using buildbot properties: 18:09:07 INFO - { 18:09:07 INFO - "project": "", 18:09:07 INFO - "product": "firefox", 18:09:07 INFO - "script_repo_revision": "production", 18:09:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 18:09:07 INFO - "repository": "", 18:09:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 18:09:07 INFO - "buildid": "20161003155858", 18:09:07 INFO - "pgo_build": "False", 18:09:07 INFO - "basedir": "/builds/slave/test", 18:09:07 INFO - "buildnumber": 62, 18:09:07 INFO - "slavename": "t-yosemite-r7-0158", 18:09:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:09:07 INFO - "platform": "yosemite_r7", 18:09:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:09:07 INFO - "branch": "mozilla-aurora", 18:09:07 INFO - "repo_path": "releases/mozilla-aurora", 18:09:07 INFO - "revision": "6414a3001705218a78ca1a24b7ddffd689742ed3", 18:09:07 INFO - "stage_platform": "macosx64", 18:09:07 INFO - "builduid": "969b9eaeb81d49d3bdb3c2161832dee1", 18:09:07 INFO - "slavebuilddir": "test" 18:09:07 INFO - } 18:09:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:09:07 INFO - Running post-action listener: _resource_record_post_action 18:09:07 INFO - [mozharness: 2016-10-04 01:09:07.616007Z] Finished read-buildbot-config step (success) 18:09:07 INFO - [mozharness: 2016-10-04 01:09:07.616134Z] Running download-and-extract step. 18:09:07 INFO - Running pre-action listener: _resource_record_pre_action 18:09:07 INFO - Running main action method: download_and_extract 18:09:07 INFO - mkdir: /builds/slave/test/build/tests 18:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:07 INFO - trying https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:08 INFO - Downloaded 1199 bytes. 18:09:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:09:08 INFO - Using the following test package requirements: 18:09:08 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:09:08 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:09:08 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:09:08 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'jsshell-mac.zip'], 18:09:08 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:09:08 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:09:08 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:09:08 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:09:08 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:09:08 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:08 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:09:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:09:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:09:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:09:08 INFO - Expected file size: 16434167 18:09:15 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:09:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:09:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:09:16 INFO - Expected file size: 16434167 18:09:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:09:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:09:22 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:09:23 INFO - Expected file size: 14414059 18:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:23 INFO - trying https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:26 INFO - Downloaded 115268789 bytes. 18:09:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:26 INFO - mkdir: /builds/slave/test/properties 18:09:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:26 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:26 INFO - Contents: 18:09:26 INFO - build_url:https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:27 INFO - Running post-action listener: _resource_record_post_action 18:09:27 INFO - Running post-action listener: set_extra_try_arguments 18:09:27 INFO - [mozharness: 2016-10-04 01:09:27.480958Z] Finished download-and-extract step (success) 18:09:27 INFO - [mozharness: 2016-10-04 01:09:27.481109Z] Running populate-webroot step. 18:09:27 INFO - Running pre-action listener: _resource_record_pre_action 18:09:27 INFO - Running main action method: populate_webroot 18:09:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:27 INFO - '--tppagecycles', 18:09:27 INFO - '7'], 18:09:27 INFO - 'tests': ['tsvgm']}}, 18:09:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['damp', 'tps']}, 18:09:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'tests': ['damp', 'tps']}, 18:09:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['dromaeo_dom']}, 18:09:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['basic_compositor_video']}, 18:09:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:09:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['a11yr', 18:09:27 INFO - 'ts_paint', 18:09:27 INFO - 'tpaint', 18:09:27 INFO - 'sessionrestore', 18:09:27 INFO - 'sessionrestore_no_auto_restore', 18:09:27 INFO - 'tabpaint']}, 18:09:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['tsvgx', 18:09:27 INFO - 'tsvgr_opacity', 18:09:27 INFO - 'tart', 18:09:27 INFO - 'tscrollx', 18:09:27 INFO - 'cart']}, 18:09:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:27 INFO - 'tsvgr_opacity', 18:09:27 INFO - 'tart', 18:09:27 INFO - 'tscrollx', 18:09:27 INFO - 'cart']}, 18:09:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'talos_options': ['--disable-e10s'], 18:09:27 INFO - 'tests': ['tp5o']}, 18:09:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'tests': ['tp5o']}, 18:09:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'talos_options': ['--disable-e10s', 18:09:27 INFO - '--xperf_path', 18:09:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:27 INFO - 'tests': ['tp5n']}, 18:09:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:27 INFO - 'talos_options': ['--xperf_path', 18:09:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:27 INFO - 'tests': ['tp5n']}}, 18:09:27 INFO - 'talos.zip': {'path': '', 18:09:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:27 INFO - Running post-action listener: _resource_record_post_action 18:09:27 INFO - [mozharness: 2016-10-04 01:09:27.500153Z] Finished populate-webroot step (success) 18:09:27 INFO - [mozharness: 2016-10-04 01:09:27.500265Z] Running create-virtualenv step. 18:09:27 INFO - Running pre-action listener: _resource_record_pre_action 18:09:27 INFO - Running main action method: create_virtualenv 18:09:27 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:09:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:27 INFO - Using real prefix '/tools/python27' 18:09:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:31 INFO - Installing pip.................done. 18:09:31 INFO - Return code: 0 18:09:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:31 INFO - 'HOME': '/Users/cltbld', 18:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:31 INFO - 'LOGNAME': 'cltbld', 18:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:31 INFO - 'MOZ_NO_REMOTE': '1', 18:09:31 INFO - 'NO_EM_RESTART': '1', 18:09:31 INFO - 'PAGER': '/bin/cat', 18:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:31 INFO - 'PWD': '/builds/slave/test', 18:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:31 INFO - 'SHELL': '/bin/bash', 18:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:31 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:31 INFO - 'USER': 'cltbld', 18:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:31 INFO - 'XPC_FLAGS': '0x0', 18:09:31 INFO - 'XPC_SERVICE_NAME': '0', 18:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:09:31 INFO - Cleaning up... 18:09:31 INFO - Return code: 0 18:09:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:31 INFO - 'HOME': '/Users/cltbld', 18:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:31 INFO - 'LOGNAME': 'cltbld', 18:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:31 INFO - 'MOZ_NO_REMOTE': '1', 18:09:31 INFO - 'NO_EM_RESTART': '1', 18:09:31 INFO - 'PAGER': '/bin/cat', 18:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:31 INFO - 'PWD': '/builds/slave/test', 18:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:31 INFO - 'SHELL': '/bin/bash', 18:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:31 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:31 INFO - 'USER': 'cltbld', 18:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:31 INFO - 'XPC_FLAGS': '0x0', 18:09:31 INFO - 'XPC_SERVICE_NAME': '0', 18:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:31 INFO - Downloading/unpacking psutil>=3.1.1 18:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:35 INFO - Installing collected packages: psutil 18:09:35 INFO - Running setup.py install for psutil 18:09:35 INFO - building 'psutil._psutil_osx' extension 18:09:35 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 18:09:35 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 18:09:35 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 18:09:35 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 18:09:35 INFO - building 'psutil._psutil_posix' extension 18:09:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:09:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:09:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:09:35 INFO - ^ 18:09:35 INFO - 1 warning generated. 18:09:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:36 INFO - Successfully installed psutil 18:09:36 INFO - Cleaning up... 18:09:36 INFO - Return code: 0 18:09:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:09:36 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')]} 18:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:36 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')]} 18:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:36 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 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:36 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 18:09:36 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 18:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:36 INFO - 'HOME': '/Users/cltbld', 18:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:36 INFO - 'LOGNAME': 'cltbld', 18:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:36 INFO - 'MOZ_NO_REMOTE': '1', 18:09:36 INFO - 'NO_EM_RESTART': '1', 18:09:36 INFO - 'PAGER': '/bin/cat', 18:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:36 INFO - 'PWD': '/builds/slave/test', 18:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:36 INFO - 'SHELL': '/bin/bash', 18:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:36 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:36 INFO - 'USER': 'cltbld', 18:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:36 INFO - 'XPC_FLAGS': '0x0', 18:09:36 INFO - 'XPC_SERVICE_NAME': '0', 18:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:09:38 INFO - Installing collected packages: mozsystemmonitor 18:09:38 INFO - Running setup.py install for mozsystemmonitor 18:09:39 INFO - Successfully installed mozsystemmonitor 18:09:39 INFO - Cleaning up... 18:09:39 INFO - Return code: 0 18:09:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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')]} 18:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09: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==2.5.1'] in /builds/slave/test/build 18:09: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==2.5.1 18:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:39 INFO - 'HOME': '/Users/cltbld', 18:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:39 INFO - 'LOGNAME': 'cltbld', 18:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:39 INFO - 'MOZ_NO_REMOTE': '1', 18:09:39 INFO - 'NO_EM_RESTART': '1', 18:09:39 INFO - 'PAGER': '/bin/cat', 18:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:39 INFO - 'PWD': '/builds/slave/test', 18:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:39 INFO - 'SHELL': '/bin/bash', 18:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:39 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:39 INFO - 'USER': 'cltbld', 18:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:39 INFO - 'XPC_FLAGS': '0x0', 18:09:39 INFO - 'XPC_SERVICE_NAME': '0', 18:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:39 INFO - Downloading/unpacking jsonschema==2.5.1 18:09:39 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 18:09:39 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 18:09:39 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 18:09:39 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 18:09:39 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 18:09:39 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 18:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:09:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 18:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:09:42 INFO - warning: no files found matching '*.txt' 18:09:42 INFO - no previously-included directories found matching 'build' 18:09:42 INFO - no previously-included directories found matching 'dist' 18:09:42 INFO - no previously-included directories found matching '.git*' 18:09:42 INFO - Installing collected packages: jsonschema, functools32 18:09:42 INFO - Running setup.py install for functools32 18:09:42 INFO - warning: no files found matching '*.txt' 18:09:42 INFO - no previously-included directories found matching 'build' 18:09:42 INFO - no previously-included directories found matching 'dist' 18:09:42 INFO - no previously-included directories found matching '.git*' 18:09:42 INFO - Successfully installed jsonschema functools32 18:09:42 INFO - Cleaning up... 18:09:42 INFO - Return code: 0 18:09:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:42 INFO - 'HOME': '/Users/cltbld', 18:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:42 INFO - 'LOGNAME': 'cltbld', 18:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:42 INFO - 'MOZ_NO_REMOTE': '1', 18:09:42 INFO - 'NO_EM_RESTART': '1', 18:09:42 INFO - 'PAGER': '/bin/cat', 18:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:42 INFO - 'PWD': '/builds/slave/test', 18:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:42 INFO - 'SHELL': '/bin/bash', 18:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:42 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:42 INFO - 'USER': 'cltbld', 18:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:42 INFO - 'XPC_FLAGS': '0x0', 18:09:42 INFO - 'XPC_SERVICE_NAME': '0', 18:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:09:42 INFO - Cleaning up... 18:09:42 INFO - Return code: 0 18:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:42 INFO - 'HOME': '/Users/cltbld', 18:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:42 INFO - 'LOGNAME': 'cltbld', 18:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:42 INFO - 'MOZ_NO_REMOTE': '1', 18:09:42 INFO - 'NO_EM_RESTART': '1', 18:09:42 INFO - 'PAGER': '/bin/cat', 18:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:42 INFO - 'PWD': '/builds/slave/test', 18:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:42 INFO - 'SHELL': '/bin/bash', 18:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:42 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:42 INFO - 'USER': 'cltbld', 18:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:42 INFO - 'XPC_FLAGS': '0x0', 18:09:42 INFO - 'XPC_SERVICE_NAME': '0', 18:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:45 INFO - Downloading blobuploader-1.2.4.tar.gz 18:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:09:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:46 INFO - Downloading docopt-0.6.1.tar.gz 18:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:09:46 INFO - Installing collected packages: blobuploader, requests, docopt 18:09:46 INFO - Running setup.py install for blobuploader 18:09:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:09:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:09:46 INFO - Running setup.py install for requests 18:09:47 INFO - Running setup.py install for docopt 18:09:47 INFO - Successfully installed blobuploader requests docopt 18:09:47 INFO - Cleaning up... 18:09:47 INFO - Return code: 0 18:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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')]} 18:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:47 INFO - 'HOME': '/Users/cltbld', 18:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:47 INFO - 'LOGNAME': 'cltbld', 18:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:47 INFO - 'MOZ_NO_REMOTE': '1', 18:09:47 INFO - 'NO_EM_RESTART': '1', 18:09:47 INFO - 'PAGER': '/bin/cat', 18:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:47 INFO - 'PWD': '/builds/slave/test', 18:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:47 INFO - 'SHELL': '/bin/bash', 18:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:47 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:47 INFO - 'USER': 'cltbld', 18:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:47 INFO - 'XPC_FLAGS': '0x0', 18:09:47 INFO - 'XPC_SERVICE_NAME': '0', 18:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-jRQ3RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pXuI6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Tl7fda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-9JbdTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-tJQUBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-gPTWsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-1dtj0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-incqNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-CCqhNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-3Zm5pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:48 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pg1WsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-u9cWW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-4MqiGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-TOpuIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-UWe_43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-SH06BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:49 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-nK2vGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:09:49 INFO - Running setup.py install for manifestparser 18:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:09:49 INFO - Running setup.py install for mozcrash 18:09:50 INFO - Running setup.py install for mozdebug 18:09:50 INFO - Running setup.py install for mozdevice 18:09:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozfile 18:09:50 INFO - Running setup.py install for mozhttpd 18:09:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozinfo 18:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozInstall 18:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozleak 18:09:51 INFO - Running setup.py install for mozlog 18:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for moznetwork 18:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozprocess 18:09:51 INFO - Running setup.py install for mozprofile 18:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozrunner 18:09:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozscreenshot 18:09:52 INFO - Running setup.py install for moztest 18:09:52 INFO - Running setup.py install for mozversion 18:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:09:52 INFO - Cleaning up... 18:09:52 INFO - Return code: 0 18:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:52 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 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:52 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 18:09:52 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 18:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:52 INFO - 'HOME': '/Users/cltbld', 18:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:52 INFO - 'LOGNAME': 'cltbld', 18:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:52 INFO - 'MOZ_NO_REMOTE': '1', 18:09:52 INFO - 'NO_EM_RESTART': '1', 18:09:52 INFO - 'PAGER': '/bin/cat', 18:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:52 INFO - 'PWD': '/builds/slave/test', 18:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:52 INFO - 'SHELL': '/bin/bash', 18:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:52 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:52 INFO - 'USER': 'cltbld', 18:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:52 INFO - 'XPC_FLAGS': '0x0', 18:09:52 INFO - 'XPC_SERVICE_NAME': '0', 18:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:52 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-W0ri8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:52 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Waba27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:52 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-mSiDq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:52 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Wxh6uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-HEkur0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-jECRK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-zLyvr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-jYFCkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-qKzKa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-tKrpqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-JUJ83T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-kRLa2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XjAsdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-b8a9Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Mb9l3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-KF6C4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Hz4QsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:54 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)) 18:09:54 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)) 18:09:54 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)) 18:09:54 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)) 18:09:54 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)) 18:09:54 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)) 18:09:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:56 INFO - Downloading blessings-1.6.tar.gz 18:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:09:56 INFO - Installing collected packages: blessings 18:09:56 INFO - Running setup.py install for blessings 18:09:57 INFO - Successfully installed blessings 18:09:57 INFO - Cleaning up... 18:09:57 INFO - Return code: 0 18:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:57 INFO - Reading from file tmpfile_stdout 18:09:57 INFO - Current package versions: 18:09:57 INFO - blessings == 1.6 18:09:57 INFO - blobuploader == 1.2.4 18:09:57 INFO - docopt == 0.6.1 18:09:57 INFO - functools32 == 3.2.3-2 18:09:57 INFO - jsonschema == 2.5.1 18:09:57 INFO - manifestparser == 1.1 18:09:57 INFO - mozInstall == 1.12 18:09:57 INFO - mozcrash == 0.17 18:09:57 INFO - mozdebug == 0.1 18:09:57 INFO - mozdevice == 0.48 18:09:57 INFO - mozfile == 1.2 18:09:57 INFO - mozhttpd == 0.7 18:09:57 INFO - mozinfo == 0.9 18:09:57 INFO - mozleak == 0.1 18:09:57 INFO - mozlog == 3.4 18:09:57 INFO - moznetwork == 0.27 18:09:57 INFO - mozprocess == 0.23 18:09:57 INFO - mozprofile == 0.28 18:09:57 INFO - mozrunner == 6.12 18:09:57 INFO - mozscreenshot == 0.1 18:09:57 INFO - mozsystemmonitor == 0.3 18:09:57 INFO - moztest == 0.7 18:09:57 INFO - mozversion == 1.4 18:09:57 INFO - psutil == 3.1.1 18:09:57 INFO - requests == 1.2.3 18:09:57 INFO - wsgiref == 0.1.2 18:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:57 INFO - 'HOME': '/Users/cltbld', 18:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:57 INFO - 'LOGNAME': 'cltbld', 18:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:57 INFO - 'MOZ_NO_REMOTE': '1', 18:09:57 INFO - 'NO_EM_RESTART': '1', 18:09:57 INFO - 'PAGER': '/bin/cat', 18:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:57 INFO - 'PWD': '/builds/slave/test', 18:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:57 INFO - 'SHELL': '/bin/bash', 18:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:57 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:57 INFO - 'USER': 'cltbld', 18:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:57 INFO - 'XPC_FLAGS': '0x0', 18:09:57 INFO - 'XPC_SERVICE_NAME': '0', 18:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:09:57 INFO - Cleaning up... 18:09:57 INFO - Return code: 0 18:09:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f88c8b200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, '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.LqCZlPrEVv/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.oIAjVREEkd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:57 INFO - 'HOME': '/Users/cltbld', 18:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:57 INFO - 'LOGNAME': 'cltbld', 18:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:57 INFO - 'MOZ_NO_REMOTE': '1', 18:09:57 INFO - 'NO_EM_RESTART': '1', 18:09:57 INFO - 'PAGER': '/bin/cat', 18:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:57 INFO - 'PWD': '/builds/slave/test', 18:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:57 INFO - 'SHELL': '/bin/bash', 18:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:09:57 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:57 INFO - 'USER': 'cltbld', 18:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:57 INFO - 'XPC_FLAGS': '0x0', 18:09:57 INFO - 'XPC_SERVICE_NAME': '0', 18:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:09:57 INFO - Cleaning up... 18:09:57 INFO - Return code: 0 18:09:57 INFO - Running post-action listener: _resource_record_post_action 18:09:57 INFO - Running post-action listener: _start_resource_monitoring 18:09:58 INFO - Starting resource monitoring. 18:09:58 INFO - [mozharness: 2016-10-04 01:09:58.023230Z] Finished create-virtualenv step (success) 18:09:58 INFO - [mozharness: 2016-10-04 01:09:58.024176Z] Running install step. 18:09:58 INFO - Running pre-action listener: _resource_record_pre_action 18:09:58 INFO - Running main action method: install 18:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:58 INFO - Reading from file tmpfile_stdout 18:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:09:58 INFO - Reading from file tmpfile_stdout 18:09:58 INFO - Output received: 18:09:58 INFO - Usage: mozinstall [options] installer 18:09:58 INFO - Options: 18:09:58 INFO - -h, --help show this help message and exit 18:09:58 INFO - -d DEST, --destination=DEST 18:09:58 INFO - Directory to install application into. [default: 18:09:58 INFO - "/builds/slave/test"] 18:09:58 INFO - --app=APP Application being installed. [default: firefox] 18:09:58 INFO - mkdir: /builds/slave/test/build/application 18:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:10:30 INFO - Reading from file tmpfile_stdout 18:10:30 INFO - Output received: 18:10:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:10:30 INFO - Running post-action listener: _resource_record_post_action 18:10:30 INFO - [mozharness: 2016-10-04 01:10:30.677682Z] Finished install step (success) 18:10:30 INFO - [mozharness: 2016-10-04 01:10:30.677879Z] Running run-tests step. 18:10:30 INFO - Running pre-action listener: _resource_record_pre_action 18:10:30 INFO - Running main action method: run_tests 18:10:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:30 INFO - 2016-10-03 18:10:30.692 screenresolution[3417:61416] starting screenresolution argv=screenresolution get 18:10:30 INFO - 2016-10-03 18:10:30.695 screenresolution[3417:61416] Display 0: 1600x1200x32@60 18:10:30 INFO - 2016-10-03 18:10:30.701 screenresolution[3418:61418] starting screenresolution argv=screenresolution list 18:10:30 INFO - Available Modes on Display 0 18:10:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:30 INFO - Intel Iris: 18:10:30 INFO - Chipset Model: Intel Iris 18:10:30 INFO - Type: GPU 18:10:30 INFO - Bus: Built-In 18:10:30 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:30 INFO - Vendor: Intel (0x8086) 18:10:30 INFO - Device ID: 0x0a2e 18:10:30 INFO - Revision ID: 0x0009 18:10:30 INFO - Displays: 18:10:30 INFO - Display: 18:10:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:30 INFO - Display Serial Number: 1600x1200 60 18:10:30 INFO - Main Display: Yes 18:10:30 INFO - Mirror: Off 18:10:30 INFO - Online: Yes 18:10:30 INFO - Rotation: Supported 18:10:30 INFO - Return code: 0 18:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:10:30 INFO - Python 2.7.3 18:10:30 INFO - Return code: 0 18:10:30 INFO - grabbing minidump binary from tooltool 18:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:30 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 0x107d2bd30>, '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 0x107b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d23b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:10:30 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 18:10:30 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 18:10:30 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 18:10:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:10:31 INFO - Return code: 0 18:10:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:10:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:10:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:10:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:10:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LqCZlPrEVv/Render', 18:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:31 INFO - 'HOME': '/Users/cltbld', 18:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:31 INFO - 'LOGNAME': 'cltbld', 18:10:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:10:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:31 INFO - 'MOZ_NO_REMOTE': '1', 18:10:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:10:31 INFO - 'NO_EM_RESTART': '1', 18:10:31 INFO - 'PAGER': '/bin/cat', 18:10:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:31 INFO - 'PWD': '/builds/slave/test', 18:10:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:31 INFO - 'SHELL': '/bin/bash', 18:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIAjVREEkd/Listeners', 18:10:31 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:31 INFO - 'USER': 'cltbld', 18:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:31 INFO - 'XPC_FLAGS': '0x0', 18:10:31 INFO - 'XPC_SERVICE_NAME': '0', 18:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:10:31 INFO - mozversion application_buildid: 20161003155858 18:10:31 INFO - mozversion application_changeset: 6414a3001705218a78ca1a24b7ddffd689742ed3 18:10:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:10:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:10:31 INFO - mozversion application_name: Firefox 18:10:31 INFO - mozversion application_remotingname: firefox-dev 18:10:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:31 INFO - mozversion application_vendor: Mozilla 18:10:31 INFO - mozversion application_version: 51.0a2 18:10:31 INFO - mozversion platform_buildid: 20161003155858 18:10:31 INFO - mozversion platform_changeset: 6414a3001705218a78ca1a24b7ddffd689742ed3 18:10:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:31 INFO - mozversion platform_version: 51.0a2 18:10:31 INFO - using testdate: 1475543431 18:10:31 INFO - actual date: 1475543431 18:10:31 INFO - starting webserver on 'localhost:59308' 18:10:31 INFO - SUITE-START | Running 2 tests 18:10:31 INFO - TEST-START | dromaeo_css 18:10:31 INFO - operating with platform_type : mac_ 18:10:31 INFO - Initialising browser for dromaeo_css test... 18:10:31 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpeaDnyl/profile http://localhost:59308/getInfo.html) 18:10:33 INFO - PROCESS | 3428 | __metrics Screen width/height:1600/1200 18:10:33 INFO - PROCESS | 3428 | colorDepth:24 18:10:33 INFO - PROCESS | 3428 | Browser inner width/height: 1024/689 18:10:33 INFO - PROCESS | 3428 | __metrics 18:10:33 INFO - PROCESS | 3428 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:10:33 INFO - PROCESS | 3428 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:34 INFO - TEST-INFO | 3428: exit 0 18:10:34 INFO - Browser initialized. 18:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:34 INFO - TEST-INFO | started process 3430 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpeaDnyl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:46 INFO - PROCESS | 3430 | RSS: Main: 219496448 18:10:46 INFO - PROCESS | 3430 | 18:11:37 INFO - PROCESS | 3430 | 1475543497702 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] 18:13:49 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59308/tests/dromaeo/cssquery-ext.html) 18:13:51 INFO - PROCESS | 3430 | RSS: Main: 339914752 18:13:51 INFO - PROCESS | 3430 | 18:16:54 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-ext.html (next: http://localhost:59308/tests/dromaeo/cssquery-jquery.html) 18:16:54 INFO - PROCESS | 3430 | RSS: Main: 351154176 18:16:54 INFO - PROCESS | 3430 | 18:19:57 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59308/tests/dromaeo/cssquery-mootools.html) 18:19:57 INFO - PROCESS | 3430 | RSS: Main: 322584576 18:19:57 INFO - PROCESS | 3430 | 18:23:00 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59308/tests/dromaeo/cssquery-prototype.html) 18:23:00 INFO - PROCESS | 3430 | RSS: Main: 314486784 18:23:00 INFO - PROCESS | 3430 | 18:26:04 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59308/tests/dromaeo/cssquery-yui.html) 18:26:04 INFO - PROCESS | 3430 | RSS: Main: 310710272 18:26:04 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:59308/tests/dromaeo/cssquery-yui.html (next: http://localhost:59308/tests/dromaeo/cssquery-dojo.html) 18:29:08 INFO - PROCESS | 3430 | RSS: Main: 363806720 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | __start_tp_report 18:29:08 INFO - PROCESS | 3430 | _x_x_mozilla_page_load 18:29:08 INFO - PROCESS | 3430 | _x_x_mozilla_page_load_details 18:29:08 INFO - PROCESS | 3430 | |i|pagename|runs| 18:29:08 INFO - PROCESS | 3430 | |0;dojo.html;3245.9026229213123;3255.9674403255967;3289.3750187464366;3293.7035666789984;3340.4321265384883;5607.102863541834;5625.774969001245;5634.464725851043;5655.519280861132;5671.2060311556415;5106.540411362977;5305.575553955684;5578.581606379527;5664.490195882369;5673.773049078032;5134.409542902558;5141.768620412072;5160.329157209558;5206.921896171561;5224.92162617561;5103.897922041557;5113.054084994288;5225.320708307933;5232.16285394337;5235.240890070937;5133.948660513403;5134.794608215667;5182.170852663575;5189;5190.7664155112925;5188.299579556749;5201.635885488017;5205.6876587404495;5229.398619158807;5241.475852414766;5136.899464533414;5162.767675454614;5196.038732834438;5203.60972927032;5217.843464696065;4930.408350997867;5517.917231241535;5542.279503664538;5543.279373681396;5571.916421253684;4963.379577552806;4964.354633897607;6014.609050411753;6084.634921904656;6111.633302001894;6164.260288765332;6231.532635052389;6237.220347456568;6260.530460215502;6260.749570017194;5571.247881536022;5623.634463759842;5625.662460252398;5691.3170419549915;5699.430056994309;6183.907241391383;6200.348963358872;6202.56582039262;6209.410106039919;6232.220972378453;6090.512758979271;6094.634321940698;6104.328523862371;6109.297430795426;6122.785702500391;6029.939700603026;6039.698015099228;6048.183495228176;6212.0371342441995;6238.875222495615;5993.9810232260625;6054;6082.996305609613;6125.295591007091;6136.263648362135;6181.381861813873;6192.721327540272;6205.6586887720705;6216.937830621727;6219.657918814418;4861.927071093936;4878.146324393217;4893.996730670204;4914.189158788759;4933.629977751683;4306.332518459643;4326.783660816946;4351.760653164107;4429.379886815848;4435.911281774411;5652.74562644682;5654.46282603152;5657.321121465368;5662.57530685192;5682;5974.551908606872;6030.517558595302;6032.607880487754;6100.969495152496;6103.633781973096;5556.444355564411;5585.636933599303;5596.384397716248;5619.831405057855;5622.24099746529;5261.237120617489;5263.578913686896;5267.789288428497;5273.762680679379;5319.893602128013;6266.717997690206;6285.088662144055;6304.117423560705;6309.779157729457;6314.842128946813;6237.5321850860455;6242.344553821965;6244.843878903063;6257.4681152102585;6257.561970662192;6257.311695713559;6301;6303.936960630518;6309.085182648582;6309.4952403806665;5950.137230101697;6001.849953751192;6097.390260973867;6106.45041946227;6121.540884433596;4637.443506779208;6114.510839132948;6128.717018009172;6134.773364742421;6208.875822483616;4984.576311013604;5976.731047102804;5983.970080149571;6004.699765011645;6020.367861374668;4635.884102897455;5927.644341339534;5933.762649494144;5934.258217722785;6003.429674180946;5700.486956173964;5725.627834190765;5734.569907256889;5765.423457654201;5830.008898487352;4986.775595098156;6001.489873360813;6017.18767966319;6047.485963693135;6054.8183554493435;5829;5829.271341082364;5832;5848.795292164754;5875.764969401347 18:29:08 INFO - PROCESS | 3430 | |1;ext.html;467.819889342603;504.5484291559054;507.9561501115208;513.5147285814907;527.604296777417;24114;32492.837535812316;40312;41253.79373103138;41323.79338103313;42638.786806065924;42991.35512967308;43007.139857202914;43140.35289470661;43182.704518864404;9807.656732014399;9992.500374981259;9994.15049720771;9994.850077248848;9995.2003839693;8770.56147192641;8987.415817971843;9839.409635421898;9965.551550180224;12244.95917846984;12225.816612750816;12238.694032649211;12266.386680665975;12266.632001039983;12296.262224266527;12199.634010979686;12263.448144833415;12286.631401057983;12294.20087694297;12327.93836030814;8709.25971292441;8952.776180595472;11745.706357341049;11953.52185912571;11999.280043197436;40014.39978400326;40352.79823600863;40479.79760101181;40500.18999619991;40518.79740601307;3200.4463885374016;3270.3459308138467;3328.7170590499595;3351.329734053175;3372.0726800129914;23074.423139421648;23406.64890026651;29985.850070749508;31057.912973046063;31120.844395778102;2493.8379005364595;3209.7753157279;3278.8032718036993;3303.207230264743;3352.2122301259183;364249;366087.9999999973;368237;368986;370022;49487;59548;59941;60155.39844601585;60370.79258414895;63544;63577.68211158914;63635;63655.68172159109;63677;16314.918425407797;16860.74708879368;16883.15584220784;16887.662246754997;16900.492985210465;11736.178467507363;13115.409806558728;13188.736225275441;13208.207507549578;13212.669683257995;13198.340082995812;14616.707665846623;14766.852331476548;16299.59251018734;16505.17474126289;5157.355330583677;6014.8195554133445;6037.366076561898;6132.724027418777;6152.938470615237;840.7267638017669;856.7643897927995;931.2736065868634;985.2167526816198;1025.7640742629237;29064.564031539543;30017.849910750305;30158.396832063238;30747.69252307493;30796.538051929238;919.2691810010923;939.234523863063;959.2757468111671;991.861139440479;1039.033698660238;13485.865141348657;15107.169105699073;15686.058836469849;16649.25078371476;16905.83094169067;673191;677132;678141;680595;683615;57869;58280.41719582835;58404.707976459846;58418.41581584215;58486.41513584895;1188.2810899405736;1232.1067226261068;1252.0234217310694;1351.0610125962558;1374.9931250343684;28790;29754.8512257446;30324;30452.695473044987;30845.691543084282;49446.50553494563;49939.250911235635;50029.74985125051;50065;50295.49704502908;411479;411843;411994;413431;414232;24342.63486047746;25826.225213243633;26408.471830563667;26475.867620662542;27593.724062759116;46671.29993050175;47530.52469475261;47729.522704772506;47937.760311198224;48113;37943;38131;38879.80560097181;39015.60984390233;40440;30234.54648180235;38912.61087389203;39176.80411597924;39298.2140357197;40411.393829092;38036;38447.80776096102;38574.42138367871;38665.03337416587;38855.41716874306;26414.811333490423;32302.955172551723;32355.867544636767;32890;32934.01197964065;25430.745692543576;25533.616995744705;25683.486330273663;25961.610575841754;26213.73786262113 18:29:08 INFO - PROCESS | 3430 | |2;jquery.html;313.89798315547444;356.4510653593466;371.7323527060517;378.3246904275868;406.2383031815346;15145.621359466018;15209.923950380247;16212.432564860232;19671.803281967175;21238.36284911455;19985.60028799423;20485;20972.475688107806;21195.57608847822;21439.67840482394;4823.228283474645;5984.251968503937;6068.362821903681;6255.906161407583;6277.121203031556;5866.618669786471;6162.815115546541;6248.218972628421;6248.500119990413;6250.687465626723;5798.623089499169;6008.158857759917;6209.410106039919;6219.689015549227;6227.782027629034;6063.999999999978;6120.632762034292;6128.295246046672;6135.079738039285;6151.046587778901;5062.139436295838;5247.553957913582;5300;5302.045631786277;5314.5748340132695;25369.74630253692;25421.618675719878;25634;25745.227643170736;25933.092341768137;2182.912683492674;2283.178055899875;2335.9299221023225;2345.4839935214227;3086.719011610179;15537.990030648085;15703.842961570352;15744.68510629781;16391.852570320083;16526.256318465577;1794.5782741055841;1930.1893204853995;1941.3302410668298;1942.9028548572514;1945.2219112355172;123774;127928;128993.35503322518;129176;134921.65078349286;8639.438436501607;10774.353538787698;11115.722106947229;11164.274322169033;11394.772104558027;13963.301834908214;13976.161430314214;13988.72022559543;13999.580012599637;14001.649958751113;8570.571471426403;8765.298776097898;8828.969337052515;8954.015058343577;8966.820663586692;7424.997625320512;8681.696140635047;8755.693550725695;8815;8867.068957759471;6498.3826536478955;6539.161752483522;6647.767328143492;6648.601083934979;6668.399844014062;1792.5339411752777;1798.14588070668;1800.4433704140151;1805.7562229099167;1846.9353572624893;907.5326207003399;923.2244914272044;926.8192702422963;937.8358787212211;964.7925695975399;21126.577468450545;22743.31770046901;22941.770582293964;22948;23028.884855575616;838.828040251747;973.3624475968111;996.7358649957768;997.2969056814928;997.5361456922566;11144.832827507595;11383.26659810078;11672.299662020307;11717.355545445082;11755.941220293844;631800;632340;640119;644283;644635;87846.10407386234;89784;92084;115721;117843;922.3820040572832;942.7595963029383;1003.267614641316;1003.4982508745627;1004.0862814838462;19798;19931.202751889763;20460.65661277238;20809.791902080786;21380.893095534422;57276.71361643332;57357;57703.711481442326;59890.40109599022;61430.77138457295;78600;78813.817792732;80971.07397053877;82077.58961205155;83717;7225.952236925721;7380.741674041383;7404.148522919718;7677.500962437423;8358.874616880874;10930.781384372427;12748.553800616934;12953.611391658265;13111.868881311064;13176;10943.343399396063;11066.889331106586;11085.833712494481;11254.324740515267;11434.828477572677;8892.33307501953;10707.57169713234;11095.944520277348;11116.49975751077;11265.26775759573;11058;11128.833067503832;11518.769624607294;11558.30650160993;11673;6084.908726369196;7110.146782386147;7403.296686814744;7476.476646634684;7529.849403012018;9061.77345566366;10842.945785271024;10943.343399396063;11105.888941110808;11295.757466678822 18:29:08 INFO - PROCESS | 3430 | |3;mootools.html;1389.9305034748263;1440.4454285100237;1663.3263528271048;1863.1895125620347;1887.4432042547446;8511.276541493973;9001.90998090019;9019.060901906088;9025.864612030824;9048;7491.775246742606;8263.33893288537;8473.87289190661;8498;8876.156765107304;2414.553307638084;2459.8524088554655;2461.6676748638884;2464.29767516257;2467.592847180213;2396.9050627000074;2463.5935070713313;2469.925902222936;2470.110760126353;2474.072222916406;2443.8044956403446;2455.312512496504;2474.6164344526537;2475.245050259679;2477.343503971449;2421.043687743349;2434.525267572824;2442.670239517669;2450.816188785848;2452.9754702452924;2420.189236605739;2439.731629520769;2440.7437219092094;2445.6942882139733;2452.7179374372;7878.80302992424;9204.033576474441;9208.401453905475;9286.582103805345;9324.766880827965;4498.460184777848;5541.168824676331;5542.501174894239;5549.556035517149;5553.555715542747;3497.4928635347733;3629.2015756533783;3694.039549717093;3760.623937606245;3764.0589852536864;1051.0750539525245;1069.4492336446735;1076.43487169236;1099.1811100729929;1103.431732657682;12524.561640342636;12552.560660376843;12557.811632825515;12560.057995650272;12582.685432864251;4799.088173247072;4811;4875.68308059975;5006.774695138727;5024.62315326352;10450.738731531772;10461.790764184674;10468.895311046792;10472.73818154537;10494.895051049545;5482.424345443751;5554.166874968787;5565.9443405566235;5585.218069470277;5594.384617692051;4221.345691417835;4524.16302983949;4683.906321873544;4739.123262196505;5088.084144853888;3706.425504046877;3885.1452680410266;4001.7598944062865;4016.979915100464;4152.647025002909;1296.9610911672664;1306.6667999660026;1306.9281189534477;1315.967100822487;1319.459021801057;808.3775492870457;842.6460886427715;850.451458809077;868.9963092628025;870.4516154822421;5494.450554944474;6053.152558641794;6090.451859332681;6147.508199344042;6188.4739797117745;797.2306724011357;935.9251259899328;952.9237660987104;971.7424882406168;989.0999190736395;3258.2668899497426;3439.6216416194197;4072.429859819628;4137.234611596804;4173.269677806372;11020.559177632966;11261.831072533918;11377.975982161644;11378.43107844621;11403.657890263305;10689.786204275872;11120.165987550805;11143.275687080313;11304.626028533936;11377.601783937687;8394.118617545191;8588.26999705032;8617.396782225309;8631.56842157902;8653.43752656088;5143.537081662668;5460.808871689472;5706.8586282744445;6030.547708921936;6329.082283069021;10197.59209631636;10258.230632702427;10504.054635082879;10620.681379558626;10654.946725266635;10381.636642717469;10765;10777.299475534066;10832.458377081271;10948.56205751793;7230.9638451807405;7468.925310746823;7631.69473221065;7826.960865195638;7998.760037198894;8594.05465398793;8746.431481953652;8799.604017819085;8809;8826.073262307365;7648;7729.845403092019;7786;7893.407994400328;7916.050073991158;7482.513636613603;7605.771826845204;7606.20134885829;7612.3148916597775;7665.616719163908;7201.675924583302;7260.745873894389;7264.818379540554;7271.054762881004;7291.30732580404;4919.458859525378;4969.801207951641;4983.27742477346;5101.158308878993;5275.815346462856;5108.872278193075;5138.511841375063;5174.7930082797775;5183.222516622386;5248 18:29:08 INFO - PROCESS | 3430 | |4;prototype.html;270.7630823029849;313.94349017176904;313.96548373110596;319.7394123789112;321.67671490152424;5350.304460420145;5405.5135037846585;5408.729563521828;5431.782728690852;5466.098093814521;5393.83818485445;5408.593176036666;5448.003598021082;5448.7548060337285;5450.247624949405;3921.411788231767;3964.7621142731527;4089.5054017049574;4092.7135100542823;4196.244361296638;3431.656834316573;3474.322507111114;4094.5905409459115;4135.60711732385;4144.171165766844;3376.96623033769;4096.344584866422;4119.299719047769;4134.400511925769;4138.2758017347;3840.2511510255513;4065.004074001859;4106.917861642765;4144.730592511477;4161.250974824516;3581;3584.444411116281;3587.5336206293277;3589.94615080774;3595.9101022474388;4649.418822647169;5275.525202731773;5293.311869456946;5350.625456218067;5353.812616558441;3925.234579257046;3947;4450.866474005785;4653.488116307203;4679.953200467986;5123.053239768864;5510.90585577482;5587.552995760329;5645.266115405012;5685.602007859451;3849.480320156771;3862.0069446179155;3864.265789499986;3865.6520913117956;3866.7486613370043;4982.427020892644;5661.1508273758855;5939.198208241875;5980.581359304851;6009.278886533601;3261.967380326166;3319.253168037172;3532.91167720809;3936.527616686016;3946.309395855714;3865.8453661853773;4042.636162745367;4052.7973601320405;4053.0677944073027;4069.2268468990796;4260.978695106566;4530.365748795171;4534.433195850519;4660.603848672901;4675.275332323496;4775.976120119377;4905.9264111038365;5270;5306.177542480922;5764.625299355613;1113.3932007056012;1333.706584551397;1339.4776037345443;1359.0215045167463;1370.6847425092285;788.9881651775228;812.7970603506843;833.7248707926369;836.3434703757642;845.4969293270494;5228.712420816892;5241.895162096736;5372.7313634318125;5450.3732070811575;5498.697571633598;4821.927671084936;5372.785088596413;5387.922415516912;5880.647161170344;5900.114982752536;5086.898262034739;5385.3268341457315;5394.029074766501;5456.508914197741;5525.723713814293;2337.5324935013064;3044.2998110434723;3055.1363668162403;3055.618047744032;3069.1559821048945;5241.318628578337;5353.9732301338245;5991.820245392645;5995.781560822524;6025.9096113558335;5423.891522169534;5523.934216509876;5610.859728506738;5781.53747700183;5893.764249430061;5992.820215393545;5992.850178745479;6001.4298641628975;6026.698665066817;6064.757409703562;4877.804887804448;4897.579701886555;4953.984433191259;5058.939341698219;5302;4450.554944505653;4561.749103799323;5665.801696940752;5745.511631511368;5771.769129234784;5657.2928383952;5971.7611295547695;5990.400959903975;6016.639001659914;6029;3370.7865168539797;3494.336076145524;3514.789112653249;4030.6372426481757;4039.3133167362207;4552.749598771967;5698.230738850202;5720.427957204412;5772.6536407815665;5773.884522309614;5028.843366025908;5451.373092094302;5529.612927095226;5560.443955604407;5626.831195064155;5218.869528261824;5267.762950667153;5558.861028474321;5566;5574.832755017356;5418.268533747893;5428.83713488596;5462.91805622908;5466.34403871538;5470.617056806144;5440.708371435225;5449.809256675997;5620.690862002629;5647.334036459337;5717.599768016199;5086.21163719624;5472.863178420572;5499.532539734168;5531.446855314436;5566.888662226814 18:29:08 INFO - PROCESS | 3430 | |5;yui.html;699.7096205074894;750.523417629805;754.3361841579409;789.0728394136895;796.5750257320585;16717.74923376149;17094.743578846326;17104.48686539403;17119.743203851936;17133.742993855103;16320.591985200346;16506.66986660266;16525.173741312916;16537.83462165381;16633.334666613322;669.0699927101333;684.096991970599;684.6953105867891;824.86802111662;850.5407080176728;822.56404105824;837.351052933975;855.9828803423928;858.3004851046409;858.5750053723384;896.8027034052498;898.1108702384657;900.5767289374016;901.2879824938291;901.3059943843236;700.9439244860399;720.4920531025614;893.8167675626481;894.0790985285166;894.8612964990405;538.1604696673203;538.442711793292;540.8134193703166;637.7640273098937;652.6051738698067;15384.999975001589;15436.768448473282;15462.149581772997;15478.845211547965;15479.535613931488;10075.748106297327;13524.120932139478;13842.9617778667;14177.43290268388;14259.78610320846;11576;11903.226290291102;11947.820782688266;12562.30907300098;12953.222806631633;3791.545014598238;3827.540695116576;3843.865464708722;3883.5533913599734;3930.977945734101;87966;90421.54789226077;91434.5428272861;97885;110187.89812101937;9040.819183616422;10634.680959571226;10660.786784264272;10785.56857725698;11014.669559913216;21017.42369322307;21726.891365543386;21740.130394784348;21742.021609027634;21782.45543861416;8063.758087257392;8079.959600201962;8104;8160.187335040048;8195.83608327842;4326.935095973563;4376.256036473807;4528.773561321987;4569.246074397754;4638.257878739453;3636.072801435617;3742.7380083394446;3784.375578029649;3792.488014118059;3797.715171362159;680.3196803196803;682.8190529509684;688.1466980943594;689.675852349395;705.9974835733271;577.5120023580068;618.9876202476015;645.7238235220884;660.2341284110408;668.7659319238325;8836.293096552261;9207.447553146832;9616.23070154386;9686.806263874683;9738.269629777795;571.4970825673464;576.7519966414482;631.3686313686313;653.4347789162435;673.3031312591543;3762.6613604775703;4687.835925742651;4698;4703.576678098919;4723.881902952385;110711;120607;161009;163425;165715.1714241421;135181;139481.30259348638;140754;141271.29364353113;141315;115102;118403;118584.22123668152;118594.40702796604;120543.19185212404;8893.199612034949;9094.090590940854;9140.771480713036;9175.174234318943;9363.344565880323;66093;66339;66475.00287495594;66775.66612166908;70197;47491;71201;81860.59069704614;88656.11343886479;92736.53631731798;12803.679908002374;12848;13239.933800330937;13369.26469044212;14272.000959932706;14738.11571305725;14769.335379907716;15092.924535377253;15529.68940621204;15955.441559545361;13248.536301229411;13429.26139062361;13694.52069177574;13971.301434928417;14164.504242351468;13835.308234588432;13843.584692459242;14075.577732668036;14211.857881421054;14826.555203343916;13433.731325373243;13492.865071349554;13741.106828056145;13748.175109493463;14339.569812905629;11162.330260184415;11280.605178818701;11616.651500455;11662.53349865996;11998.58004969822;11546.769064618493;11568;11648.592299269485;11772.352520611448;11833.526658933546 18:29:08 INFO - PROCESS | 3430 | __end_tp_report 18:29:08 INFO - PROCESS | 3430 | __start_cc_report 18:29:08 INFO - PROCESS | 3430 | _x_x_mozilla_cycle_collect,1673 18:29:08 INFO - PROCESS | 3430 | __end_cc_report 18:29:08 INFO - PROCESS | 3430 | __startTimestamp1475544548260__endTimestamp 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | ------- Summary: start ------- 18:29:08 INFO - PROCESS | 3430 | Number of tests: 6 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#0] dojo.html Cycles:165 Average:5618.88 Median:5725.63 stddev:646.74 (11.3%) stddev-sans-first:621.36 18:29:08 INFO - PROCESS | 3430 | Values: 3245.9 3256.0 3289.4 3293.7 3340.4 5607.1 5625.8 5634.5 5655.5 5671.2 5106.5 5305.6 5578.6 5664.5 5673.8 5134.4 5141.8 5160.3 5206.9 5224.9 5103.9 5113.1 5225.3 5232.2 5235.2 5133.9 5134.8 5182.2 5189.0 5190.8 5188.3 5201.6 5205.7 5229.4 5241.5 5136.9 5162.8 5196.0 5203.6 5217.8 4930.4 5517.9 5542.3 5543.3 5571.9 4963.4 4964.4 6014.6 6084.6 6111.6 6164.3 6231.5 6237.2 6260.5 6260.7 5571.2 5623.6 5625.7 5691.3 5699.4 6183.9 6200.3 6202.6 6209.4 6232.2 6090.5 6094.6 6104.3 6109.3 6122.8 6029.9 6039.7 6048.2 6212.0 6238.9 5994.0 6054.0 6083.0 6125.3 6136.3 6181.4 6192.7 6205.7 6216.9 6219.7 4861.9 4878.1 4894.0 4914.2 4933.6 4306.3 4326.8 4351.8 4429.4 4435.9 5652.7 5654.5 5657.3 5662.6 5682.0 5974.6 6030.5 6032.6 6101.0 6103.6 5556.4 5585.6 5596.4 5619.8 5622.2 5261.2 5263.6 5267.8 5273.8 5319.9 6266.7 6285.1 6304.1 6309.8 6314.8 6237.5 6242.3 6244.8 6257.5 6257.6 6257.3 6301.0 6303.9 6309.1 6309.5 5950.1 6001.8 6097.4 6106.5 6121.5 4637.4 6114.5 6128.7 6134.8 6208.9 4984.6 5976.7 5984.0 6004.7 6020.4 4635.9 5927.6 5933.8 5934.3 6003.4 5700.5 5725.6 5734.6 5765.4 5830.0 4986.8 6001.5 6017.2 6047.5 6054.8 5829.0 5829.3 5832.0 5848.8 5875.8 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#1] ext.html Cycles:180 Average:63136.48 Median:38083.50 stddev:135115.42 (354.8%) stddev-sans-first:135412.52 18:29:08 INFO - PROCESS | 3430 | Values: 467.8 504.5 508.0 513.5 527.6 24114.0 32492.8 40312.0 41253.8 41323.8 42638.8 42991.4 43007.1 43140.4 43182.7 9807.7 9992.5 9994.2 9994.9 9995.2 8770.6 8987.4 9839.4 9965.6 12245.0 12225.8 12238.7 12266.4 12266.6 12296.3 12199.6 12263.4 12286.6 12294.2 12327.9 8709.3 8952.8 11745.7 11953.5 11999.3 40014.4 40352.8 40479.8 40500.2 40518.8 3200.4 3270.3 3328.7 3351.3 3372.1 23074.4 23406.6 29985.9 31057.9 31120.8 2493.8 3209.8 3278.8 3303.2 3352.2 364249.0 366088.0 368237.0 368986.0 370022.0 49487.0 59548.0 59941.0 60155.4 60370.8 63544.0 63577.7 63635.0 63655.7 63677.0 16314.9 16860.7 16883.2 16887.7 16900.5 11736.2 13115.4 13188.7 13208.2 13212.7 13198.3 14616.7 14766.9 16299.6 16505.2 5157.4 6014.8 6037.4 6132.7 6152.9 840.7 856.8 931.3 985.2 1025.8 29064.6 30017.8 30158.4 30747.7 30796.5 919.3 939.2 959.3 991.9 1039.0 13485.9 15107.2 15686.1 16649.3 16905.8 673191.0 677132.0 678141.0 680595.0 683615.0 57869.0 58280.4 58404.7 58418.4 58486.4 1188.3 1232.1 1252.0 1351.1 1375.0 28790.0 29754.9 30324.0 30452.7 30845.7 49446.5 49939.3 50029.7 50065.0 50295.5 411479.0 411843.0 411994.0 413431.0 414232.0 24342.6 25826.2 26408.5 26475.9 27593.7 46671.3 47530.5 47729.5 47937.8 48113.0 37943.0 38131.0 38879.8 39015.6 40440.0 30234.5 38912.6 39176.8 39298.2 40411.4 38036.0 38447.8 38574.4 38665.0 38855.4 26414.8 32303.0 32355.9 32890.0 32934.0 25430.7 25533.6 25683.5 25961.6 26213.7 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#2] jquery.html Cycles:180 Average:36134.67 Median:14509.91 stddev:105965.30 (730.3%) stddev-sans-first:106228.42 18:29:08 INFO - PROCESS | 3430 | Values: 313.9 356.5 371.7 378.3 406.2 15145.6 15209.9 16212.4 19671.8 21238.4 19985.6 20485.0 20972.5 21195.6 21439.7 4823.2 5984.3 6068.4 6255.9 6277.1 5866.6 6162.8 6248.2 6248.5 6250.7 5798.6 6008.2 6209.4 6219.7 6227.8 6064.0 6120.6 6128.3 6135.1 6151.0 5062.1 5247.6 5300.0 5302.0 5314.6 25369.7 25421.6 25634.0 25745.2 25933.1 2182.9 2283.2 2335.9 2345.5 3086.7 15538.0 15703.8 15744.7 16391.9 16526.3 1794.6 1930.2 1941.3 1942.9 1945.2 123774.0 127928.0 128993.4 129176.0 134921.7 8639.4 10774.4 11115.7 11164.3 11394.8 13963.3 13976.2 13988.7 13999.6 14001.6 8570.6 8765.3 8829.0 8954.0 8966.8 7425.0 8681.7 8755.7 8815.0 8867.1 6498.4 6539.2 6647.8 6648.6 6668.4 1792.5 1798.1 1800.4 1805.8 1846.9 907.5 923.2 926.8 937.8 964.8 21126.6 22743.3 22941.8 22948.0 23028.9 838.8 973.4 996.7 997.3 997.5 11144.8 11383.3 11672.3 11717.4 11755.9 631800.0 632340.0 640119.0 644283.0 644635.0 87846.1 89784.0 92084.0 115721.0 117843.0 922.4 942.8 1003.3 1003.5 1004.1 19798.0 19931.2 20460.7 20809.8 21380.9 57276.7 57357.0 57703.7 59890.4 61430.8 78600.0 78813.8 80971.1 82077.6 83717.0 7226.0 7380.7 7404.1 7677.5 8358.9 10930.8 12748.6 12953.6 13111.9 13176.0 10943.3 11066.9 11085.8 11254.3 11434.8 8892.3 10707.6 11095.9 11116.5 11265.3 11058.0 11128.8 11518.8 11558.3 11673.0 6084.9 7110.1 7403.3 7476.5 7529.8 9061.8 10842.9 10943.3 11105.9 11295.8 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#3] mootools.html Cycles:180 Average:5899.09 Median:4805.04 stddev:3375.05 (70.2%) stddev-sans-first:3367.50 18:29:08 INFO - PROCESS | 3430 | Values: 1389.9 1440.4 1663.3 1863.2 1887.4 8511.3 9001.9 9019.1 9025.9 9048.0 7491.8 8263.3 8473.9 8498.0 8876.2 2414.6 2459.9 2461.7 2464.3 2467.6 2396.9 2463.6 2469.9 2470.1 2474.1 2443.8 2455.3 2474.6 2475.2 2477.3 2421.0 2434.5 2442.7 2450.8 2453.0 2420.2 2439.7 2440.7 2445.7 2452.7 7878.8 9204.0 9208.4 9286.6 9324.8 4498.5 5541.2 5542.5 5549.6 5553.6 3497.5 3629.2 3694.0 3760.6 3764.1 1051.1 1069.4 1076.4 1099.2 1103.4 12524.6 12552.6 12557.8 12560.1 12582.7 4799.1 4811.0 4875.7 5006.8 5024.6 10450.7 10461.8 10468.9 10472.7 10494.9 5482.4 5554.2 5565.9 5585.2 5594.4 4221.3 4524.2 4683.9 4739.1 5088.1 3706.4 3885.1 4001.8 4017.0 4152.6 1297.0 1306.7 1306.9 1316.0 1319.5 808.4 842.6 850.5 869.0 870.5 5494.5 6053.2 6090.5 6147.5 6188.5 797.2 935.9 952.9 971.7 989.1 3258.3 3439.6 4072.4 4137.2 4173.3 11020.6 11261.8 11378.0 11378.4 11403.7 10689.8 11120.2 11143.3 11304.6 11377.6 8394.1 8588.3 8617.4 8631.6 8653.4 5143.5 5460.8 5706.9 6030.5 6329.1 10197.6 10258.2 10504.1 10620.7 10654.9 10381.6 10765.0 10777.3 10832.5 10948.6 7231.0 7468.9 7631.7 7827.0 7998.8 8594.1 8746.4 8799.6 8809.0 8826.1 7648.0 7729.8 7786.0 7893.4 7916.1 7482.5 7605.8 7606.2 7612.3 7665.6 7201.7 7260.7 7264.8 7271.1 7291.3 4919.5 4969.8 4983.3 5101.2 5275.8 5108.9 5138.5 5174.8 5183.2 5248.0 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#4] prototype.html Cycles:180 Average:4555.00 Median:5268.88 stddev:1409.58 (26.8%) stddev-sans-first:1376.36 18:29:08 INFO - PROCESS | 3430 | Values: 270.8 313.9 314.0 319.7 321.7 5350.3 5405.5 5408.7 5431.8 5466.1 5393.8 5408.6 5448.0 5448.8 5450.2 3921.4 3964.8 4089.5 4092.7 4196.2 3431.7 3474.3 4094.6 4135.6 4144.2 3377.0 4096.3 4119.3 4134.4 4138.3 3840.3 4065.0 4106.9 4144.7 4161.3 3581.0 3584.4 3587.5 3589.9 3595.9 4649.4 5275.5 5293.3 5350.6 5353.8 3925.2 3947.0 4450.9 4653.5 4680.0 5123.1 5510.9 5587.6 5645.3 5685.6 3849.5 3862.0 3864.3 3865.7 3866.7 4982.4 5661.2 5939.2 5980.6 6009.3 3262.0 3319.3 3532.9 3936.5 3946.3 3865.8 4042.6 4052.8 4053.1 4069.2 4261.0 4530.4 4534.4 4660.6 4675.3 4776.0 4905.9 5270.0 5306.2 5764.6 1113.4 1333.7 1339.5 1359.0 1370.7 789.0 812.8 833.7 836.3 845.5 5228.7 5241.9 5372.7 5450.4 5498.7 4821.9 5372.8 5387.9 5880.6 5900.1 5086.9 5385.3 5394.0 5456.5 5525.7 2337.5 3044.3 3055.1 3055.6 3069.2 5241.3 5354.0 5991.8 5995.8 6025.9 5423.9 5523.9 5610.9 5781.5 5893.8 5992.8 5992.9 6001.4 6026.7 6064.8 4877.8 4897.6 4954.0 5058.9 5302.0 4450.6 4561.7 5665.8 5745.5 5771.8 5657.3 5971.8 5990.4 6016.6 6029.0 3370.8 3494.3 3514.8 4030.6 4039.3 4552.7 5698.2 5720.4 5772.7 5773.9 5028.8 5451.4 5529.6 5560.4 5626.8 5218.9 5267.8 5558.9 5566.0 5574.8 5418.3 5428.8 5462.9 5466.3 5470.6 5440.7 5449.8 5620.7 5647.3 5717.6 5086.2 5472.9 5499.5 5531.4 5566.9 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - PROCESS | 3430 | [#5] yui.html Cycles:180 Average:24746.99 Median:3795.10 stddev:39513.05 (1041.2%) stddev-sans-first:39582.65 18:29:08 INFO - PROCESS | 3430 | Values: 699.7 750.5 754.3 789.1 796.6 16717.7 17094.7 17104.5 17119.7 17133.7 16320.6 16506.7 16525.2 16537.8 16633.3 669.1 684.1 684.7 824.9 850.5 822.6 837.4 856.0 858.3 858.6 896.8 898.1 900.6 901.3 901.3 700.9 720.5 893.8 894.1 894.9 538.2 538.4 540.8 637.8 652.6 15385.0 15436.8 15462.1 15478.8 15479.5 10075.7 13524.1 13843.0 14177.4 14259.8 11576.0 11903.2 11947.8 12562.3 12953.2 3791.5 3827.5 3843.9 3883.6 3931.0 87966.0 90421.5 91434.5 97885.0 110187.9 9040.8 10634.7 10660.8 10785.6 11014.7 21017.4 21726.9 21740.1 21742.0 21782.5 8063.8 8080.0 8104.0 8160.2 8195.8 4326.9 4376.3 4528.8 4569.2 4638.3 3636.1 3742.7 3784.4 3792.5 3797.7 680.3 682.8 688.1 689.7 706.0 577.5 619.0 645.7 660.2 668.8 8836.3 9207.4 9616.2 9686.8 9738.3 571.5 576.8 631.4 653.4 673.3 3762.7 4687.8 4698.0 4703.6 4723.9 110711.0 120607.0 161009.0 163425.0 165715.2 135181.0 139481.3 140754.0 141271.3 141315.0 115102.0 118403.0 118584.2 118594.4 120543.2 8893.2 9094.1 9140.8 9175.2 9363.3 66093.0 66339.0 66475.0 66775.7 70197.0 47491.0 71201.0 81860.6 88656.1 92736.5 12803.7 12848.0 13239.9 13369.3 14272.0 14738.1 14769.3 15092.9 15529.7 15955.4 13248.5 13429.3 13694.5 13971.3 14164.5 13835.3 13843.6 14075.6 14211.9 14826.6 13433.7 13492.9 13741.1 13748.2 14339.6 11162.3 11280.6 11616.7 11662.5 11998.6 11546.8 11568.0 11648.6 11772.4 11833.5 18:29:08 INFO - PROCESS | 3430 | -------- Summary: end -------- 18:29:08 INFO - PROCESS | 3430 | 18:29:08 INFO - TEST-INFO | 3430: exit 0 18:29:08 INFO - TEST-OK | dromaeo_css | took 1117619ms 18:29:08 INFO - TEST-START | kraken 18:29:08 INFO - operating with platform_type : mac_ 18:29:08 INFO - Initialising browser for kraken test... 18:29:08 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp4waKDk/profile http://localhost:59308/getInfo.html) 18:29:11 INFO - PROCESS | 3433 | __metrics Screen width/height:1600/1200 18:29:11 INFO - PROCESS | 3433 | colorDepth:24 18:29:11 INFO - PROCESS | 3433 | Browser inner width/height: 1024/689 18:29:11 INFO - PROCESS | 3433 | __metrics 18:29:11 INFO - PROCESS | 3433 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:29:11 INFO - PROCESS | 3433 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:29:12 INFO - TEST-INFO | 3433: exit 0 18:29:12 INFO - Browser initialized. 18:29:12 INFO - Running cycle 1/1 for kraken test... 18:29:12 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp4waKDk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:23 INFO - PROCESS | 3434 | RSS: Main: 219377664 18:29:23 INFO - PROCESS | 3434 | 18:29:26 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:27 INFO - PROCESS | 3434 | RSS: Main: 269475840 18:29:27 INFO - PROCESS | 3434 | 18:29:30 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-dft) 18:29:30 INFO - PROCESS | 3434 | RSS: Main: 279670784 18:29:30 INFO - PROCESS | 3434 | 18:29:33 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-fft) 18:29:34 INFO - PROCESS | 3434 | RSS: Main: 377380864 18:29:34 INFO - PROCESS | 3434 | 18:29:36 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59308/tests/kraken/driver.html?testName=audio-oscillator) 18:29:37 INFO - PROCESS | 3434 | RSS: Main: 278507520 18:29:37 INFO - PROCESS | 3434 | 18:29:39 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:29:39 INFO - PROCESS | 3434 | RSS: Main: 280948736 18:29:39 INFO - PROCESS | 3434 | 18:29:42 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-darkroom) 18:29:43 INFO - PROCESS | 3434 | RSS: Main: 317992960 18:29:43 INFO - PROCESS | 3434 | 18:29:46 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59308/tests/kraken/driver.html?testName=imaging-desaturate) 18:29:46 INFO - PROCESS | 3434 | RSS: Main: 320790528 18:29:46 INFO - PROCESS | 3434 | 18:29:49 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59308/tests/kraken/driver.html?testName=json-parse-financial) 18:29:50 INFO - PROCESS | 3434 | RSS: Main: 317112320 18:29:50 INFO - PROCESS | 3434 | 18:29:51 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:29:52 INFO - PROCESS | 3434 | RSS: Main: 294977536 18:29:52 INFO - PROCESS | 3434 | 18:29:54 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:29:54 INFO - PROCESS | 3434 | RSS: Main: 297340928 18:29:54 INFO - PROCESS | 3434 | 18:29:56 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:29:57 INFO - PROCESS | 3434 | RSS: Main: 300449792 18:29:57 INFO - PROCESS | 3434 | 18:30:00 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:01 INFO - PROCESS | 3434 | RSS: Main: 312553472 18:30:01 INFO - PROCESS | 3434 | 18:30:03 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:04 INFO - PROCESS | 3434 | RSS: Main: 309030912 18:30:04 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:59308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59308/tests/kraken/driver.html?testName=ai-astar) 18:30:06 INFO - PROCESS | 3434 | RSS: Main: 352219136 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | __start_tp_report 18:30:06 INFO - PROCESS | 3434 | _x_x_mozilla_page_load 18:30:06 INFO - PROCESS | 3434 | _x_x_mozilla_page_load_details 18:30:06 INFO - PROCESS | 3434 | |i|pagename|runs| 18:30:06 INFO - PROCESS | 3434 | |0;ai-astar;115;115;114;114;114;114;113;115;114;114 18:30:06 INFO - PROCESS | 3434 | |1;audio-beat-detection;146;111;108;143;107;110;104;112;144;106 18:30:06 INFO - PROCESS | 3434 | |2;audio-dft;183;185;182;182;185;184;181;184;187;185 18:30:06 INFO - PROCESS | 3434 | |3;audio-fft;81;58;60;89;63;59;59;57;91;69 18:30:06 INFO - PROCESS | 3434 | |4;audio-oscillator;88;70;94;70;68;69;92;68;68;90 18:30:06 INFO - PROCESS | 3434 | |5;imaging-gaussian-blur;90;89;90;84;86;83;109;130;87;85 18:30:06 INFO - PROCESS | 3434 | |6;imaging-darkroom;94;93;93;95;93;103;131;95;93;93 18:30:06 INFO - PROCESS | 3434 | |7;imaging-desaturate;84;82;84;85;85;87;86;84;85;84 18:30:06 INFO - PROCESS | 3434 | |8;json-parse-financial;55;53;53;55;57;58;58;57;58;58 18:30:06 INFO - PROCESS | 3434 | |9;json-stringify-tinderbox;63;75;80;73;71;68;67;68;69;69 18:30:06 INFO - PROCESS | 3434 | |10;stanford-crypto-aes;83;83;82;85;84;80;83;83;88;83 18:30:06 INFO - PROCESS | 3434 | |11;stanford-crypto-ccm;137;137;136;137;131;135;158;153;181;138 18:30:06 INFO - PROCESS | 3434 | |12;stanford-crypto-pbkdf2;164;163;163;164;166;164;164;162;164;163 18:30:06 INFO - PROCESS | 3434 | |13;stanford-crypto-sha256-iterative;67;70;67;75;67;65;65;66;66;67 18:30:06 INFO - PROCESS | 3434 | __end_tp_report 18:30:06 INFO - PROCESS | 3434 | __start_cc_report 18:30:06 INFO - PROCESS | 3434 | _x_x_mozilla_cycle_collect,1956 18:30:06 INFO - PROCESS | 3434 | __end_cc_report 18:30:06 INFO - PROCESS | 3434 | __startTimestamp1475544606403__endTimestamp 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | ------- Summary: start ------- 18:30:06 INFO - PROCESS | 3434 | Number of tests: 14 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 18:30:06 INFO - PROCESS | 3434 | Values: 115.0 115.0 114.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:111.50 stddev:17.58 (15.8%) stddev-sans-first:15.73 18:30:06 INFO - PROCESS | 3434 | Values: 146.0 111.0 108.0 143.0 107.0 110.0 104.0 112.0 144.0 106.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.81 (1.0%) stddev-sans-first:1.90 18:30:06 INFO - PROCESS | 3434 | Values: 183.0 185.0 182.0 182.0 185.0 184.0 181.0 184.0 187.0 185.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#3] audio-fft Cycles:10 Average:68.60 Median:66.00 stddev:13.37 (20.3%) stddev-sans-first:13.41 18:30:06 INFO - PROCESS | 3434 | Values: 81.0 58.0 60.0 89.0 63.0 59.0 59.0 57.0 91.0 69.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.00 stddev:11.57 (14.6%) stddev-sans-first:11.65 18:30:06 INFO - PROCESS | 3434 | Values: 88.0 70.0 94.0 70.0 68.0 69.0 92.0 68.0 68.0 90.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:86.50 stddev:14.86 (17.2%) stddev-sans-first:15.72 18:30:06 INFO - PROCESS | 3434 | Values: 90.0 89.0 90.0 84.0 86.0 83.0 109.0 130.0 87.0 85.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:93.00 stddev:11.89 (12.8%) stddev-sans-first:12.51 18:30:06 INFO - PROCESS | 3434 | Values: 94.0 93.0 93.0 95.0 93.0 103.0 131.0 95.0 93.0 93.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 18:30:06 INFO - PROCESS | 3434 | Values: 84.0 82.0 84.0 85.0 85.0 87.0 86.0 84.0 85.0 84.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.50 stddev:2.04 (3.6%) stddev-sans-first:2.12 18:30:06 INFO - PROCESS | 3434 | Values: 55.0 53.0 53.0 55.0 57.0 58.0 58.0 57.0 58.0 58.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:4.74 (6.8%) stddev-sans-first:4.23 18:30:06 INFO - PROCESS | 3434 | Values: 63.0 75.0 80.0 73.0 71.0 68.0 67.0 68.0 69.0 69.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:2.19 18:30:06 INFO - PROCESS | 3434 | Values: 83.0 83.0 82.0 85.0 84.0 80.0 83.0 83.0 88.0 83.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:137.50 stddev:15.43 (11.2%) stddev-sans-first:16.14 18:30:06 INFO - PROCESS | 3434 | Values: 137.0 137.0 136.0 137.0 131.0 135.0 158.0 153.0 181.0 138.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 18:30:06 INFO - PROCESS | 3434 | Values: 164.0 163.0 163.0 164.0 166.0 164.0 164.0 162.0 164.0 163.0 18:30:06 INFO - PROCESS | 3434 | 18:30:06 INFO - PROCESS | 3434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.99 (4.5%) stddev-sans-first:3.17 18:30:06 INFO - PROCESS | 3434 | Values: 67.0 70.0 67.0 75.0 67.0 65.0 65.0 66.0 66.0 67.0 18:30:06 INFO - PROCESS | 3434 | -------- Summary: end -------- 18:30:06 INFO - PROCESS | 3434 | 18:30:07 INFO - TEST-INFO | 3434: exit 0 18:30:07 INFO - TEST-OK | kraken | took 58401ms 18:30:07 INFO - SUITE-END | took 1176s 18:30:07 INFO - Completed test suite (00:19:36) 18:30:07 INFO - javascript benchmark 18:30:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.9026229213123, 3255.9674403255967, 3289.3750187464366, 3293.7035666789984, 3340.4321265384883, 5607.102863541834, 5625.774969001245, 5634.464725851043, 5655.519280861132, 5671.2060311556415, 5106.540411362977, 5305.575553955684, 5578.581606379527, 5664.490195882369, 5673.773049078032, 5134.409542902558, 5141.768620412072, 5160.329157209558, 5206.921896171561, 5224.92162617561, 5103.897922041557, 5113.054084994288, 5225.320708307933, 5232.16285394337, 5235.240890070937, 5133.948660513403, 5134.794608215667, 5182.170852663575, 5189.0, 5190.7664155112925, 5188.299579556749, 5201.635885488017, 5205.6876587404495, 5229.398619158807, 5241.475852414766, 5136.899464533414, 5162.767675454614, 5196.038732834438, 5203.60972927032, 5217.843464696065, 4930.408350997867, 5517.917231241535, 5542.279503664538, 5543.279373681396, 5571.916421253684, 4963.379577552806, 4964.354633897607, 6014.609050411753, 6084.634921904656, 6111.633302001894, 6164.260288765332, 6231.532635052389, 6237.220347456568, 6260.530460215502, 6260.749570017194, 5571.247881536022, 5623.634463759842, 5625.662460252398, 5691.3170419549915, 5699.430056994309, 6183.907241391383, 6200.348963358872, 6202.56582039262, 6209.410106039919, 6232.220972378453, 6090.512758979271, 6094.634321940698, 6104.328523862371, 6109.297430795426, 6122.785702500391, 6029.939700603026, 6039.698015099228, 6048.183495228176, 6212.0371342441995, 6238.875222495615, 5993.9810232260625, 6054.0, 6082.996305609613, 6125.295591007091, 6136.263648362135, 6181.381861813873, 6192.721327540272, 6205.6586887720705, 6216.937830621727, 6219.657918814418, 4861.927071093936, 4878.146324393217, 4893.996730670204, 4914.189158788759, 4933.629977751683, 4306.332518459643, 4326.783660816946, 4351.760653164107, 4429.379886815848, 4435.911281774411, 5652.74562644682, 5654.46282603152, 5657.321121465368, 5662.57530685192, 5682.0, 5974.551908606872, 6030.517558595302, 6032.607880487754, 6100.969495152496, 6103.633781973096, 5556.444355564411, 5585.636933599303, 5596.384397716248, 5619.831405057855, 5622.24099746529, 5261.237120617489, 5263.578913686896, 5267.789288428497, 5273.762680679379, 5319.893602128013, 6266.717997690206, 6285.088662144055, 6304.117423560705, 6309.779157729457, 6314.842128946813, 6237.5321850860455, 6242.344553821965, 6244.843878903063, 6257.4681152102585, 6257.561970662192, 6257.311695713559, 6301.0, 6303.936960630518, 6309.085182648582, 6309.4952403806665, 5950.137230101697, 6001.849953751192, 6097.390260973867, 6106.45041946227, 6121.540884433596, 4637.443506779208, 6114.510839132948, 6128.717018009172, 6134.773364742421, 6208.875822483616, 4984.576311013604, 5976.731047102804, 5983.970080149571, 6004.699765011645, 6020.367861374668, 4635.884102897455, 5927.644341339534, 5933.762649494144, 5934.258217722785, 6003.429674180946, 5700.486956173964, 5725.627834190765, 5734.569907256889, 5765.423457654201, 5830.008898487352, 4986.775595098156, 6001.489873360813, 6017.18767966319, 6047.485963693135, 6054.8183554493435, 5829.0, 5829.271341082364, 5832.0, 5848.795292164754, 5875.764969401347], "value": 5579.45731273651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.819889342603, 504.5484291559054, 507.9561501115208, 513.5147285814907, 527.604296777417, 24114.0, 32492.837535812316, 40312.0, 41253.79373103138, 41323.79338103313, 42638.786806065924, 42991.35512967308, 43007.139857202914, 43140.35289470661, 43182.704518864404, 9807.656732014399, 9992.500374981259, 9994.15049720771, 9994.850077248848, 9995.2003839693, 8770.56147192641, 8987.415817971843, 9839.409635421898, 9965.551550180224, 12244.95917846984, 12225.816612750816, 12238.694032649211, 12266.386680665975, 12266.632001039983, 12296.262224266527, 12199.634010979686, 12263.448144833415, 12286.631401057983, 12294.20087694297, 12327.93836030814, 8709.25971292441, 8952.776180595472, 11745.706357341049, 11953.52185912571, 11999.280043197436, 40014.39978400326, 40352.79823600863, 40479.79760101181, 40500.18999619991, 40518.79740601307, 3200.4463885374016, 3270.3459308138467, 3328.7170590499595, 3351.329734053175, 3372.0726800129914, 23074.423139421648, 23406.64890026651, 29985.850070749508, 31057.912973046063, 31120.844395778102, 2493.8379005364595, 3209.7753157279, 3278.8032718036993, 3303.207230264743, 3352.2122301259183, 364249.0, 366087.9999999973, 368237.0, 368986.0, 370022.0, 49487.0, 59548.0, 59941.0, 60155.39844601585, 60370.79258414895, 63544.0, 63577.68211158914, 63635.0, 63655.68172159109, 63677.0, 16314.918425407797, 16860.74708879368, 16883.15584220784, 16887.662246754997, 16900.492985210465, 11736.178467507363, 13115.409806558728, 13188.736225275441, 13208.207507549578, 13212.669683257995, 13198.340082995812, 14616.707665846623, 14766.852331476548, 16299.59251018734, 16505.17474126289, 5157.355330583677, 6014.8195554133445, 6037.366076561898, 6132.724027418777, 6152.938470615237, 840.7267638017669, 856.7643897927995, 931.2736065868634, 985.2167526816198, 1025.7640742629237, 29064.564031539543, 30017.849910750305, 30158.396832063238, 30747.69252307493, 30796.538051929238, 919.2691810010923, 939.234523863063, 959.2757468111671, 991.861139440479, 1039.033698660238, 13485.865141348657, 15107.169105699073, 15686.058836469849, 16649.25078371476, 16905.83094169067, 673191.0, 677132.0, 678141.0, 680595.0, 683615.0, 57869.0, 58280.41719582835, 58404.707976459846, 58418.41581584215, 58486.41513584895, 1188.2810899405736, 1232.1067226261068, 1252.0234217310694, 1351.0610125962558, 1374.9931250343684, 28790.0, 29754.8512257446, 30324.0, 30452.695473044987, 30845.691543084282, 49446.50553494563, 49939.250911235635, 50029.74985125051, 50065.0, 50295.49704502908, 411479.0, 411843.0, 411994.0, 413431.0, 414232.0, 24342.63486047746, 25826.225213243633, 26408.471830563667, 26475.867620662542, 27593.724062759116, 46671.29993050175, 47530.52469475261, 47729.522704772506, 47937.760311198224, 48113.0, 37943.0, 38131.0, 38879.80560097181, 39015.60984390233, 40440.0, 30234.54648180235, 38912.61087389203, 39176.80411597924, 39298.2140357197, 40411.393829092, 38036.0, 38447.80776096102, 38574.42138367871, 38665.03337416587, 38855.41716874306, 26414.811333490423, 32302.955172551723, 32355.867544636767, 32890.0, 32934.01197964065, 25430.745692543576, 25533.616995744705, 25683.486330273663, 25961.610575841754, 26213.73786262113], "value": 19509.801918788446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.89798315547444, 356.4510653593466, 371.7323527060517, 378.3246904275868, 406.2383031815346, 15145.621359466018, 15209.923950380247, 16212.432564860232, 19671.803281967175, 21238.36284911455, 19985.60028799423, 20485.0, 20972.475688107806, 21195.57608847822, 21439.67840482394, 4823.228283474645, 5984.251968503937, 6068.362821903681, 6255.906161407583, 6277.121203031556, 5866.618669786471, 6162.815115546541, 6248.218972628421, 6248.500119990413, 6250.687465626723, 5798.623089499169, 6008.158857759917, 6209.410106039919, 6219.689015549227, 6227.782027629034, 6063.999999999978, 6120.632762034292, 6128.295246046672, 6135.079738039285, 6151.046587778901, 5062.139436295838, 5247.553957913582, 5300.0, 5302.045631786277, 5314.5748340132695, 25369.74630253692, 25421.618675719878, 25634.0, 25745.227643170736, 25933.092341768137, 2182.912683492674, 2283.178055899875, 2335.9299221023225, 2345.4839935214227, 3086.719011610179, 15537.990030648085, 15703.842961570352, 15744.68510629781, 16391.852570320083, 16526.256318465577, 1794.5782741055841, 1930.1893204853995, 1941.3302410668298, 1942.9028548572514, 1945.2219112355172, 123774.0, 127928.0, 128993.35503322518, 129176.0, 134921.65078349286, 8639.438436501607, 10774.353538787698, 11115.722106947229, 11164.274322169033, 11394.772104558027, 13963.301834908214, 13976.161430314214, 13988.72022559543, 13999.580012599637, 14001.649958751113, 8570.571471426403, 8765.298776097898, 8828.969337052515, 8954.015058343577, 8966.820663586692, 7424.997625320512, 8681.696140635047, 8755.693550725695, 8815.0, 8867.068957759471, 6498.3826536478955, 6539.161752483522, 6647.767328143492, 6648.601083934979, 6668.399844014062, 1792.5339411752777, 1798.14588070668, 1800.4433704140151, 1805.7562229099167, 1846.9353572624893, 907.5326207003399, 923.2244914272044, 926.8192702422963, 937.8358787212211, 964.7925695975399, 21126.577468450545, 22743.31770046901, 22941.770582293964, 22948.0, 23028.884855575616, 838.828040251747, 973.3624475968111, 996.7358649957768, 997.2969056814928, 997.5361456922566, 11144.832827507595, 11383.26659810078, 11672.299662020307, 11717.355545445082, 11755.941220293844, 631800.0, 632340.0, 640119.0, 644283.0, 644635.0, 87846.10407386234, 89784.0, 92084.0, 115721.0, 117843.0, 922.3820040572832, 942.7595963029383, 1003.267614641316, 1003.4982508745627, 1004.0862814838462, 19798.0, 19931.202751889763, 20460.65661277238, 20809.791902080786, 21380.893095534422, 57276.71361643332, 57357.0, 57703.711481442326, 59890.40109599022, 61430.77138457295, 78600.0, 78813.817792732, 80971.07397053877, 82077.58961205155, 83717.0, 7225.952236925721, 7380.741674041383, 7404.148522919718, 7677.500962437423, 8358.874616880874, 10930.781384372427, 12748.553800616934, 12953.611391658265, 13111.868881311064, 13176.0, 10943.343399396063, 11066.889331106586, 11085.833712494481, 11254.324740515267, 11434.828477572677, 8892.33307501953, 10707.57169713234, 11095.944520277348, 11116.49975751077, 11265.26775759573, 11058.0, 11128.833067503832, 11518.769624607294, 11558.30650160993, 11673.0, 6084.908726369196, 7110.146782386147, 7403.296686814744, 7476.476646634684, 7529.849403012018, 9061.77345566366, 10842.945785271024, 10943.343399396063, 11105.888941110808, 11295.757466678822], "value": 9770.104948593586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.9305034748263, 1440.4454285100237, 1663.3263528271048, 1863.1895125620347, 1887.4432042547446, 8511.276541493973, 9001.90998090019, 9019.060901906088, 9025.864612030824, 9048.0, 7491.775246742606, 8263.33893288537, 8473.87289190661, 8498.0, 8876.156765107304, 2414.553307638084, 2459.8524088554655, 2461.6676748638884, 2464.29767516257, 2467.592847180213, 2396.9050627000074, 2463.5935070713313, 2469.925902222936, 2470.110760126353, 2474.072222916406, 2443.8044956403446, 2455.312512496504, 2474.6164344526537, 2475.245050259679, 2477.343503971449, 2421.043687743349, 2434.525267572824, 2442.670239517669, 2450.816188785848, 2452.9754702452924, 2420.189236605739, 2439.731629520769, 2440.7437219092094, 2445.6942882139733, 2452.7179374372, 7878.80302992424, 9204.033576474441, 9208.401453905475, 9286.582103805345, 9324.766880827965, 4498.460184777848, 5541.168824676331, 5542.501174894239, 5549.556035517149, 5553.555715542747, 3497.4928635347733, 3629.2015756533783, 3694.039549717093, 3760.623937606245, 3764.0589852536864, 1051.0750539525245, 1069.4492336446735, 1076.43487169236, 1099.1811100729929, 1103.431732657682, 12524.561640342636, 12552.560660376843, 12557.811632825515, 12560.057995650272, 12582.685432864251, 4799.088173247072, 4811.0, 4875.68308059975, 5006.774695138727, 5024.62315326352, 10450.738731531772, 10461.790764184674, 10468.895311046792, 10472.73818154537, 10494.895051049545, 5482.424345443751, 5554.166874968787, 5565.9443405566235, 5585.218069470277, 5594.384617692051, 4221.345691417835, 4524.16302983949, 4683.906321873544, 4739.123262196505, 5088.084144853888, 3706.425504046877, 3885.1452680410266, 4001.7598944062865, 4016.979915100464, 4152.647025002909, 1296.9610911672664, 1306.6667999660026, 1306.9281189534477, 1315.967100822487, 1319.459021801057, 808.3775492870457, 842.6460886427715, 850.451458809077, 868.9963092628025, 870.4516154822421, 5494.450554944474, 6053.152558641794, 6090.451859332681, 6147.508199344042, 6188.4739797117745, 797.2306724011357, 935.9251259899328, 952.9237660987104, 971.7424882406168, 989.0999190736395, 3258.2668899497426, 3439.6216416194197, 4072.429859819628, 4137.234611596804, 4173.269677806372, 11020.559177632966, 11261.831072533918, 11377.975982161644, 11378.43107844621, 11403.657890263305, 10689.786204275872, 11120.165987550805, 11143.275687080313, 11304.626028533936, 11377.601783937687, 8394.118617545191, 8588.26999705032, 8617.396782225309, 8631.56842157902, 8653.43752656088, 5143.537081662668, 5460.808871689472, 5706.8586282744445, 6030.547708921936, 6329.082283069021, 10197.59209631636, 10258.230632702427, 10504.054635082879, 10620.681379558626, 10654.946725266635, 10381.636642717469, 10765.0, 10777.299475534066, 10832.458377081271, 10948.56205751793, 7230.9638451807405, 7468.925310746823, 7631.69473221065, 7826.960865195638, 7998.760037198894, 8594.05465398793, 8746.431481953652, 8799.604017819085, 8809.0, 8826.073262307365, 7648.0, 7729.845403092019, 7786.0, 7893.407994400328, 7916.050073991158, 7482.513636613603, 7605.771826845204, 7606.20134885829, 7612.3148916597775, 7665.616719163908, 7201.675924583302, 7260.745873894389, 7264.818379540554, 7271.054762881004, 7291.30732580404, 4919.458859525378, 4969.801207951641, 4983.27742477346, 5101.158308878993, 5275.815346462856, 5108.872278193075, 5138.511841375063, 5174.7930082797775, 5183.222516622386, 5248.0], "value": 4707.780066482069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.7630823029849, 313.94349017176904, 313.96548373110596, 319.7394123789112, 321.67671490152424, 5350.304460420145, 5405.5135037846585, 5408.729563521828, 5431.782728690852, 5466.098093814521, 5393.83818485445, 5408.593176036666, 5448.003598021082, 5448.7548060337285, 5450.247624949405, 3921.411788231767, 3964.7621142731527, 4089.5054017049574, 4092.7135100542823, 4196.244361296638, 3431.656834316573, 3474.322507111114, 4094.5905409459115, 4135.60711732385, 4144.171165766844, 3376.96623033769, 4096.344584866422, 4119.299719047769, 4134.400511925769, 4138.2758017347, 3840.2511510255513, 4065.004074001859, 4106.917861642765, 4144.730592511477, 4161.250974824516, 3581.0, 3584.444411116281, 3587.5336206293277, 3589.94615080774, 3595.9101022474388, 4649.418822647169, 5275.525202731773, 5293.311869456946, 5350.625456218067, 5353.812616558441, 3925.234579257046, 3947.0, 4450.866474005785, 4653.488116307203, 4679.953200467986, 5123.053239768864, 5510.90585577482, 5587.552995760329, 5645.266115405012, 5685.602007859451, 3849.480320156771, 3862.0069446179155, 3864.265789499986, 3865.6520913117956, 3866.7486613370043, 4982.427020892644, 5661.1508273758855, 5939.198208241875, 5980.581359304851, 6009.278886533601, 3261.967380326166, 3319.253168037172, 3532.91167720809, 3936.527616686016, 3946.309395855714, 3865.8453661853773, 4042.636162745367, 4052.7973601320405, 4053.0677944073027, 4069.2268468990796, 4260.978695106566, 4530.365748795171, 4534.433195850519, 4660.603848672901, 4675.275332323496, 4775.976120119377, 4905.9264111038365, 5270.0, 5306.177542480922, 5764.625299355613, 1113.3932007056012, 1333.706584551397, 1339.4776037345443, 1359.0215045167463, 1370.6847425092285, 788.9881651775228, 812.7970603506843, 833.7248707926369, 836.3434703757642, 845.4969293270494, 5228.712420816892, 5241.895162096736, 5372.7313634318125, 5450.3732070811575, 5498.697571633598, 4821.927671084936, 5372.785088596413, 5387.922415516912, 5880.647161170344, 5900.114982752536, 5086.898262034739, 5385.3268341457315, 5394.029074766501, 5456.508914197741, 5525.723713814293, 2337.5324935013064, 3044.2998110434723, 3055.1363668162403, 3055.618047744032, 3069.1559821048945, 5241.318628578337, 5353.9732301338245, 5991.820245392645, 5995.781560822524, 6025.9096113558335, 5423.891522169534, 5523.934216509876, 5610.859728506738, 5781.53747700183, 5893.764249430061, 5992.820215393545, 5992.850178745479, 6001.4298641628975, 6026.698665066817, 6064.757409703562, 4877.804887804448, 4897.579701886555, 4953.984433191259, 5058.939341698219, 5302.0, 4450.554944505653, 4561.749103799323, 5665.801696940752, 5745.511631511368, 5771.769129234784, 5657.2928383952, 5971.7611295547695, 5990.400959903975, 6016.639001659914, 6029.0, 3370.7865168539797, 3494.336076145524, 3514.789112653249, 4030.6372426481757, 4039.3133167362207, 4552.749598771967, 5698.230738850202, 5720.427957204412, 5772.6536407815665, 5773.884522309614, 5028.843366025908, 5451.373092094302, 5529.612927095226, 5560.443955604407, 5626.831195064155, 5218.869528261824, 5267.762950667153, 5558.861028474321, 5566.0, 5574.832755017356, 5418.268533747893, 5428.83713488596, 5462.91805622908, 5466.34403871538, 5470.617056806144, 5440.708371435225, 5449.809256675997, 5620.690862002629, 5647.334036459337, 5717.599768016199, 5086.21163719624, 5472.863178420572, 5499.532539734168, 5531.446855314436, 5566.888662226814], "value": 4098.374274756547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.7096205074894, 750.523417629805, 754.3361841579409, 789.0728394136895, 796.5750257320585, 16717.74923376149, 17094.743578846326, 17104.48686539403, 17119.743203851936, 17133.742993855103, 16320.591985200346, 16506.66986660266, 16525.173741312916, 16537.83462165381, 16633.334666613322, 669.0699927101333, 684.096991970599, 684.6953105867891, 824.86802111662, 850.5407080176728, 822.56404105824, 837.351052933975, 855.9828803423928, 858.3004851046409, 858.5750053723384, 896.8027034052498, 898.1108702384657, 900.5767289374016, 901.2879824938291, 901.3059943843236, 700.9439244860399, 720.4920531025614, 893.8167675626481, 894.0790985285166, 894.8612964990405, 538.1604696673203, 538.442711793292, 540.8134193703166, 637.7640273098937, 652.6051738698067, 15384.999975001589, 15436.768448473282, 15462.149581772997, 15478.845211547965, 15479.535613931488, 10075.748106297327, 13524.120932139478, 13842.9617778667, 14177.43290268388, 14259.78610320846, 11576.0, 11903.226290291102, 11947.820782688266, 12562.30907300098, 12953.222806631633, 3791.545014598238, 3827.540695116576, 3843.865464708722, 3883.5533913599734, 3930.977945734101, 87966.0, 90421.54789226077, 91434.5428272861, 97885.0, 110187.89812101937, 9040.819183616422, 10634.680959571226, 10660.786784264272, 10785.56857725698, 11014.669559913216, 21017.42369322307, 21726.891365543386, 21740.130394784348, 21742.021609027634, 21782.45543861416, 8063.758087257392, 8079.959600201962, 8104.0, 8160.187335040048, 8195.83608327842, 4326.935095973563, 4376.256036473807, 4528.773561321987, 4569.246074397754, 4638.257878739453, 3636.072801435617, 3742.7380083394446, 3784.375578029649, 3792.488014118059, 3797.715171362159, 680.3196803196803, 682.8190529509684, 688.1466980943594, 689.675852349395, 705.9974835733271, 577.5120023580068, 618.9876202476015, 645.7238235220884, 660.2341284110408, 668.7659319238325, 8836.293096552261, 9207.447553146832, 9616.23070154386, 9686.806263874683, 9738.269629777795, 571.4970825673464, 576.7519966414482, 631.3686313686313, 653.4347789162435, 673.3031312591543, 3762.6613604775703, 4687.835925742651, 4698.0, 4703.576678098919, 4723.881902952385, 110711.0, 120607.0, 161009.0, 163425.0, 165715.1714241421, 135181.0, 139481.30259348638, 140754.0, 141271.29364353113, 141315.0, 115102.0, 118403.0, 118584.22123668152, 118594.40702796604, 120543.19185212404, 8893.199612034949, 9094.090590940854, 9140.771480713036, 9175.174234318943, 9363.344565880323, 66093.0, 66339.0, 66475.00287495594, 66775.66612166908, 70197.0, 47491.0, 71201.0, 81860.59069704614, 88656.11343886479, 92736.53631731798, 12803.679908002374, 12848.0, 13239.933800330937, 13369.26469044212, 14272.000959932706, 14738.11571305725, 14769.335379907716, 15092.924535377253, 15529.68940621204, 15955.441559545361, 13248.536301229411, 13429.26139062361, 13694.52069177574, 13971.301434928417, 14164.504242351468, 13835.308234588432, 13843.584692459242, 14075.577732668036, 14211.857881421054, 14826.555203343916, 13433.731325373243, 13492.865071349554, 13741.106828056145, 13748.175109493463, 14339.569812905629, 11162.330260184415, 11280.605178818701, 11616.651500455, 11662.53349865996, 11998.58004969822, 11546.769064618493, 11568.0, 11648.592299269485, 11772.352520611448, 11833.526658933546], "value": 7835.503954627036, "unit": "score"}], "name": "dromaeo_css", "value": 7374.183332477892, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 108.0, 143.0, 107.0, 110.0, 104.0, 112.0, 144.0, 106.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 182.0, 185.0, 184.0, 181.0, 184.0, 187.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 89.0, 63.0, 59.0, 59.0, 57.0, 91.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 94.0, 70.0, 68.0, 69.0, 92.0, 68.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 84.0, 86.0, 83.0, 109.0, 130.0, 87.0, 85.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 95.0, 93.0, 103.0, 131.0, 95.0, 93.0, 93.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 85.0, 85.0, 87.0, 86.0, 84.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 75.0, 80.0, 73.0, 71.0, 68.0, 67.0, 68.0, 69.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 85.0, 84.0, 80.0, 83.0, 83.0, 88.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 136.0, 137.0, 131.0, 135.0, 158.0, 153.0, 181.0, 138.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 164.0, 166.0, 164.0, 164.0, 162.0, 164.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 75.0, 67.0, 65.0, 65.0, 66.0, 66.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1425.0, "alertThreshold": 2.0}]} 18:30:07 INFO - Return code: 0 18:30:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:07 INFO - # TBPL SUCCESS # 18:30:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:07 INFO - 2016-10-03 18:30:07.726 screenresolution[3439:63431] starting screenresolution argv=screenresolution get 18:30:07 INFO - 2016-10-03 18:30:07.728 screenresolution[3439:63431] Display 0: 1600x1200x32@60 18:30:07 INFO - 2016-10-03 18:30:07.734 screenresolution[3440:63434] starting screenresolution argv=screenresolution list 18:30:07 INFO - Available Modes on Display 0 18:30:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:07 INFO - Intel Iris: 18:30:07 INFO - Chipset Model: Intel Iris 18:30:07 INFO - Type: GPU 18:30:07 INFO - Bus: Built-In 18:30:07 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:07 INFO - Vendor: Intel (0x8086) 18:30:07 INFO - Device ID: 0x0a2e 18:30:07 INFO - Revision ID: 0x0009 18:30:07 INFO - Displays: 18:30:07 INFO - Display: 18:30:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:07 INFO - Display Serial Number: 1600x1200 60 18:30:07 INFO - Main Display: Yes 18:30:07 INFO - Mirror: Off 18:30:07 INFO - Online: Yes 18:30:07 INFO - Rotation: Supported 18:30:07 INFO - Return code: 0 18:30:07 INFO - Running post-action listener: _resource_record_post_action 18:30:07 INFO - [mozharness: 2016-10-04 01:30:07.971322Z] Finished run-tests step (success) 18:30:07 INFO - Running post-run listener: _resource_record_post_run 18:30:08 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 745472; Write bytes: 660384256; Read time: 7; Write time: 2478 18:30:08 INFO - TinderboxPrint: CPU usage
53.4% 18:30:08 INFO - TinderboxPrint: I/O read bytes / time
745,472 / 7 18:30:08 INFO - TinderboxPrint: I/O write bytes / time
660,384,256 / 2,478 18:30:08 INFO - TinderboxPrint: CPU idle
2,254.5 (46.6%) 18:30:08 INFO - TinderboxPrint: CPU system
973.3 (20.1%) 18:30:08 INFO - TinderboxPrint: CPU user
1,609.8 (33.3%) 18:30:08 INFO - TinderboxPrint: Swap in / out
362,995,712 / 0 18:30:08 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355772928; Write bytes: 355415552; Read time: 27382; Write time: 651 18:30:08 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 745472; Write bytes: 293950464; Read time: 7; Write time: 1790 18:30:08 INFO - Running post-run listener: _upload_blobber_files 18:30:08 INFO - Blob upload gear active. 18:30:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:08 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 18:30:08 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'] 18:30:08 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 18:30:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:09 INFO - (blobuploader) - INFO - Done attempting. 18:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:10 INFO - (blobuploader) - INFO - Done attempting. 18:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:12 INFO - (blobuploader) - INFO - Done attempting. 18:30:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:12 INFO - Return code: 0 18:30:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1eb9fad934241f6f8731e6c01c201dd213c2940ab1a4b1b6cb6a962d44a5f4c0bf16631638c05f1760bef020e71477e70710807b0390d810a90dff4741bca4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/064e059e3bd9978973e8f16d2e40adbe614ea1996deb2afe48cecf9ebb231857baa02f8c9eda65f7b5db11be7c2767c22693d51837573f8cce3363cd00a81bbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309f828b2a8911abee34c4a34ceeaa48cd3ef0ef480e7cdcbeed393444a4b11f20e40732f1d113de0c1d26767e54ed847201311a38ec221613d5a060a7e6f717"} 18:30:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:12 INFO - Contents: 18:30:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1eb9fad934241f6f8731e6c01c201dd213c2940ab1a4b1b6cb6a962d44a5f4c0bf16631638c05f1760bef020e71477e70710807b0390d810a90dff4741bca4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/064e059e3bd9978973e8f16d2e40adbe614ea1996deb2afe48cecf9ebb231857baa02f8c9eda65f7b5db11be7c2767c22693d51837573f8cce3363cd00a81bbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309f828b2a8911abee34c4a34ceeaa48cd3ef0ef480e7cdcbeed393444a4b11f20e40732f1d113de0c1d26767e54ed847201311a38ec221613d5a060a7e6f717"} 18:30:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:12 INFO - Copying logs to upload dir... 18:30:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.597930 ========= master_lag: 3.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-03 18:30:16.567214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:16.570478) ========= 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.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1eb9fad934241f6f8731e6c01c201dd213c2940ab1a4b1b6cb6a962d44a5f4c0bf16631638c05f1760bef020e71477e70710807b0390d810a90dff4741bca4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/064e059e3bd9978973e8f16d2e40adbe614ea1996deb2afe48cecf9ebb231857baa02f8c9eda65f7b5db11be7c2767c22693d51837573f8cce3363cd00a81bbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309f828b2a8911abee34c4a34ceeaa48cd3ef0ef480e7cdcbeed393444a4b11f20e40732f1d113de0c1d26767e54ed847201311a38ec221613d5a060a7e6f717"} build_url:https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1eb9fad934241f6f8731e6c01c201dd213c2940ab1a4b1b6cb6a962d44a5f4c0bf16631638c05f1760bef020e71477e70710807b0390d810a90dff4741bca4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/064e059e3bd9978973e8f16d2e40adbe614ea1996deb2afe48cecf9ebb231857baa02f8c9eda65f7b5db11be7c2767c22693d51837573f8cce3363cd00a81bbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309f828b2a8911abee34c4a34ceeaa48cd3ef0ef480e7cdcbeed393444a4b11f20e40732f1d113de0c1d26767e54ed847201311a38ec221613d5a060a7e6f717"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:16.616478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:16.616855) ========= 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.LqCZlPrEVv/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.oIAjVREEkd/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005378 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:16.670315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 18:30:16.670681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 18:30:16.671921) ========= ========= Total master_lag: 3.91 =========