builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0277 starttime: 1476096023.04 results: success (0) buildid: 20161010013015 builduid: 6587c7957c55499b954d5edf42f29fd7 revision: ca710272133c70d68ba587ccf45d6567e5e830b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.038720) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.039185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.039452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.064040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.064472) ========= 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.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-10 03:40:23-- 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% 72.8M=0s 2016-10-10 03:40:23 (72.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.169249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.169562) ========= 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.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.026662 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:23.217594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 03:40:23.217951) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ca710272133c70d68ba587ccf45d6567e5e830b8 --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 ca710272133c70d68ba587ccf45d6567e5e830b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-10 03:40:23,304 truncating revision to first 12 chars 2016-10-10 03:40:23,304 Setting DEBUG logging. 2016-10-10 03:40:23,304 attempt 1/10 2016-10-10 03:40:23,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ca710272133c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 03:40:24,303 unpacking tar archive at: mozilla-aurora-ca710272133c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 03:40:24.529686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:24.530042) ========= script_repo_revision: ca710272133c70d68ba587ccf45d6567e5e830b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:24.530436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:24.530700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 03:40:24.549249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-10 03:40:24.549529) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:40:24 INFO - MultiFileLogger online at 20161010 03:40:24 in /builds/slave/test 03:40:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:24 INFO - {'append_to_log': False, 03:40:24 INFO - 'base_work_dir': '/builds/slave/test', 03:40:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:24 INFO - 'branch': 'Mozilla-Aurora', 03:40:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:24 INFO - 'config_files': ('talos/mac_config.py',), 03:40:24 INFO - 'default_actions': ('clobber', 03:40:24 INFO - 'read-buildbot-config', 03:40:24 INFO - 'download-and-extract', 03:40:24 INFO - 'populate-webroot', 03:40:24 INFO - 'create-virtualenv', 03:40:24 INFO - 'install', 03:40:24 INFO - 'run-tests'), 03:40:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:24 INFO - 'download_minidump_stackwalk': True, 03:40:24 INFO - 'download_symbols': 'ondemand', 03:40:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:24 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:24 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:24 INFO - 'installer_path': 'installer.exe', 03:40:24 INFO - 'log_level': 'info', 03:40:24 INFO - 'log_name': 'talos', 03:40:24 INFO - 'log_to_console': True, 03:40:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:40:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:40:24 INFO - 'opt_config_files': (), 03:40:24 INFO - 'pip_index': False, 03:40:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:24 INFO - 'cmd': ('bash', 03:40:24 INFO - '-c', 03:40:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:24 INFO - 'enabled': True, 03:40:24 INFO - 'halt_on_failure': False, 03:40:24 INFO - 'name': 'check_screen_resolution'},), 03:40:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:24 INFO - 'cmd': ('bash', 03:40:24 INFO - '-c', 03:40:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:24 INFO - 'enabled': True, 03:40:24 INFO - 'halt_on_failure': False, 03:40:24 INFO - 'name': 'check_screen_resolution'},), 03:40:24 INFO - 'run_cmd_checks_enabled': True, 03:40:24 INFO - 'sps_profile': False, 03:40:24 INFO - 'sps_profile_interval': 0, 03:40:24 INFO - 'suite': 'dromaeojs-e10s', 03:40:24 INFO - 'system_bits': '32', 03:40:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:24 INFO - 'title': 't-yosemite-r7-0277', 03:40:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:24 INFO - 'use_talos_json': True, 03:40:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:24 INFO - 'work_dir': 'build'} 03:40:24 INFO - [mozharness: 2016-10-10 10:40:24.763182Z] Running clobber step. 03:40:24 INFO - Running pre-action listener: _resource_record_pre_action 03:40:24 INFO - Running main action method: clobber 03:40:24 INFO - rmtree: /builds/slave/test/build 03:40:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:27 INFO - Running post-action listener: _resource_record_post_action 03:40:27 INFO - [mozharness: 2016-10-10 10:40:27.235716Z] Finished clobber step (success) 03:40:27 INFO - [mozharness: 2016-10-10 10:40:27.235878Z] Running read-buildbot-config step. 03:40:27 INFO - Running pre-action listener: _resource_record_pre_action 03:40:27 INFO - Running main action method: read_buildbot_config 03:40:27 INFO - Using buildbot properties: 03:40:27 INFO - { 03:40:27 INFO - "project": "", 03:40:27 INFO - "product": "firefox", 03:40:27 INFO - "script_repo_revision": "production", 03:40:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:40:27 INFO - "repository": "", 03:40:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:40:27 INFO - "buildid": "20161010013015", 03:40:27 INFO - "pgo_build": "False", 03:40:27 INFO - "basedir": "/builds/slave/test", 03:40:27 INFO - "buildnumber": 16, 03:40:27 INFO - "slavename": "t-yosemite-r7-0277", 03:40:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:40:27 INFO - "platform": "yosemite_r7", 03:40:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:40:27 INFO - "branch": "mozilla-aurora", 03:40:27 INFO - "repo_path": "releases/mozilla-aurora", 03:40:27 INFO - "revision": "ca710272133c70d68ba587ccf45d6567e5e830b8", 03:40:27 INFO - "stage_platform": "macosx64", 03:40:27 INFO - "builduid": "6587c7957c55499b954d5edf42f29fd7", 03:40:27 INFO - "slavebuilddir": "test" 03:40:27 INFO - } 03:40:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:40:27 INFO - Running post-action listener: _resource_record_post_action 03:40:27 INFO - [mozharness: 2016-10-10 10:40:27.239078Z] Finished read-buildbot-config step (success) 03:40:27 INFO - [mozharness: 2016-10-10 10:40:27.239188Z] Running download-and-extract step. 03:40:27 INFO - Running pre-action listener: _resource_record_pre_action 03:40:27 INFO - Running main action method: download_and_extract 03:40:27 INFO - mkdir: /builds/slave/test/build/tests 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:27 INFO - trying https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:40:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:40:28 INFO - Downloaded 1199 bytes. 03:40:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:40:28 INFO - Using the following test package requirements: 03:40:28 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:40:28 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:40:28 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:40:28 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'jsshell-mac.zip'], 03:40:28 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:40:28 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:40:28 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:40:28 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:40:28 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:40:28 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:40:28 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:40:28 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:40:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:40:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:40:28 INFO - Fetch https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:40:29 INFO - Expected file size: 16434726 03:40:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:40:36 INFO - Expected file size: 16434726 03:40:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:40:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:40:43 INFO - Fetch https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:40:43 INFO - Expected file size: 14414059 03:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:44 INFO - trying https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:40:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:40:47 INFO - Downloaded 115376193 bytes. 03:40:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:40:47 INFO - mkdir: /builds/slave/test/properties 03:40:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:47 INFO - Contents: 03:40:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:40:48 INFO - Running post-action listener: _resource_record_post_action 03:40:48 INFO - Running post-action listener: set_extra_try_arguments 03:40:48 INFO - [mozharness: 2016-10-10 10:40:48.398555Z] Finished download-and-extract step (success) 03:40:48 INFO - [mozharness: 2016-10-10 10:40:48.398687Z] Running populate-webroot step. 03:40:48 INFO - Running pre-action listener: _resource_record_pre_action 03:40:48 INFO - Running main action method: populate_webroot 03:40:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:48 INFO - '--tppagecycles', 03:40:48 INFO - '7'], 03:40:48 INFO - 'tests': ['tsvgm']}}, 03:40:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['damp', 'tps']}, 03:40:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'tests': ['damp', 'tps']}, 03:40:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['dromaeo_dom']}, 03:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['basic_compositor_video']}, 03:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:40:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['a11yr', 03:40:48 INFO - 'ts_paint', 03:40:48 INFO - 'tpaint', 03:40:48 INFO - 'sessionrestore', 03:40:48 INFO - 'sessionrestore_no_auto_restore', 03:40:48 INFO - 'tabpaint']}, 03:40:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['tsvgx', 03:40:48 INFO - 'tsvgr_opacity', 03:40:48 INFO - 'tart', 03:40:48 INFO - 'tscrollx', 03:40:48 INFO - 'cart']}, 03:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:48 INFO - 'tsvgr_opacity', 03:40:48 INFO - 'tart', 03:40:48 INFO - 'tscrollx', 03:40:48 INFO - 'cart']}, 03:40:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'talos_options': ['--disable-e10s'], 03:40:48 INFO - 'tests': ['tp5o']}, 03:40:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'tests': ['tp5o']}, 03:40:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'talos_options': ['--disable-e10s', 03:40:48 INFO - '--xperf_path', 03:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:48 INFO - 'tests': ['tp5n']}, 03:40:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:48 INFO - 'talos_options': ['--xperf_path', 03:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:48 INFO - 'tests': ['tp5n']}}, 03:40:48 INFO - 'talos.zip': {'path': '', 03:40:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:48 INFO - Running post-action listener: _resource_record_post_action 03:40:48 INFO - [mozharness: 2016-10-10 10:40:48.417439Z] Finished populate-webroot step (success) 03:40:48 INFO - [mozharness: 2016-10-10 10:40:48.417554Z] Running create-virtualenv step. 03:40:48 INFO - Running pre-action listener: _resource_record_pre_action 03:40:48 INFO - Running main action method: create_virtualenv 03:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:40:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:48 INFO - Using real prefix '/tools/python27' 03:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:52 INFO - Installing pip.................done. 03:40:52 INFO - Return code: 0 03:40:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:52 INFO - 'HOME': '/Users/cltbld', 03:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:52 INFO - 'LOGNAME': 'cltbld', 03:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:52 INFO - 'MOZ_NO_REMOTE': '1', 03:40:52 INFO - 'NO_EM_RESTART': '1', 03:40:52 INFO - 'PAGER': '/bin/cat', 03:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:52 INFO - 'PWD': '/builds/slave/test', 03:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:52 INFO - 'SHELL': '/bin/bash', 03:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:40:52 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:52 INFO - 'USER': 'cltbld', 03:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:52 INFO - 'XPC_FLAGS': '0x0', 03:40:52 INFO - 'XPC_SERVICE_NAME': '0', 03:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:40:52 INFO - Cleaning up... 03:40:52 INFO - Return code: 0 03:40:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:52 INFO - 'HOME': '/Users/cltbld', 03:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:52 INFO - 'LOGNAME': 'cltbld', 03:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:52 INFO - 'MOZ_NO_REMOTE': '1', 03:40:52 INFO - 'NO_EM_RESTART': '1', 03:40:52 INFO - 'PAGER': '/bin/cat', 03:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:52 INFO - 'PWD': '/builds/slave/test', 03:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:52 INFO - 'SHELL': '/bin/bash', 03:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:40:52 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:52 INFO - 'USER': 'cltbld', 03:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:52 INFO - 'XPC_FLAGS': '0x0', 03:40:52 INFO - 'XPC_SERVICE_NAME': '0', 03:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:52 INFO - Downloading/unpacking psutil>=3.1.1 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:56 INFO - Installing collected packages: psutil 03:40:56 INFO - Running setup.py install for psutil 03:40:56 INFO - building 'psutil._psutil_osx' extension 03:40:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:40:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:40:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:40:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:40:56 INFO - building 'psutil._psutil_posix' extension 03:40:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:40:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:40:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:40:56 INFO - ^ 03:40:57 INFO - 1 warning generated. 03:40:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:40:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:57 INFO - Successfully installed psutil 03:40:57 INFO - Cleaning up... 03:40:57 INFO - Return code: 0 03:40:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:40: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 mozsystemmonitor==0.3 03:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:57 INFO - 'HOME': '/Users/cltbld', 03:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:57 INFO - 'LOGNAME': 'cltbld', 03:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:57 INFO - 'MOZ_NO_REMOTE': '1', 03:40:57 INFO - 'NO_EM_RESTART': '1', 03:40:57 INFO - 'PAGER': '/bin/cat', 03:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:57 INFO - 'PWD': '/builds/slave/test', 03:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:57 INFO - 'SHELL': '/bin/bash', 03:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:40:57 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:57 INFO - 'USER': 'cltbld', 03:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:57 INFO - 'XPC_FLAGS': '0x0', 03:40:57 INFO - 'XPC_SERVICE_NAME': '0', 03:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:00 INFO - Installing collected packages: mozsystemmonitor 03:41:00 INFO - Running setup.py install for mozsystemmonitor 03:41:00 INFO - Successfully installed mozsystemmonitor 03:41:00 INFO - Cleaning up... 03:41:00 INFO - Return code: 0 03:41:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:41:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:00 INFO - 'HOME': '/Users/cltbld', 03:41:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:00 INFO - 'LOGNAME': 'cltbld', 03:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:00 INFO - 'MOZ_NO_REMOTE': '1', 03:41:00 INFO - 'NO_EM_RESTART': '1', 03:41:00 INFO - 'PAGER': '/bin/cat', 03:41:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:00 INFO - 'PWD': '/builds/slave/test', 03:41:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:00 INFO - 'SHELL': '/bin/bash', 03:41:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:00 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:00 INFO - 'USER': 'cltbld', 03:41:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:00 INFO - 'XPC_FLAGS': '0x0', 03:41:00 INFO - 'XPC_SERVICE_NAME': '0', 03:41:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:03 INFO - warning: no files found matching '*.txt' 03:41:03 INFO - no previously-included directories found matching 'build' 03:41:03 INFO - no previously-included directories found matching 'dist' 03:41:03 INFO - no previously-included directories found matching '.git*' 03:41:03 INFO - Installing collected packages: jsonschema, functools32 03:41:03 INFO - Running setup.py install for functools32 03:41:03 INFO - warning: no files found matching '*.txt' 03:41:03 INFO - no previously-included directories found matching 'build' 03:41:03 INFO - no previously-included directories found matching 'dist' 03:41:03 INFO - no previously-included directories found matching '.git*' 03:41:03 INFO - Successfully installed jsonschema functools32 03:41:03 INFO - Cleaning up... 03:41:03 INFO - Return code: 0 03:41:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:03 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:03 INFO - 'HOME': '/Users/cltbld', 03:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:03 INFO - 'LOGNAME': 'cltbld', 03:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:03 INFO - 'MOZ_NO_REMOTE': '1', 03:41:03 INFO - 'NO_EM_RESTART': '1', 03:41:03 INFO - 'PAGER': '/bin/cat', 03:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:03 INFO - 'PWD': '/builds/slave/test', 03:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:03 INFO - 'SHELL': '/bin/bash', 03:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:03 INFO - 'USER': 'cltbld', 03:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:03 INFO - 'XPC_FLAGS': '0x0', 03:41:03 INFO - 'XPC_SERVICE_NAME': '0', 03:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:04 INFO - Cleaning up... 03:41:04 INFO - Return code: 0 03:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:04 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:04 INFO - 'HOME': '/Users/cltbld', 03:41:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:04 INFO - 'LOGNAME': 'cltbld', 03:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:04 INFO - 'MOZ_NO_REMOTE': '1', 03:41:04 INFO - 'NO_EM_RESTART': '1', 03:41:04 INFO - 'PAGER': '/bin/cat', 03:41:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:04 INFO - 'PWD': '/builds/slave/test', 03:41:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:04 INFO - 'SHELL': '/bin/bash', 03:41:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:04 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:04 INFO - 'USER': 'cltbld', 03:41:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:04 INFO - 'XPC_FLAGS': '0x0', 03:41:04 INFO - 'XPC_SERVICE_NAME': '0', 03:41:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:08 INFO - Downloading docopt-0.6.1.tar.gz 03:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:08 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:08 INFO - Running setup.py install for blobuploader 03:41:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:08 INFO - Running setup.py install for requests 03:41:08 INFO - Running setup.py install for docopt 03:41:09 INFO - Successfully installed blobuploader requests docopt 03:41:09 INFO - Cleaning up... 03:41:09 INFO - Return code: 0 03:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:09 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:09 INFO - 'HOME': '/Users/cltbld', 03:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:09 INFO - 'LOGNAME': 'cltbld', 03:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:09 INFO - 'MOZ_NO_REMOTE': '1', 03:41:09 INFO - 'NO_EM_RESTART': '1', 03:41:09 INFO - 'PAGER': '/bin/cat', 03:41:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:09 INFO - 'PWD': '/builds/slave/test', 03:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:09 INFO - 'SHELL': '/bin/bash', 03:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:09 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:09 INFO - 'USER': 'cltbld', 03:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:09 INFO - 'XPC_FLAGS': '0x0', 03:41:09 INFO - 'XPC_SERVICE_NAME': '0', 03:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-t9Mgwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-clgpJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-JOqSPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZhCcMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8LiQrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:09 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xCj_hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-c7i7FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-bHLUSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5gD3Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-nBZHiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-N5bRpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AKmSd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-n3H0xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-UsKlO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-9OElDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZtJFSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-G6KWSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:11 INFO - Running setup.py install for manifestparser 03:41:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Running setup.py install for mozcrash 03:41:11 INFO - Running setup.py install for mozdebug 03:41:11 INFO - Running setup.py install for mozdevice 03:41:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:11 INFO - Running setup.py install for mozfile 03:41:11 INFO - Running setup.py install for mozhttpd 03:41:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozinfo 03:41:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozInstall 03:41:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozleak 03:41:12 INFO - Running setup.py install for mozlog 03:41:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for moznetwork 03:41:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:12 INFO - Running setup.py install for mozprocess 03:41:13 INFO - Running setup.py install for mozprofile 03:41:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Running setup.py install for mozrunner 03:41:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Running setup.py install for mozscreenshot 03:41:13 INFO - Running setup.py install for moztest 03:41:13 INFO - Running setup.py install for mozversion 03:41:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:13 INFO - Cleaning up... 03:41:13 INFO - Return code: 0 03:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:13 INFO - 'HOME': '/Users/cltbld', 03:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:13 INFO - 'LOGNAME': 'cltbld', 03:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:13 INFO - 'MOZ_NO_REMOTE': '1', 03:41:13 INFO - 'NO_EM_RESTART': '1', 03:41:13 INFO - 'PAGER': '/bin/cat', 03:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:13 INFO - 'PWD': '/builds/slave/test', 03:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:13 INFO - 'SHELL': '/bin/bash', 03:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:13 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:13 INFO - 'USER': 'cltbld', 03:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:13 INFO - 'XPC_FLAGS': '0x0', 03:41:13 INFO - 'XPC_SERVICE_NAME': '0', 03:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-vh4QK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-hmwCIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-offZAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-7XLI0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WfHDFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ViKEr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ggpY9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ij9ePZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:14 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-J3r0km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-iTUv0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_wIi5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-GFJU3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-c5rlEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HX3zUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3YfzGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-eNb7PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-9LH2sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:18 INFO - Downloading blessings-1.6.tar.gz 03:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:18 INFO - Installing collected packages: blessings 03:41:18 INFO - Running setup.py install for blessings 03:41:18 INFO - Successfully installed blessings 03:41:18 INFO - Cleaning up... 03:41:18 INFO - Return code: 0 03:41:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Current package versions: 03:41:19 INFO - blessings == 1.6 03:41:19 INFO - blobuploader == 1.2.4 03:41:19 INFO - docopt == 0.6.1 03:41:19 INFO - functools32 == 3.2.3-2 03:41:19 INFO - jsonschema == 2.5.1 03:41:19 INFO - manifestparser == 1.1 03:41:19 INFO - mozInstall == 1.12 03:41:19 INFO - mozcrash == 0.17 03:41:19 INFO - mozdebug == 0.1 03:41:19 INFO - mozdevice == 0.48 03:41:19 INFO - mozfile == 1.2 03:41:19 INFO - mozhttpd == 0.7 03:41:19 INFO - mozinfo == 0.9 03:41:19 INFO - mozleak == 0.1 03:41:19 INFO - mozlog == 3.4 03:41:19 INFO - moznetwork == 0.27 03:41:19 INFO - mozprocess == 0.23 03:41:19 INFO - mozprofile == 0.28 03:41:19 INFO - mozrunner == 6.12 03:41:19 INFO - mozscreenshot == 0.1 03:41:19 INFO - mozsystemmonitor == 0.3 03:41:19 INFO - moztest == 0.7 03:41:19 INFO - mozversion == 1.4 03:41:19 INFO - psutil == 3.1.1 03:41:19 INFO - requests == 1.2.3 03:41:19 INFO - wsgiref == 0.1.2 03:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:19 INFO - 'HOME': '/Users/cltbld', 03:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PAGER': '/bin/cat', 03:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:19 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - 'XPC_FLAGS': '0x0', 03:41:19 INFO - 'XPC_SERVICE_NAME': '0', 03:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x106cc5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1f2e9a750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, '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.4fDqRM7R5i/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.03cJtIaSmw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:19 INFO - 'HOME': '/Users/cltbld', 03:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PAGER': '/bin/cat', 03:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:19 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - 'XPC_FLAGS': '0x0', 03:41:19 INFO - 'XPC_SERVICE_NAME': '0', 03:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Running post-action listener: _resource_record_post_action 03:41:19 INFO - Running post-action listener: _start_resource_monitoring 03:41:19 INFO - Starting resource monitoring. 03:41:19 INFO - [mozharness: 2016-10-10 10:41:19.587580Z] Finished create-virtualenv step (success) 03:41:19 INFO - [mozharness: 2016-10-10 10:41:19.588551Z] Running install step. 03:41:19 INFO - Running pre-action listener: _resource_record_pre_action 03:41:19 INFO - Running main action method: install 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:19 INFO - Reading from file tmpfile_stdout 03:41:19 INFO - Output received: 03:41:19 INFO - Usage: mozinstall [options] installer 03:41:19 INFO - Options: 03:41:19 INFO - -h, --help show this help message and exit 03:41:19 INFO - -d DEST, --destination=DEST 03:41:19 INFO - Directory to install application into. [default: 03:41:19 INFO - "/builds/slave/test"] 03:41:19 INFO - --app=APP Application being installed. [default: firefox] 03:41:19 INFO - mkdir: /builds/slave/test/build/application 03:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:41:52 INFO - Reading from file tmpfile_stdout 03:41:52 INFO - Output received: 03:41:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:41:52 INFO - Running post-action listener: _resource_record_post_action 03:41:52 INFO - [mozharness: 2016-10-10 10:41:52.380829Z] Finished install step (success) 03:41:52 INFO - [mozharness: 2016-10-10 10:41:52.380959Z] Running run-tests step. 03:41:52 INFO - Running pre-action listener: _resource_record_pre_action 03:41:52 INFO - Running main action method: run_tests 03:41:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:52 INFO - 2016-10-10 03:41:52.395 screenresolution[1639:7410] starting screenresolution argv=screenresolution get 03:41:52 INFO - 2016-10-10 03:41:52.398 screenresolution[1639:7410] Display 0: 1600x1200x32@60 03:41:52 INFO - 2016-10-10 03:41:52.404 screenresolution[1640:7413] starting screenresolution argv=screenresolution list 03:41:52 INFO - Available Modes on Display 0 03:41:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:52 INFO - Intel Iris: 03:41:52 INFO - Chipset Model: Intel Iris 03:41:52 INFO - Type: GPU 03:41:52 INFO - Bus: Built-In 03:41:52 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:52 INFO - Vendor: Intel (0x8086) 03:41:52 INFO - Device ID: 0x0a2e 03:41:52 INFO - Revision ID: 0x0009 03:41:52 INFO - Displays: 03:41:52 INFO - Display: 03:41:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:52 INFO - Display Serial Number: 1600x1200 60 03:41:52 INFO - Main Display: Yes 03:41:52 INFO - Mirror: Off 03:41:52 INFO - Online: Yes 03:41:52 INFO - Rotation: Supported 03:41:52 INFO - Return code: 0 03:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:52 INFO - Python 2.7.3 03:41:52 INFO - Return code: 0 03:41:52 INFO - grabbing minidump binary from tooltool 03:41: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')]} 03:41:52 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 0x106ad9d30>, '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 0x10693fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ad1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:41:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:41:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:41:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:52 INFO - Return code: 0 03:41:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:41:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:41:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4fDqRM7R5i/Render', 03:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:52 INFO - 'HOME': '/Users/cltbld', 03:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:52 INFO - 'LOGNAME': 'cltbld', 03:41:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:52 INFO - 'MOZ_NO_REMOTE': '1', 03:41:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:52 INFO - 'NO_EM_RESTART': '1', 03:41:52 INFO - 'PAGER': '/bin/cat', 03:41:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:52 INFO - 'PWD': '/builds/slave/test', 03:41:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:52 INFO - 'SHELL': '/bin/bash', 03:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.03cJtIaSmw/Listeners', 03:41:52 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:52 INFO - 'USER': 'cltbld', 03:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:52 INFO - 'XPC_FLAGS': '0x0', 03:41:52 INFO - 'XPC_SERVICE_NAME': '0', 03:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:41:52 INFO - mozversion application_buildid: 20161010013015 03:41:52 INFO - mozversion application_changeset: ca710272133c70d68ba587ccf45d6567e5e830b8 03:41:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:52 INFO - mozversion application_name: Firefox 03:41:52 INFO - mozversion application_remotingname: firefox-dev 03:41:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:52 INFO - mozversion application_vendor: Mozilla 03:41:52 INFO - mozversion application_version: 51.0a2 03:41:52 INFO - mozversion platform_buildid: 20161010013015 03:41:52 INFO - mozversion platform_changeset: ca710272133c70d68ba587ccf45d6567e5e830b8 03:41:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:52 INFO - mozversion platform_version: 51.0a2 03:41:52 INFO - using testdate: 1476096112 03:41:52 INFO - actual date: 1476096112 03:41:52 INFO - starting webserver on 'localhost:49266' 03:41:52 INFO - SUITE-START | Running 2 tests 03:41:52 INFO - TEST-START | dromaeo_css 03:41:52 INFO - operating with platform_type : mac_ 03:41:52 INFO - Initialising browser for dromaeo_css test... 03:41:52 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp78rhvm/profile http://localhost:49266/getInfo.html) 03:41:55 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 03:41:55 INFO - PROCESS | 1650 | colorDepth:24 03:41:55 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 03:41:55 INFO - PROCESS | 1650 | __metrics 03:41:55 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:41:56 INFO - TEST-INFO | 1650: exit 0 03:41:56 INFO - Browser initialized. 03:41:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:56 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp78rhvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:08 INFO - PROCESS | 1653 | RSS: Main: 225271808 03:42:08 INFO - PROCESS | 1653 | 03:42:58 INFO - PROCESS | 1653 | 1476096178200 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 03:45:11 INFO - PROCESS | 1653 | RSS: Main: 237195264 03:45:11 INFO - PROCESS | 1653 | 03:48:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 03:48:14 INFO - PROCESS | 1653 | RSS: Main: 247111680 03:48:14 INFO - PROCESS | 1653 | 03:51:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 03:51:17 INFO - PROCESS | 1653 | RSS: Main: 252968960 03:51:17 INFO - PROCESS | 1653 | 03:54:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 03:54:19 INFO - PROCESS | 1653 | RSS: Main: 253206528 03:54:19 INFO - PROCESS | 1653 | 03:57:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 03:57:23 INFO - PROCESS | 1653 | RSS: Main: 258473984 03:57:23 INFO - PROCESS | 1653 | 04:00:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 04:00:26 INFO - PROCESS | 1653 | RSS: Main: 260251648 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | __start_tp_report 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:00:26 INFO - PROCESS | 1653 | |i|pagename|runs| 04:00:26 INFO - PROCESS | 1653 | |0;dojo.html;2923.050008747157;3391.609964854041;3420.3672320620685;3462.688358047775;3465.98267008665;5739.339975902767;5757.769689212431;5772.3361813391475;5796.159556864252;5828.3297420796625;4823.397075365579;5804.100364443508;5819.068948968166;5881.176635271055;5882.941070607289;4389.209942210401;5239.764210610531;5311.176767601028;5355.598330125236;5357.732113394334;5347.983883062225;5380.623356365037;5386.138217885139;5400.864978375533;5419.783208671648;5263.526282634562;5268.841934741964;5370.113931201347;5371.301730775013;5384.703841288728;5244.580433565325;5283.049051170788;5308.973455132699;5320.255164277004;5375.75809088592;5173.327467429248;5254.264402983586;5271.28837606922;5273.551748101416;5275.630705850592;5665.716714164275;5700.8859822803315;5773.364929857712;5839.737211825435;5896.056630939029;6176.166217560617;6208.317085120633;6243.001119820807;6278.843028924268;6351.2060992375955;5239.973800131013;6276.905846412307;6342.904856427157;6350.904736428957;6354.3963323484195;5931.3178984417345;5935.990881550104;5936.851578710567;5938.940610593882;5943.227380440515;6266.028765541349;6312.779052733133;6324.747010119636;6326.778562750282;6327.873442531123;6218.9378106218355;6282;6282.654454004982;6283.05754136874;6287.685615719196;6256.6871656417;6338.429541341301;6346.777862774781;6352.555321127569;6365.204349456318;6154.076888466676;6208.782692605737;6214.658193799294;6233.968830155911;6304.65324407162;6268.905966410507;6285.402886725754;6311.463525600284;6347.301796802348;6388.904166437507;4998.500149985045;5006;5011.123053465629;5015.623828212899;5026.824061157842;4379.146066516999;4429.269170586817;4442.133783912171;4453.710508816916;4467.888302792391;5899.410058994066;5903.291605007426;5910.970445147746;5955.40445955401;6009.248843894513;6250.624962502265;6319.684015799192;6323.462505686976;6328.588641738273;6329.620222786648;5014.899702006012;5680.715964201773;5880.206172166788;5896.056630939115;5939.910901336483;4958.884251043559;5501.752421141058;5516.889662206733;5527.032769265443;5527.088030475007;6485.3514648534765;6488.31872653374;6508.60948343101;6511.446527045254;6512.706928188148;6196.845078873064;6221.96889015552;6246.250449946036;6248;6291.496680265659;6362.300146983735;6402.135711678864;6430.935690643034;6448.387403196689;6479.773207937699;6276.466500347522;6318.0838778375955;6327.3988971047675;6334.461570766536;6335.144755458138;5139.792148845093;6145.740123274807;6184.6598437086395;6297.842553936005;6317;4630.351750754964;6252.781152659817;6255.749770009149;6265.592736472115;6269.623822570478;5084;6201.503879689524;6223.844403889939;6264.749410023548;6274.560780745486;5932.8813423732145;5961.225040744675;6017.15759793638;6082.11809287642;6166.691665416801;6131.3460828618745;6152.630842149485;6211.503079753518;6248.937510624835;6290.559660823698;5070.569001634754;6099.969500152471;6104.572679912363;6112.633242005494;6118.969405152946 04:00:26 INFO - PROCESS | 1653 | |1;ext.html;453.8593036158791;456.8971981304206;463.8562045765815;468.8546550569326;554.6533416614615;38454.230915381675;40456.79771601142;40492;42823.78588107055;42916.3562546562;42334.788326058406;43053;43134.13731725363;43150;43154.784226078824;9730.70807875763;9878.901210987906;9880.950595247014;9900.207983361313;9911.801763964717;9741;9852.211823054175;9857.260705447085;9871;9906.009399060109;9858.901410985905;9879;9883.50582470877;9901.900980990169;9906.801863962752;9813.362131461468;9852.556634951445;9856.852147217798;9868.753281167956;9870.703878883645;9688.224942004623;9750.171235444996;9755.951220243924;9863.457509836957;9867.259955503294;40065.59934400648;40365;40423.393649095284;40474.59525404737;40724.796376018225;3397.133730898605;3433.0215888471666;3442.277121804424;3916.6475017248586;3936.665383442411;29954.101376958508;30244.69755302441;30567.847160764275;31571;31915.202119947186;3248.4640034394297;3271.9182020449443;3314.4531152360073;3334.9666503334897;3348.7655864089525;487311;490394;491155.54422228015;491708;495357;58101;58516.414835851945;58628;64836.67581662061;66962.66518667375;65753.68492630216;69698;70523.29476705269;70666;70959;17339.21973511195;17460.650786984443;17541.29834806619;17594.472165835046;17606.383776568015;13164.946804255636;13184.802227966587;13327.933360333136;13328.6667833303;13350.532731354357;20050.799492005186;20446.591068178554;20670.896645516677;20685.482862928548;20744.48138796542;7167.964160179165;8400.201980811813;8495.362847786317;8504.277136443472;8518.190771876785;772.0773675457774;949.1681055562692;965.4303960663242;986.1962500562163;1048.4286064095086;26472.8676356617;29339;30135.246618834706;30402.54396184059;30769.846150769103;817.5380909785952;821.3593397150232;826.0417915218318;898.9302729751574;995.0447570332417;12814.487420503076;13304.933475332562;14984;15266.007709498846;15546.37814487408;543355;631147;656307;657910;658920;48319;50205;57169.428305716414;57219;57271.42728572744;1382.5506710319187;1395.2674845706085;1411.0334420921702;1414.0384538513908;1420.0982376191193;28634.85682571574;29494;29544.96592619248;29613.703862961956;30109.548356774227;40117;48867.5113248863;48998;49025.26462103143;49048.75475622599;569992;572743;575015;575419;576378;42880.56124406503;43184.35223471713;43358;43370;43575;47094.76452617715;47138.528614714785;47351;47639.188864890035;48093;38445.2310953785;38895.6110438892;39951.600483994785;40009.71326058212;40548.59451405448;39016.41475377815;39349.409758853064;40261.59738402579;40560;40960.77117686474;37769.62230377771;37784.62215377811;37796.62203377931;38168;38532.22935541329;32940.01179964605;34057.148571285914;34647.65352346444;34659.65340346564;34848.30303393969;21800.34598962034;25994.35014124662;26003.21990340293;26305.868470657526;26406 04:00:26 INFO - PROCESS | 1653 | |2;jquery.html;336.7171078192088;359.5487662982958;365.3259735787472;367.5552581376536;374.77326217638347;15652.686946261068;19630.018499075042;20949;21216.469588260283;21569.352919412442;17331.82668173318;20697.586048279027;20901.790982090173;21288.787112128874;21357.67963480549;5972.372900845414;5990.191324171246;6219.160413344209;6244.406781355787;6273.68631568422;6033.456988871001;6075.513958883301;6195.938040619603;6207.782727604535;6208.596441231328;5597;6052;6193.7832175873855;6193.85413698465;6765.188177418717;6815.148106486689;6849.315068493136;6897.55165914219;6907.551009184437;6958.304169583052;5042.84871453857;5844.707764611795;6089.0866370044405;6097.756089756404;6104.236970378703;11259.774804503946;13150.473981040746;13379.331033448387;13456.461741530327;13473.393697283645;2147.881866497342;2253.5154941687615;2347.7534858839745;2647.272000199941;2683.651125353711;8755.693550725695;10019.549120289532;10221.540030698636;10471.267011309212;10573.577056917715;1830.3227805711838;1841.6500864835639;1853.8146185381488;1883.5479484923658;1911.4170178095676;79290.60354698189;79920.60039699823;94817;118395;121228.99999999911;9008.459492430475;9755.170810481046;9822;10094.343867648578;11796.88203117975;11717.531298748125;13781.448742050407;14507.927460362842;14641.707165856837;14664.706705866036;7687.385009199251;8533.53065581399;8573.099824518336;8755.080716524673;8843.159899809507;8346.582670866432;8454;8818.250448711802;8945.910540894507;8962.82074358509;4539.818407263672;4584.15193189261;4590.42619672541;4594.19601569724;4675.579197872208;1621.8783591230706;1960;1973.1318219983161;1981.7027445882945;2003.1186278037617;923.5613083785148;946.7443790176613;956.9091235990976;976.5263847034183;1002.1281485108003;15689.450869219523;21233.256836010667;21689.34931952044;21864;21914.890425547772;902.2195800632537;923.9630414783334;930.7580029192324;989.0554520432969;994.4033579852031;11110.500027498781;11485.483153258123;11631.76736465266;11643.476043578059;11691.473883675086;543868;546469;552610;555009;586798;123836.38081809533;131303.34348328388;132488.01267980988;135725;139596.30201848925;972.8394814855469;976.3019441099648;1005.8843233028296;1009.1472705563787;1009.7425156585024;19073.71389429132;19779.70330445016;19829.801701982797;19843.603127937073;19935;52570;56206.59483512781;56821;59406.70296648489;59680.70159649174;83028.58485707533;84316.9784329889;85360.71958920745;86381.70427443468;87942;5985.670788106696;7909.604519774103;8294.170582941899;8456.873146902679;8539.615717292612;7287.781366559012;9914.909359970254;13091.214527128403;13601.319934003062;13653;11302.660920172408;11442.542298307975;11451.942740286246;11715.355655438692;11719.76560468803;8979;11221.55113795439;11349.659510214708;11648.126390520576;11678.182527223013;10451.268411211142;10751.838722419327;11158.274712143684;11338.09295256394;11748.647540573797;8206.261436470746;8224.136465671258;8469.491830490191;8581.699640512801;8584.91415085841;9968.152707019985;11400.201985861242;11479;11688.824667629822;11882.643520694393 04:00:26 INFO - PROCESS | 1653 | |3;mootools.html;1277.4826195390865;1426.472205284045;1626.7559866020094;1829.7529833472486;1843.741876137342;7790.883136752939;7979.481333713319;8510.829783404328;9036.864447033291;9063.90936090639;7570.848583028336;8818.118188181179;8823.558822058887;8861.379703420764;8901.19889209971;2378.678878351426;2398.124684490166;2401.2196036288187;2404.3989002749313;2404.4229384947575;2352.9058837646476;2393.8563686178886;2395.592749232626;2400.8079353651665;2404.1224952892157;2367.7040369953756;2370.182287110944;2381.654660074288;2383.797377222938;2398.95202095958;2373.6202207646866;2388.534235824015;2392.820538459614;2405.1341517053847;2407.9398015049587;2347.6009078456705;2364.0307473935604;2369.4313364792497;2374.050379848057;2377.679013333195;8909.465432074032;8956.507392093432;8987.191152796215;8992.955035224848;9020.458772473672;5302.098643230622;5404.32445944257;5461.726913654302;5492.725363731797;5498.697571633558;3632.654897784706;3645.76302540334;3680.061584296014;3708.9985703859807;3711.1278849470355;1074.8925107489188;1078.309881675728;1078.563181911327;1098.549594666183;1104.8453216549608;11597.362145082017;11736.765264694744;11792.115591330685;11798.233114847593;11807.996320312785;4718.882027949328;4737.248422802164;4782.856514304576;4847.515248475124;4883.145449546315;8526.914730852735;10026.097651211427;10107.241956853266;10115.39307641544;10123.341982771097;5352.063388906926;5368.91946620801;5373.811916582901;5379.65032272901;5420.295361603045;4454.7549884756;4602.056578401487;4760.738159401197;4935.3090567320605;4935.851924442272;3301.620313663959;4026.5973402660084;4062.5734297898885;4087.2847251730827;4133.9793301033305;1331.3010669398643;1332.6934804994905;1342.2282187742087;1344.2337867415674;1351.5674984005025;914.2229105260608;919.1911118215927;921.0161845593796;925.4678559828126;954.8854137503544;4347.369631403492;5790.42095790426;6004.489618382399;6070.423309785563;6142.57002009855;814.4543156085437;935.6725146198776;936.2463217110155;951.6676652686157;992.1269283031031;3661.377565813818;4043.129358316865;4065.4714887064492;4087.838679927193;4120.237756015147;10433.686989390331;10777.946110269555;10798.082163016075;10807.67576972692;10815.78368432627;10689.412082335546;10811.78376432467;10836.783264334668;10850.511726972305;10851.457427128613;8129.634166462523;8148.06297275809;8184.6726130955285;8268.338532917352;8274.379421543408;5619.466150715675;5827.708614569339;5834;5994.400559943971;6071.180390647206;9932.354396964174;9949.751256218653;10005.249606279704;10066.597336106473;10131;9002.86495702578;10160.44117573511;10210.234232432746;10270.743231418975;10283.177345812466;6333.36666333363;6416.711247993758;6704.564203326768;7186.281371862772;7521.435892308208;8231.176882311722;8495.95752021236;8506.362022848187;8509.319254459751;8517.91482085196;6710.563813352116;6888;7141.607211603412;7312.670929808065;7427.071616047994;7332.266773322625;7374.778756637309;7429.517081389692;7456.701731930662;7502.512336698097;6997.370236678723;7025.648717564203;7075.929240707733;7093.82265443368;7098;5053.216751403538;5062.848114556569;5096.031753966735;5105.974470127774;5108.897822043613;5005.749712514433;5082.440931497458;5121.692698438105;5141.203113517411;5174.560162386088 04:00:26 INFO - PROCESS | 1653 | |4;prototype.html;302.38313839766874;305.4974566837552;310.84768463452906;314.9338638885834;316.5979206407862;4681.4616319123315;4953.281774142747;5152.098382783012;5595.8321250362505;5688.715564221788;5313.57491400688;5420.587838411909;5526.613137080406;5575.661841158123;5599.972000140004;3692.907677308062;4086.4891888513935;4229.873103806891;4245.68836307679;4293.690424420551;4135.04893874409;4160.126373461577;4270.914581708364;4273.807678654468;4279.422277992462;3279.8688052477873;3704.7962362070075;3917.9822391468415;3974.1852920151446;4185.856002557462;3447.6897079262862;3668.596454390015;3787.5381002348695;4183.728057676257;4254.893627659302;3236.87052517899;3550.982245088758;3694.353488139565;3694.8706795262306;3699.3711069118044;5173.249878767558;5229.816956406507;5353.330833645794;5363.168708850135;5437.456254374571;4418.425604671372;4791.448983366922;4829.227323628203;4835;4875.9764697650435;5358.33020872391;5514.862128446781;5589.860253493695;5756.798512052058;5804.738786754606;4023.839046438168;4038.9394159087637;4043.9081448008874;4049.805307434314;4077.612626800449;5900.262467191601;6129.172561704202;6193.473554747852;6197.659128747917;6206.317305096436;3643.3988391915036;3673.393890008119;3769.1330993871015;4128.483939507561;4153.314703073959;3318.551995480579;3811.4092315691114;4039.4546736190237;4039.636432721069;4053.7365071270274;4686.835960741358;4723.669343146015;4730.976345118322;4778.1399348116975;4781.976090119527;5137.33214682089;5719.8570035749435;5960.582759206901;5966.701664916737;5995.52035837132;1261.3377976562194;1343.355189509041;1356.3625096204769;1381.6683995840926;1382.143071295803;847.1867007672703;898.8471959766855;902.3007169443603;927.5733162745213;932.1005229953128;4905.435874874363;5227.607929405233;5315.358979099252;5429.6199266051;5501.394846566875;5168.483151684802;5960.821175364746;5964.224650795369;5968.612040217372;5995.250593675791;5124.104022273633;5368.275282836845;5471.917921231185;5472.972635136799;5481.698506582176;2522.070615978778;2645.6692913385828;2651.5624921888057;2671;2709.6883858356146;5211.42674305826;5238.842834714965;5266.709656134195;5294.49702278283;5330.693979974853;4621.376114224537;4950.935548857013;5143.3827940646615;5190.263010632339;5196.934628401169;4602.742463221573;4653.371794807726;5115.948840511547;5145.099607568585;5208.333333333373;4129.545749967441;4451.465824101128;4505.887352816075;4515.887102822456;4803.670219943255;4300.892477688083;4386.758728269976;4406.3035731244345;4989.675671081368;5068.695878247317;4342.80457379425;4815.711057336571;4916.852494425173;5213.843584692465;5233.607479439133;3023.9244018899703;3163.28826014145;3255.67443255682;3478.89563313101;3484.1812174139563;3592.8742494012586;4199.354406723744;4362.520122786555;4735.431748190239;4888.657793954531;4217.457335837911;4332.393464914978;4888.5111488850835;4894.804207831789;4909.312696222603;4292.960843599265;4327.805248763751;4358.428527168986;4876;4881.608741508653;4190.099128687347;4280.8929776754585;4664.79008444614;4741.719735671419;4884.7069175849565;3852.147852147852;4834.815470209821;4848.7090774553635;4853.563179313879;4910.558049775537;4266.957330426656;4474.5681381957465;4655.859314467977;4797.544233297831;4843.740627436962 04:00:26 INFO - PROCESS | 1653 | |5;yui.html;680.4182424027454;740.9481336306458;780.7930898311948;788.9644965976532;802.3460879383306;15444.69110617787;15475.071495710252;15574.454894078695;15725.60685982851;15807.209639518022;14204.147751134913;14217.786733198984;14220.502282420117;14237.92881035596;14318.856811431882;659.6470888074881;668.6188872342767;675.3685304240527;813.7558732380277;850.3877208409934;833;835.6490274084899;845.5603086395101;846.1031306814765;848.245061894914;804.4208170117506;899.6086702284495;903.4940433357308;907.1654078248027;909.8362294786936;895.2256298301987;900.2033200617468;901.0133903375793;902.801383695586;903.4624398482957;662.8177251255895;666.7199776094004;666.7199776094052;669.554746093847;670.718298314709;14626.561203163923;14760.926195368955;14815.48145814902;14829;14886.478973235884;14484.855151448455;14487.492937747129;14559.98080134391;14648.12111273327;14679.48621798232;9899.257555683353;11531.48108335127;11662.241954272946;12050.096242781827;12448.315342656151;3798.1454172811173;3802.429635554661;3853.2293541291574;3884.261990221849;3920.745151565168;100760.49619751854;125158.74841251654;126933;128770.35614821866;131056.6894331054;10651.520681569347;10738.033576978109;10930.836037459445;11264.0425563828;11442.427878606037;18816.87098774078;21796.455088622595;21821.345359639236;21933.780662193174;21962.584115747253;6831.28271531482;6920.5847649141215;7314.743983960642;7503.887441688379;8089.635966381527;4358.498772641186;4439.556044395599;4483.237849565582;4506.0312032912425;4538.364628951949;3309.23887505875;3608.6391360863704;3713.350163721338;3728.2357116790995;3751.437284407306;622.8941080016408;688.1466980943594;714.7712731925734;721.2607077745353;721.4480922094601;589.949854262384;664.6643445060214;684.1482354468718;687.9552829066095;702.3854127638316;7629.656665450068;7863.567503787347;8884.600192991331;9061.032863849712;9440.433573985583;547.6878179437762;574.5719439017874;599.4215581963426;608.5314307982828;651.4625434016955;4606.378138951266;4776.665633405698;4785.952140478551;4796.37647105881;4818.229083346718;164744;168424;169008;172169;174998;140173.59826401607;141790;143801.28099359645;143893.56106439012;148024;123630;123696;124447.9999999982;125451.3727431357;125844.37077814553;9025.41334813235;9110.635574576943;9127.680531181377;9195.632174712937;9234.353595248536;66477.33522664712;67592.32407676057;69088;69295.65352173206;71015.64492177506;87838.121618783;97178.51410742901;105042;105100.42349364613;107397.46301268444;11660.941695291469;11805.173637845612;11916.702082448008;12083.879161208275;12147.635570932885;12825.42285597169;12995.870041299466;13067.150635208682;13134.474621015052;13362.732745344843;11342.376169310437;11670.591529296435;11991;12254.938725306316;13354.998375122099;13498.122622029538;13571.59285221445;13624.04631675773;13867.375968081662;14052.437902483785;12689.492420303084;13138.605841824761;14001.159930404208;14102;14110;9658.420494770337;11072.391018493738;11379.487923043318;11729.35488548104;11760.647180584596;11160.944195278971;11616.303021818718;11720.88279117232;11734.530618775494;11781.352025638673 04:00:26 INFO - PROCESS | 1653 | __end_tp_report 04:00:26 INFO - PROCESS | 1653 | __start_cc_report 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,368 04:00:26 INFO - PROCESS | 1653 | __end_cc_report 04:00:26 INFO - PROCESS | 1653 | __startTimestamp1476097226085__endTimestamp 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:00:26 INFO - PROCESS | 1653 | Number of tests: 6 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5789.76 Median:6017.16 stddev:685.51 (11.4%) stddev-sans-first:649.68 04:00:26 INFO - PROCESS | 1653 | Values: 2923.1 3391.6 3420.4 3462.7 3466.0 5739.3 5757.8 5772.3 5796.2 5828.3 4823.4 5804.1 5819.1 5881.2 5882.9 4389.2 5239.8 5311.2 5355.6 5357.7 5348.0 5380.6 5386.1 5400.9 5419.8 5263.5 5268.8 5370.1 5371.3 5384.7 5244.6 5283.0 5309.0 5320.3 5375.8 5173.3 5254.3 5271.3 5273.6 5275.6 5665.7 5700.9 5773.4 5839.7 5896.1 6176.2 6208.3 6243.0 6278.8 6351.2 5240.0 6276.9 6342.9 6350.9 6354.4 5931.3 5936.0 5936.9 5938.9 5943.2 6266.0 6312.8 6324.7 6326.8 6327.9 6218.9 6282.0 6282.7 6283.1 6287.7 6256.7 6338.4 6346.8 6352.6 6365.2 6154.1 6208.8 6214.7 6234.0 6304.7 6268.9 6285.4 6311.5 6347.3 6388.9 4998.5 5006.0 5011.1 5015.6 5026.8 4379.1 4429.3 4442.1 4453.7 4467.9 5899.4 5903.3 5911.0 5955.4 6009.2 6250.6 6319.7 6323.5 6328.6 6329.6 5014.9 5680.7 5880.2 5896.1 5939.9 4958.9 5501.8 5516.9 5527.0 5527.1 6485.4 6488.3 6508.6 6511.4 6512.7 6196.8 6222.0 6246.3 6248.0 6291.5 6362.3 6402.1 6430.9 6448.4 6479.8 6276.5 6318.1 6327.4 6334.5 6335.1 5139.8 6145.7 6184.7 6297.8 6317.0 4630.4 6252.8 6255.7 6265.6 6269.6 5084.0 6201.5 6223.8 6264.7 6274.6 5932.9 5961.2 6017.2 6082.1 6166.7 6131.3 6152.6 6211.5 6248.9 6290.6 5070.6 6100.0 6104.6 6112.6 6119.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70627.66 Median:43142.07 stddev:151642.67 (351.5%) stddev-sans-first:151976.54 04:00:26 INFO - PROCESS | 1653 | Values: 453.9 456.9 463.9 468.9 554.7 38454.2 40456.8 40492.0 42823.8 42916.4 42334.8 43053.0 43134.1 43150.0 43154.8 9730.7 9878.9 9881.0 9900.2 9911.8 9741.0 9852.2 9857.3 9871.0 9906.0 9858.9 9879.0 9883.5 9901.9 9906.8 9813.4 9852.6 9856.9 9868.8 9870.7 9688.2 9750.2 9756.0 9863.5 9867.3 40065.6 40365.0 40423.4 40474.6 40724.8 3397.1 3433.0 3442.3 3916.6 3936.7 29954.1 30244.7 30567.8 31571.0 31915.2 3248.5 3271.9 3314.5 3335.0 3348.8 487311.0 490394.0 491155.5 491708.0 495357.0 58101.0 58516.4 58628.0 64836.7 66962.7 65753.7 69698.0 70523.3 70666.0 70959.0 17339.2 17460.7 17541.3 17594.5 17606.4 13164.9 13184.8 13327.9 13328.7 13350.5 20050.8 20446.6 20670.9 20685.5 20744.5 7168.0 8400.2 8495.4 8504.3 8518.2 772.1 949.2 965.4 986.2 1048.4 26472.9 29339.0 30135.2 30402.5 30769.8 817.5 821.4 826.0 898.9 995.0 12814.5 13304.9 14984.0 15266.0 15546.4 543355.0 631147.0 656307.0 657910.0 658920.0 48319.0 50205.0 57169.4 57219.0 57271.4 1382.6 1395.3 1411.0 1414.0 1420.1 28634.9 29494.0 29545.0 29613.7 30109.5 40117.0 48867.5 48998.0 49025.3 49048.8 569992.0 572743.0 575015.0 575419.0 576378.0 42880.6 43184.4 43358.0 43370.0 43575.0 47094.8 47138.5 47351.0 47639.2 48093.0 38445.2 38895.6 39951.6 40009.7 40548.6 39016.4 39349.4 40261.6 40560.0 40960.8 37769.6 37784.6 37796.6 38168.0 38532.2 32940.0 34057.1 34647.7 34659.7 34848.3 21800.3 25994.4 26003.2 26305.9 26406.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33454.48 Median:366.44 stddev:93332.26 (25470.0%) stddev-sans-first:93560.96 04:00:26 INFO - PROCESS | 1653 | Values: 336.7 359.5 365.3 367.6 374.8 15652.7 19630.0 20949.0 21216.5 21569.4 17331.8 20697.6 20901.8 21288.8 21357.7 5972.4 5990.2 6219.2 6244.4 6273.7 6033.5 6075.5 6195.9 6207.8 6208.6 5597.0 6052.0 6193.8 6193.9 6765.2 6815.1 6849.3 6897.6 6907.6 6958.3 5042.8 5844.7 6089.1 6097.8 6104.2 11259.8 13150.5 13379.3 13456.5 13473.4 2147.9 2253.5 2347.8 2647.3 2683.7 8755.7 10019.5 10221.5 10471.3 10573.6 1830.3 1841.7 1853.8 1883.5 1911.4 79290.6 79920.6 94817.0 118395.0 121229.0 9008.5 9755.2 9822.0 10094.3 11796.9 11717.5 13781.4 14507.9 14641.7 14664.7 7687.4 8533.5 8573.1 8755.1 8843.2 8346.6 8454.0 8818.3 8945.9 8962.8 4539.8 4584.2 4590.4 4594.2 4675.6 1621.9 1960.0 1973.1 1981.7 2003.1 923.6 946.7 956.9 976.5 1002.1 15689.5 21233.3 21689.3 21864.0 21914.9 902.2 924.0 930.8 989.1 994.4 11110.5 11485.5 11631.8 11643.5 11691.5 543868.0 546469.0 552610.0 555009.0 586798.0 123836.4 131303.3 132488.0 135725.0 139596.3 972.8 976.3 1005.9 1009.1 1009.7 19073.7 19779.7 19829.8 19843.6 19935.0 52570.0 56206.6 56821.0 59406.7 59680.7 83028.6 84317.0 85360.7 86381.7 87942.0 5985.7 7909.6 8294.2 8456.9 8539.6 7287.8 9914.9 13091.2 13601.3 13653.0 11302.7 11442.5 11451.9 11715.4 11719.8 8979.0 11221.6 11349.7 11648.1 11678.2 10451.3 10751.8 11158.3 11338.1 11748.6 8206.3 8224.1 8469.5 8581.7 8584.9 9968.2 11400.2 11479.0 11688.8 11882.6 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5712.31 Median:4935.58 stddev:3183.76 (64.5%) stddev-sans-first:3175.25 04:00:26 INFO - PROCESS | 1653 | Values: 1277.5 1426.5 1626.8 1829.8 1843.7 7790.9 7979.5 8510.8 9036.9 9063.9 7570.8 8818.1 8823.6 8861.4 8901.2 2378.7 2398.1 2401.2 2404.4 2404.4 2352.9 2393.9 2395.6 2400.8 2404.1 2367.7 2370.2 2381.7 2383.8 2399.0 2373.6 2388.5 2392.8 2405.1 2407.9 2347.6 2364.0 2369.4 2374.1 2377.7 8909.5 8956.5 8987.2 8993.0 9020.5 5302.1 5404.3 5461.7 5492.7 5498.7 3632.7 3645.8 3680.1 3709.0 3711.1 1074.9 1078.3 1078.6 1098.5 1104.8 11597.4 11736.8 11792.1 11798.2 11808.0 4718.9 4737.2 4782.9 4847.5 4883.1 8526.9 10026.1 10107.2 10115.4 10123.3 5352.1 5368.9 5373.8 5379.7 5420.3 4454.8 4602.1 4760.7 4935.3 4935.9 3301.6 4026.6 4062.6 4087.3 4134.0 1331.3 1332.7 1342.2 1344.2 1351.6 914.2 919.2 921.0 925.5 954.9 4347.4 5790.4 6004.5 6070.4 6142.6 814.5 935.7 936.2 951.7 992.1 3661.4 4043.1 4065.5 4087.8 4120.2 10433.7 10777.9 10798.1 10807.7 10815.8 10689.4 10811.8 10836.8 10850.5 10851.5 8129.6 8148.1 8184.7 8268.3 8274.4 5619.5 5827.7 5834.0 5994.4 6071.2 9932.4 9949.8 10005.2 10066.6 10131.0 9002.9 10160.4 10210.2 10270.7 10283.2 6333.4 6416.7 6704.6 7186.3 7521.4 8231.2 8496.0 8506.4 8509.3 8517.9 6710.6 6888.0 7141.6 7312.7 7427.1 7332.3 7374.8 7429.5 7456.7 7502.5 6997.4 7025.6 7075.9 7093.8 7098.0 5053.2 5062.8 5096.0 5106.0 5108.9 5005.7 5082.4 5121.7 5141.2 5174.6 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4331.21 Median:4733.20 stddev:1310.29 (27.7%) stddev-sans-first:1278.60 04:00:26 INFO - PROCESS | 1653 | Values: 302.4 305.5 310.8 314.9 316.6 4681.5 4953.3 5152.1 5595.8 5688.7 5313.6 5420.6 5526.6 5575.7 5600.0 3692.9 4086.5 4229.9 4245.7 4293.7 4135.0 4160.1 4270.9 4273.8 4279.4 3279.9 3704.8 3918.0 3974.2 4185.9 3447.7 3668.6 3787.5 4183.7 4254.9 3236.9 3551.0 3694.4 3694.9 3699.4 5173.2 5229.8 5353.3 5363.2 5437.5 4418.4 4791.4 4829.2 4835.0 4876.0 5358.3 5514.9 5589.9 5756.8 5804.7 4023.8 4038.9 4043.9 4049.8 4077.6 5900.3 6129.2 6193.5 6197.7 6206.3 3643.4 3673.4 3769.1 4128.5 4153.3 3318.6 3811.4 4039.5 4039.6 4053.7 4686.8 4723.7 4731.0 4778.1 4782.0 5137.3 5719.9 5960.6 5966.7 5995.5 1261.3 1343.4 1356.4 1381.7 1382.1 847.2 898.8 902.3 927.6 932.1 4905.4 5227.6 5315.4 5429.6 5501.4 5168.5 5960.8 5964.2 5968.6 5995.3 5124.1 5368.3 5471.9 5473.0 5481.7 2522.1 2645.7 2651.6 2671.0 2709.7 5211.4 5238.8 5266.7 5294.5 5330.7 4621.4 4950.9 5143.4 5190.3 5196.9 4602.7 4653.4 5115.9 5145.1 5208.3 4129.5 4451.5 4505.9 4515.9 4803.7 4300.9 4386.8 4406.3 4989.7 5068.7 4342.8 4815.7 4916.9 5213.8 5233.6 3023.9 3163.3 3255.7 3478.9 3484.2 3592.9 4199.4 4362.5 4735.4 4888.7 4217.5 4332.4 4888.5 4894.8 4909.3 4293.0 4327.8 4358.4 4876.0 4881.6 4190.1 4280.9 4664.8 4741.7 4884.7 3852.1 4834.8 4848.7 4853.6 4910.6 4267.0 4474.6 4655.9 4797.5 4843.7 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:26900.34 Median:12635.91 stddev:44826.05 (354.8%) stddev-sans-first:44908.57 04:00:26 INFO - PROCESS | 1653 | Values: 680.4 740.9 780.8 789.0 802.3 15444.7 15475.1 15574.5 15725.6 15807.2 14204.1 14217.8 14220.5 14237.9 14318.9 659.6 668.6 675.4 813.8 850.4 833.0 835.6 845.6 846.1 848.2 804.4 899.6 903.5 907.2 909.8 895.2 900.2 901.0 902.8 903.5 662.8 666.7 666.7 669.6 670.7 14626.6 14760.9 14815.5 14829.0 14886.5 14484.9 14487.5 14560.0 14648.1 14679.5 9899.3 11531.5 11662.2 12050.1 12448.3 3798.1 3802.4 3853.2 3884.3 3920.7 100760.5 125158.7 126933.0 128770.4 131056.7 10651.5 10738.0 10930.8 11264.0 11442.4 18816.9 21796.5 21821.3 21933.8 21962.6 6831.3 6920.6 7314.7 7503.9 8089.6 4358.5 4439.6 4483.2 4506.0 4538.4 3309.2 3608.6 3713.4 3728.2 3751.4 622.9 688.1 714.8 721.3 721.4 589.9 664.7 684.1 688.0 702.4 7629.7 7863.6 8884.6 9061.0 9440.4 547.7 574.6 599.4 608.5 651.5 4606.4 4776.7 4786.0 4796.4 4818.2 164744.0 168424.0 169008.0 172169.0 174998.0 140173.6 141790.0 143801.3 143893.6 148024.0 123630.0 123696.0 124448.0 125451.4 125844.4 9025.4 9110.6 9127.7 9195.6 9234.4 66477.3 67592.3 69088.0 69295.7 71015.6 87838.1 97178.5 105042.0 105100.4 107397.5 11660.9 11805.2 11916.7 12083.9 12147.6 12825.4 12995.9 13067.2 13134.5 13362.7 11342.4 11670.6 11991.0 12254.9 13355.0 13498.1 13571.6 13624.0 13867.4 14052.4 12689.5 13138.6 14001.2 14102.0 14110.0 9658.4 11072.4 11379.5 11729.4 11760.6 11160.9 11616.3 11720.9 11734.5 11781.4 04:00:26 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - TEST-INFO | 1653: exit 0 04:00:26 INFO - TEST-OK | dromaeo_css | took 1113680ms 04:00:26 INFO - TEST-START | kraken 04:00:26 INFO - operating with platform_type : mac_ 04:00:26 INFO - Initialising browser for kraken test... 04:00:26 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpr2w8xa/profile http://localhost:49266/getInfo.html) 04:00:29 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 04:00:29 INFO - PROCESS | 1671 | colorDepth:24 04:00:29 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 04:00:29 INFO - PROCESS | 1671 | __metrics 04:00:29 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 04:00:30 INFO - TEST-INFO | 1671: exit 0 04:00:30 INFO - Browser initialized. 04:00:30 INFO - Running cycle 1/1 for kraken test... 04:00:30 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpr2w8xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:42 INFO - PROCESS | 1673 | RSS: Main: 225533952 04:00:42 INFO - PROCESS | 1673 | 04:00:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:45 INFO - PROCESS | 1673 | RSS: Main: 237674496 04:00:45 INFO - PROCESS | 1673 | 04:00:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 04:00:49 INFO - PROCESS | 1673 | RSS: Main: 245215232 04:00:49 INFO - PROCESS | 1673 | 04:00:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 04:00:52 INFO - PROCESS | 1673 | RSS: Main: 248836096 04:00:52 INFO - PROCESS | 1673 | 04:00:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 04:00:55 INFO - PROCESS | 1673 | RSS: Main: 249159680 04:00:55 INFO - PROCESS | 1673 | 04:00:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:58 INFO - PROCESS | 1673 | RSS: Main: 249360384 04:00:58 INFO - PROCESS | 1673 | 04:01:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:01 INFO - PROCESS | 1673 | RSS: Main: 250159104 04:01:01 INFO - PROCESS | 1673 | 04:01:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:05 INFO - PROCESS | 1673 | RSS: Main: 251330560 04:01:05 INFO - PROCESS | 1673 | 04:01:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 04:01:08 INFO - PROCESS | 1673 | RSS: Main: 251965440 04:01:08 INFO - PROCESS | 1673 | 04:01:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:10 INFO - PROCESS | 1673 | RSS: Main: 251351040 04:01:10 INFO - PROCESS | 1673 | 04:01:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:13 INFO - PROCESS | 1673 | RSS: Main: 251424768 04:01:13 INFO - PROCESS | 1673 | 04:01:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:16 INFO - PROCESS | 1673 | RSS: Main: 251375616 04:01:16 INFO - PROCESS | 1673 | 04:01:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:19 INFO - PROCESS | 1673 | RSS: Main: 251465728 04:01:19 INFO - PROCESS | 1673 | 04:01:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:23 INFO - PROCESS | 1673 | RSS: Main: 251801600 04:01:23 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 04:01:25 INFO - PROCESS | 1673 | RSS: Main: 253571072 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | __start_tp_report 04:01:25 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 04:01:25 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 04:01:25 INFO - PROCESS | 1673 | |i|pagename|runs| 04:01:25 INFO - PROCESS | 1673 | |0;ai-astar;105;120;118;116;121;117;117;118;118;117 04:01:25 INFO - PROCESS | 1673 | |1;audio-beat-detection;137;130;140;140;111;144;114;111;137;108 04:01:25 INFO - PROCESS | 1673 | |2;audio-dft;196;201;196;197;194;193;198;193;200;191 04:01:25 INFO - PROCESS | 1673 | |3;audio-fft;83;59;60;84;62;51;60;83;107;50 04:01:25 INFO - PROCESS | 1673 | |4;audio-oscillator;84;70;90;72;69;70;88;70;70;72 04:01:25 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;90;87;94;132;130;86;90;89;92;85 04:01:25 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;98;97;95;122;101;139;96;114;151 04:01:25 INFO - PROCESS | 1673 | |7;imaging-desaturate;93;96;104;150;90;98;90;90;89;91 04:01:25 INFO - PROCESS | 1673 | |8;json-parse-financial;58;55;57;57;59;59;61;60;60;84 04:01:25 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;77;70;83;79;77;60;83;103;104 04:01:25 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;87;105;107;103;82;85;84;81;86;72 04:01:25 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;139;140;152;151;135;141;145;144;168;153 04:01:25 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;167;168;166;166;179;209;165;166;162;165 04:01:25 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;62;84;91;67;69;68;69;80;66;69 04:01:25 INFO - PROCESS | 1673 | __end_tp_report 04:01:25 INFO - PROCESS | 1673 | __start_cc_report 04:01:25 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,943 04:01:25 INFO - PROCESS | 1673 | __end_cc_report 04:01:25 INFO - PROCESS | 1673 | __startTimestamp1476097285383__endTimestamp 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | ------- Summary: start ------- 04:01:25 INFO - PROCESS | 1673 | Number of tests: 14 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:4.37 (3.7%) stddev-sans-first:1.58 04:01:25 INFO - PROCESS | 1673 | Values: 105.0 120.0 118.0 116.0 121.0 117.0 117.0 118.0 118.0 117.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:137.00 stddev:14.44 (10.5%) stddev-sans-first:14.88 04:01:25 INFO - PROCESS | 1673 | Values: 137.0 130.0 140.0 140.0 111.0 144.0 114.0 111.0 137.0 108.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:195.90 Median:196.50 stddev:3.21 (1.6%) stddev-sans-first:3.41 04:01:25 INFO - PROCESS | 1673 | Values: 196.0 201.0 196.0 197.0 194.0 193.0 198.0 193.0 200.0 191.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:69.90 Median:61.00 stddev:18.41 (30.2%) stddev-sans-first:18.90 04:01:25 INFO - PROCESS | 1673 | Values: 83.0 59.0 60.0 84.0 62.0 51.0 60.0 83.0 107.0 50.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:72.00 stddev:8.34 (11.6%) stddev-sans-first:8.26 04:01:25 INFO - PROCESS | 1673 | Values: 84.0 70.0 90.0 72.0 69.0 70.0 88.0 70.0 70.0 72.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:89.50 stddev:17.87 (20.0%) stddev-sans-first:18.74 04:01:25 INFO - PROCESS | 1673 | Values: 90.0 87.0 94.0 132.0 130.0 86.0 90.0 89.0 92.0 85.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:110.80 Median:95.00 stddev:20.32 (21.4%) stddev-sans-first:20.73 04:01:25 INFO - PROCESS | 1673 | Values: 95.0 98.0 97.0 95.0 122.0 101.0 139.0 96.0 114.0 151.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:90.50 stddev:18.50 (20.4%) stddev-sans-first:19.49 04:01:25 INFO - PROCESS | 1673 | Values: 93.0 96.0 104.0 150.0 90.0 98.0 90.0 90.0 89.0 91.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.50 stddev:8.27 (13.9%) stddev-sans-first:8.70 04:01:25 INFO - PROCESS | 1673 | Values: 58.0 55.0 57.0 57.0 59.0 59.0 61.0 60.0 60.0 84.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:77.00 stddev:14.29 (18.6%) stddev-sans-first:14.20 04:01:25 INFO - PROCESS | 1673 | Values: 66.0 77.0 70.0 83.0 79.0 77.0 60.0 83.0 103.0 104.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:83.00 stddev:11.70 (14.1%) stddev-sans-first:12.38 04:01:25 INFO - PROCESS | 1673 | Values: 87.0 105.0 107.0 103.0 82.0 85.0 84.0 81.0 86.0 72.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:148.00 stddev:9.57 (6.5%) stddev-sans-first:9.72 04:01:25 INFO - PROCESS | 1673 | Values: 139.0 140.0 152.0 151.0 135.0 141.0 145.0 144.0 168.0 153.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:166.50 stddev:13.98 (8.4%) stddev-sans-first:14.75 04:01:25 INFO - PROCESS | 1673 | Values: 167.0 168.0 166.0 166.0 179.0 209.0 165.0 166.0 162.0 165.0 04:01:25 INFO - PROCESS | 1673 | 04:01:25 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:69.00 stddev:9.25 (13.4%) stddev-sans-first:9.00 04:01:25 INFO - PROCESS | 1673 | Values: 62.0 84.0 91.0 67.0 69.0 68.0 69.0 80.0 66.0 69.0 04:01:25 INFO - PROCESS | 1673 | -------- Summary: end -------- 04:01:25 INFO - PROCESS | 1673 | 04:01:26 INFO - TEST-INFO | 1673: exit 0 04:01:26 INFO - TEST-OK | kraken | took 59505ms 04:01:26 INFO - SUITE-END | took 1173s 04:01:26 INFO - Completed test suite (00:19:33) 04:01:26 INFO - javascript benchmark 04:01:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.103008034885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.050008747157, 3391.609964854041, 3420.3672320620685, 3462.688358047775, 3465.98267008665, 5739.339975902767, 5757.769689212431, 5772.3361813391475, 5796.159556864252, 5828.3297420796625, 4823.397075365579, 5804.100364443508, 5819.068948968166, 5881.176635271055, 5882.941070607289, 4389.209942210401, 5239.764210610531, 5311.176767601028, 5355.598330125236, 5357.732113394334, 5347.983883062225, 5380.623356365037, 5386.138217885139, 5400.864978375533, 5419.783208671648, 5263.526282634562, 5268.841934741964, 5370.113931201347, 5371.301730775013, 5384.703841288728, 5244.580433565325, 5283.049051170788, 5308.973455132699, 5320.255164277004, 5375.75809088592, 5173.327467429248, 5254.264402983586, 5271.28837606922, 5273.551748101416, 5275.630705850592, 5665.716714164275, 5700.8859822803315, 5773.364929857712, 5839.737211825435, 5896.056630939029, 6176.166217560617, 6208.317085120633, 6243.001119820807, 6278.843028924268, 6351.2060992375955, 5239.973800131013, 6276.905846412307, 6342.904856427157, 6350.904736428957, 6354.3963323484195, 5931.3178984417345, 5935.990881550104, 5936.851578710567, 5938.940610593882, 5943.227380440515, 6266.028765541349, 6312.779052733133, 6324.747010119636, 6326.778562750282, 6327.873442531123, 6218.9378106218355, 6282.0, 6282.654454004982, 6283.05754136874, 6287.685615719196, 6256.6871656417, 6338.429541341301, 6346.777862774781, 6352.555321127569, 6365.204349456318, 6154.076888466676, 6208.782692605737, 6214.658193799294, 6233.968830155911, 6304.65324407162, 6268.905966410507, 6285.402886725754, 6311.463525600284, 6347.301796802348, 6388.904166437507, 4998.500149985045, 5006.0, 5011.123053465629, 5015.623828212899, 5026.824061157842, 4379.146066516999, 4429.269170586817, 4442.133783912171, 4453.710508816916, 4467.888302792391, 5899.410058994066, 5903.291605007426, 5910.970445147746, 5955.40445955401, 6009.248843894513, 6250.624962502265, 6319.684015799192, 6323.462505686976, 6328.588641738273, 6329.620222786648, 5014.899702006012, 5680.715964201773, 5880.206172166788, 5896.056630939115, 5939.910901336483, 4958.884251043559, 5501.752421141058, 5516.889662206733, 5527.032769265443, 5527.088030475007, 6485.3514648534765, 6488.31872653374, 6508.60948343101, 6511.446527045254, 6512.706928188148, 6196.845078873064, 6221.96889015552, 6246.250449946036, 6248.0, 6291.496680265659, 6362.300146983735, 6402.135711678864, 6430.935690643034, 6448.387403196689, 6479.773207937699, 6276.466500347522, 6318.0838778375955, 6327.3988971047675, 6334.461570766536, 6335.144755458138, 5139.792148845093, 6145.740123274807, 6184.6598437086395, 6297.842553936005, 6317.0, 4630.351750754964, 6252.781152659817, 6255.749770009149, 6265.592736472115, 6269.623822570478, 5084.0, 6201.503879689524, 6223.844403889939, 6264.749410023548, 6274.560780745486, 5932.8813423732145, 5961.225040744675, 6017.15759793638, 6082.11809287642, 6166.691665416801, 6131.3460828618745, 6152.630842149485, 6211.503079753518, 6248.937510624835, 6290.559660823698, 5070.569001634754, 6099.969500152471, 6104.572679912363, 6112.633242005494, 6118.969405152946], "value": 5746.777851782332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.8593036158791, 456.8971981304206, 463.8562045765815, 468.8546550569326, 554.6533416614615, 38454.230915381675, 40456.79771601142, 40492.0, 42823.78588107055, 42916.3562546562, 42334.788326058406, 43053.0, 43134.13731725363, 43150.0, 43154.784226078824, 9730.70807875763, 9878.901210987906, 9880.950595247014, 9900.207983361313, 9911.801763964717, 9741.0, 9852.211823054175, 9857.260705447085, 9871.0, 9906.009399060109, 9858.901410985905, 9879.0, 9883.50582470877, 9901.900980990169, 9906.801863962752, 9813.362131461468, 9852.556634951445, 9856.852147217798, 9868.753281167956, 9870.703878883645, 9688.224942004623, 9750.171235444996, 9755.951220243924, 9863.457509836957, 9867.259955503294, 40065.59934400648, 40365.0, 40423.393649095284, 40474.59525404737, 40724.796376018225, 3397.133730898605, 3433.0215888471666, 3442.277121804424, 3916.6475017248586, 3936.665383442411, 29954.101376958508, 30244.69755302441, 30567.847160764275, 31571.0, 31915.202119947186, 3248.4640034394297, 3271.9182020449443, 3314.4531152360073, 3334.9666503334897, 3348.7655864089525, 487311.0, 490394.0, 491155.54422228015, 491708.0, 495357.0, 58101.0, 58516.414835851945, 58628.0, 64836.67581662061, 66962.66518667375, 65753.68492630216, 69698.0, 70523.29476705269, 70666.0, 70959.0, 17339.21973511195, 17460.650786984443, 17541.29834806619, 17594.472165835046, 17606.383776568015, 13164.946804255636, 13184.802227966587, 13327.933360333136, 13328.6667833303, 13350.532731354357, 20050.799492005186, 20446.591068178554, 20670.896645516677, 20685.482862928548, 20744.48138796542, 7167.964160179165, 8400.201980811813, 8495.362847786317, 8504.277136443472, 8518.190771876785, 772.0773675457774, 949.1681055562692, 965.4303960663242, 986.1962500562163, 1048.4286064095086, 26472.8676356617, 29339.0, 30135.246618834706, 30402.54396184059, 30769.846150769103, 817.5380909785952, 821.3593397150232, 826.0417915218318, 898.9302729751574, 995.0447570332417, 12814.487420503076, 13304.933475332562, 14984.0, 15266.007709498846, 15546.37814487408, 543355.0, 631147.0, 656307.0, 657910.0, 658920.0, 48319.0, 50205.0, 57169.428305716414, 57219.0, 57271.42728572744, 1382.5506710319187, 1395.2674845706085, 1411.0334420921702, 1414.0384538513908, 1420.0982376191193, 28634.85682571574, 29494.0, 29544.96592619248, 29613.703862961956, 30109.548356774227, 40117.0, 48867.5113248863, 48998.0, 49025.26462103143, 49048.75475622599, 569992.0, 572743.0, 575015.0, 575419.0, 576378.0, 42880.56124406503, 43184.35223471713, 43358.0, 43370.0, 43575.0, 47094.76452617715, 47138.528614714785, 47351.0, 47639.188864890035, 48093.0, 38445.2310953785, 38895.6110438892, 39951.600483994785, 40009.71326058212, 40548.59451405448, 39016.41475377815, 39349.409758853064, 40261.59738402579, 40560.0, 40960.77117686474, 37769.62230377771, 37784.62215377811, 37796.62203377931, 38168.0, 38532.22935541329, 32940.01179964605, 34057.148571285914, 34647.65352346444, 34659.65340346564, 34848.30303393969, 21800.34598962034, 25994.35014124662, 26003.21990340293, 26305.868470657526, 26406.0], "value": 20388.469707772365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7171078192088, 359.5487662982958, 365.3259735787472, 367.5552581376536, 374.77326217638347, 15652.686946261068, 19630.018499075042, 20949.0, 21216.469588260283, 21569.352919412442, 17331.82668173318, 20697.586048279027, 20901.790982090173, 21288.787112128874, 21357.67963480549, 5972.372900845414, 5990.191324171246, 6219.160413344209, 6244.406781355787, 6273.68631568422, 6033.456988871001, 6075.513958883301, 6195.938040619603, 6207.782727604535, 6208.596441231328, 5597.0, 6052.0, 6193.7832175873855, 6193.85413698465, 6765.188177418717, 6815.148106486689, 6849.315068493136, 6897.55165914219, 6907.551009184437, 6958.304169583052, 5042.84871453857, 5844.707764611795, 6089.0866370044405, 6097.756089756404, 6104.236970378703, 11259.774804503946, 13150.473981040746, 13379.331033448387, 13456.461741530327, 13473.393697283645, 2147.881866497342, 2253.5154941687615, 2347.7534858839745, 2647.272000199941, 2683.651125353711, 8755.693550725695, 10019.549120289532, 10221.540030698636, 10471.267011309212, 10573.577056917715, 1830.3227805711838, 1841.6500864835639, 1853.8146185381488, 1883.5479484923658, 1911.4170178095676, 79290.60354698189, 79920.60039699823, 94817.0, 118395.0, 121228.99999999911, 9008.459492430475, 9755.170810481046, 9822.0, 10094.343867648578, 11796.88203117975, 11717.531298748125, 13781.448742050407, 14507.927460362842, 14641.707165856837, 14664.706705866036, 7687.385009199251, 8533.53065581399, 8573.099824518336, 8755.080716524673, 8843.159899809507, 8346.582670866432, 8454.0, 8818.250448711802, 8945.910540894507, 8962.82074358509, 4539.818407263672, 4584.15193189261, 4590.42619672541, 4594.19601569724, 4675.579197872208, 1621.8783591230706, 1960.0, 1973.1318219983161, 1981.7027445882945, 2003.1186278037617, 923.5613083785148, 946.7443790176613, 956.9091235990976, 976.5263847034183, 1002.1281485108003, 15689.450869219523, 21233.256836010667, 21689.34931952044, 21864.0, 21914.890425547772, 902.2195800632537, 923.9630414783334, 930.7580029192324, 989.0554520432969, 994.4033579852031, 11110.500027498781, 11485.483153258123, 11631.76736465266, 11643.476043578059, 11691.473883675086, 543868.0, 546469.0, 552610.0, 555009.0, 586798.0, 123836.38081809533, 131303.34348328388, 132488.01267980988, 135725.0, 139596.30201848925, 972.8394814855469, 976.3019441099648, 1005.8843233028296, 1009.1472705563787, 1009.7425156585024, 19073.71389429132, 19779.70330445016, 19829.801701982797, 19843.603127937073, 19935.0, 52570.0, 56206.59483512781, 56821.0, 59406.70296648489, 59680.70159649174, 83028.58485707533, 84316.9784329889, 85360.71958920745, 86381.70427443468, 87942.0, 5985.670788106696, 7909.604519774103, 8294.170582941899, 8456.873146902679, 8539.615717292612, 7287.781366559012, 9914.909359970254, 13091.214527128403, 13601.319934003062, 13653.0, 11302.660920172408, 11442.542298307975, 11451.942740286246, 11715.355655438692, 11719.76560468803, 8979.0, 11221.55113795439, 11349.659510214708, 11648.126390520576, 11678.182527223013, 10451.268411211142, 10751.838722419327, 11158.274712143684, 11338.09295256394, 11748.647540573797, 8206.261436470746, 8224.136465671258, 8469.491830490191, 8581.699640512801, 8584.91415085841, 9968.152707019985, 11400.201985861242, 11479.0, 11688.824667629822, 11882.643520694393], "value": 9447.466953845067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.4826195390865, 1426.472205284045, 1626.7559866020094, 1829.7529833472486, 1843.741876137342, 7790.883136752939, 7979.481333713319, 8510.829783404328, 9036.864447033291, 9063.90936090639, 7570.848583028336, 8818.118188181179, 8823.558822058887, 8861.379703420764, 8901.19889209971, 2378.678878351426, 2398.124684490166, 2401.2196036288187, 2404.3989002749313, 2404.4229384947575, 2352.9058837646476, 2393.8563686178886, 2395.592749232626, 2400.8079353651665, 2404.1224952892157, 2367.7040369953756, 2370.182287110944, 2381.654660074288, 2383.797377222938, 2398.95202095958, 2373.6202207646866, 2388.534235824015, 2392.820538459614, 2405.1341517053847, 2407.9398015049587, 2347.6009078456705, 2364.0307473935604, 2369.4313364792497, 2374.050379848057, 2377.679013333195, 8909.465432074032, 8956.507392093432, 8987.191152796215, 8992.955035224848, 9020.458772473672, 5302.098643230622, 5404.32445944257, 5461.726913654302, 5492.725363731797, 5498.697571633558, 3632.654897784706, 3645.76302540334, 3680.061584296014, 3708.9985703859807, 3711.1278849470355, 1074.8925107489188, 1078.309881675728, 1078.563181911327, 1098.549594666183, 1104.8453216549608, 11597.362145082017, 11736.765264694744, 11792.115591330685, 11798.233114847593, 11807.996320312785, 4718.882027949328, 4737.248422802164, 4782.856514304576, 4847.515248475124, 4883.145449546315, 8526.914730852735, 10026.097651211427, 10107.241956853266, 10115.39307641544, 10123.341982771097, 5352.063388906926, 5368.91946620801, 5373.811916582901, 5379.65032272901, 5420.295361603045, 4454.7549884756, 4602.056578401487, 4760.738159401197, 4935.3090567320605, 4935.851924442272, 3301.620313663959, 4026.5973402660084, 4062.5734297898885, 4087.2847251730827, 4133.9793301033305, 1331.3010669398643, 1332.6934804994905, 1342.2282187742087, 1344.2337867415674, 1351.5674984005025, 914.2229105260608, 919.1911118215927, 921.0161845593796, 925.4678559828126, 954.8854137503544, 4347.369631403492, 5790.42095790426, 6004.489618382399, 6070.423309785563, 6142.57002009855, 814.4543156085437, 935.6725146198776, 936.2463217110155, 951.6676652686157, 992.1269283031031, 3661.377565813818, 4043.129358316865, 4065.4714887064492, 4087.838679927193, 4120.237756015147, 10433.686989390331, 10777.946110269555, 10798.082163016075, 10807.67576972692, 10815.78368432627, 10689.412082335546, 10811.78376432467, 10836.783264334668, 10850.511726972305, 10851.457427128613, 8129.634166462523, 8148.06297275809, 8184.6726130955285, 8268.338532917352, 8274.379421543408, 5619.466150715675, 5827.708614569339, 5834.0, 5994.400559943971, 6071.180390647206, 9932.354396964174, 9949.751256218653, 10005.249606279704, 10066.597336106473, 10131.0, 9002.86495702578, 10160.44117573511, 10210.234232432746, 10270.743231418975, 10283.177345812466, 6333.36666333363, 6416.711247993758, 6704.564203326768, 7186.281371862772, 7521.435892308208, 8231.176882311722, 8495.95752021236, 8506.362022848187, 8509.319254459751, 8517.91482085196, 6710.563813352116, 6888.0, 7141.607211603412, 7312.670929808065, 7427.071616047994, 7332.266773322625, 7374.778756637309, 7429.517081389692, 7456.701731930662, 7502.512336698097, 6997.370236678723, 7025.648717564203, 7075.929240707733, 7093.82265443368, 7098.0, 5053.216751403538, 5062.848114556569, 5096.031753966735, 5105.974470127774, 5108.897822043613, 5005.749712514433, 5082.440931497458, 5121.692698438105, 5141.203113517411, 5174.560162386088], "value": 4610.518298658465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.38313839766874, 305.4974566837552, 310.84768463452906, 314.9338638885834, 316.5979206407862, 4681.4616319123315, 4953.281774142747, 5152.098382783012, 5595.8321250362505, 5688.715564221788, 5313.57491400688, 5420.587838411909, 5526.613137080406, 5575.661841158123, 5599.972000140004, 3692.907677308062, 4086.4891888513935, 4229.873103806891, 4245.68836307679, 4293.690424420551, 4135.04893874409, 4160.126373461577, 4270.914581708364, 4273.807678654468, 4279.422277992462, 3279.8688052477873, 3704.7962362070075, 3917.9822391468415, 3974.1852920151446, 4185.856002557462, 3447.6897079262862, 3668.596454390015, 3787.5381002348695, 4183.728057676257, 4254.893627659302, 3236.87052517899, 3550.982245088758, 3694.353488139565, 3694.8706795262306, 3699.3711069118044, 5173.249878767558, 5229.816956406507, 5353.330833645794, 5363.168708850135, 5437.456254374571, 4418.425604671372, 4791.448983366922, 4829.227323628203, 4835.0, 4875.9764697650435, 5358.33020872391, 5514.862128446781, 5589.860253493695, 5756.798512052058, 5804.738786754606, 4023.839046438168, 4038.9394159087637, 4043.9081448008874, 4049.805307434314, 4077.612626800449, 5900.262467191601, 6129.172561704202, 6193.473554747852, 6197.659128747917, 6206.317305096436, 3643.3988391915036, 3673.393890008119, 3769.1330993871015, 4128.483939507561, 4153.314703073959, 3318.551995480579, 3811.4092315691114, 4039.4546736190237, 4039.636432721069, 4053.7365071270274, 4686.835960741358, 4723.669343146015, 4730.976345118322, 4778.1399348116975, 4781.976090119527, 5137.33214682089, 5719.8570035749435, 5960.582759206901, 5966.701664916737, 5995.52035837132, 1261.3377976562194, 1343.355189509041, 1356.3625096204769, 1381.6683995840926, 1382.143071295803, 847.1867007672703, 898.8471959766855, 902.3007169443603, 927.5733162745213, 932.1005229953128, 4905.435874874363, 5227.607929405233, 5315.358979099252, 5429.6199266051, 5501.394846566875, 5168.483151684802, 5960.821175364746, 5964.224650795369, 5968.612040217372, 5995.250593675791, 5124.104022273633, 5368.275282836845, 5471.917921231185, 5472.972635136799, 5481.698506582176, 2522.070615978778, 2645.6692913385828, 2651.5624921888057, 2671.0, 2709.6883858356146, 5211.42674305826, 5238.842834714965, 5266.709656134195, 5294.49702278283, 5330.693979974853, 4621.376114224537, 4950.935548857013, 5143.3827940646615, 5190.263010632339, 5196.934628401169, 4602.742463221573, 4653.371794807726, 5115.948840511547, 5145.099607568585, 5208.333333333373, 4129.545749967441, 4451.465824101128, 4505.887352816075, 4515.887102822456, 4803.670219943255, 4300.892477688083, 4386.758728269976, 4406.3035731244345, 4989.675671081368, 5068.695878247317, 4342.80457379425, 4815.711057336571, 4916.852494425173, 5213.843584692465, 5233.607479439133, 3023.9244018899703, 3163.28826014145, 3255.67443255682, 3478.89563313101, 3484.1812174139563, 3592.8742494012586, 4199.354406723744, 4362.520122786555, 4735.431748190239, 4888.657793954531, 4217.457335837911, 4332.393464914978, 4888.5111488850835, 4894.804207831789, 4909.312696222603, 4292.960843599265, 4327.805248763751, 4358.428527168986, 4876.0, 4881.608741508653, 4190.099128687347, 4280.8929776754585, 4664.79008444614, 4741.719735671419, 4884.7069175849565, 3852.147852147852, 4834.815470209821, 4848.7090774553635, 4853.563179313879, 4910.558049775537, 4266.957330426656, 4474.5681381957465, 4655.859314467977, 4797.544233297831, 4843.740627436962], "value": 3926.200130566942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.4182424027454, 740.9481336306458, 780.7930898311948, 788.9644965976532, 802.3460879383306, 15444.69110617787, 15475.071495710252, 15574.454894078695, 15725.60685982851, 15807.209639518022, 14204.147751134913, 14217.786733198984, 14220.502282420117, 14237.92881035596, 14318.856811431882, 659.6470888074881, 668.6188872342767, 675.3685304240527, 813.7558732380277, 850.3877208409934, 833.0, 835.6490274084899, 845.5603086395101, 846.1031306814765, 848.245061894914, 804.4208170117506, 899.6086702284495, 903.4940433357308, 907.1654078248027, 909.8362294786936, 895.2256298301987, 900.2033200617468, 901.0133903375793, 902.801383695586, 903.4624398482957, 662.8177251255895, 666.7199776094004, 666.7199776094052, 669.554746093847, 670.718298314709, 14626.561203163923, 14760.926195368955, 14815.48145814902, 14829.0, 14886.478973235884, 14484.855151448455, 14487.492937747129, 14559.98080134391, 14648.12111273327, 14679.48621798232, 9899.257555683353, 11531.48108335127, 11662.241954272946, 12050.096242781827, 12448.315342656151, 3798.1454172811173, 3802.429635554661, 3853.2293541291574, 3884.261990221849, 3920.745151565168, 100760.49619751854, 125158.74841251654, 126933.0, 128770.35614821866, 131056.6894331054, 10651.520681569347, 10738.033576978109, 10930.836037459445, 11264.0425563828, 11442.427878606037, 18816.87098774078, 21796.455088622595, 21821.345359639236, 21933.780662193174, 21962.584115747253, 6831.28271531482, 6920.5847649141215, 7314.743983960642, 7503.887441688379, 8089.635966381527, 4358.498772641186, 4439.556044395599, 4483.237849565582, 4506.0312032912425, 4538.364628951949, 3309.23887505875, 3608.6391360863704, 3713.350163721338, 3728.2357116790995, 3751.437284407306, 622.8941080016408, 688.1466980943594, 714.7712731925734, 721.2607077745353, 721.4480922094601, 589.949854262384, 664.6643445060214, 684.1482354468718, 687.9552829066095, 702.3854127638316, 7629.656665450068, 7863.567503787347, 8884.600192991331, 9061.032863849712, 9440.433573985583, 547.6878179437762, 574.5719439017874, 599.4215581963426, 608.5314307982828, 651.4625434016955, 4606.378138951266, 4776.665633405698, 4785.952140478551, 4796.37647105881, 4818.229083346718, 164744.0, 168424.0, 169008.0, 172169.0, 174998.0, 140173.59826401607, 141790.0, 143801.28099359645, 143893.56106439012, 148024.0, 123630.0, 123696.0, 124447.9999999982, 125451.3727431357, 125844.37077814553, 9025.41334813235, 9110.635574576943, 9127.680531181377, 9195.632174712937, 9234.353595248536, 66477.33522664712, 67592.32407676057, 69088.0, 69295.65352173206, 71015.64492177506, 87838.121618783, 97178.51410742901, 105042.0, 105100.42349364613, 107397.46301268444, 11660.941695291469, 11805.173637845612, 11916.702082448008, 12083.879161208275, 12147.635570932885, 12825.42285597169, 12995.870041299466, 13067.150635208682, 13134.474621015052, 13362.732745344843, 11342.376169310437, 11670.591529296435, 11991.0, 12254.938725306316, 13354.998375122099, 13498.122622029538, 13571.59285221445, 13624.04631675773, 13867.375968081662, 14052.437902483785, 12689.492420303084, 13138.605841824761, 14001.159930404208, 14102.0, 14110.0, 9658.420494770337, 11072.391018493738, 11379.487923043318, 11729.35488548104, 11760.647180584596, 11160.944195278971, 11616.303021818718, 11720.88279117232, 11734.530618775494, 11781.352025638673], "value": 7868.023218645078, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 118.0, 116.0, 121.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 140.0, 140.0, 111.0, 144.0, 114.0, 111.0, 137.0, 108.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 201.0, 196.0, 197.0, 194.0, 193.0, 198.0, 193.0, 200.0, 191.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 84.0, 62.0, 51.0, 60.0, 83.0, 107.0, 50.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 90.0, 72.0, 69.0, 70.0, 88.0, 70.0, 70.0, 72.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 94.0, 132.0, 130.0, 86.0, 90.0, 89.0, 92.0, 85.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 97.0, 95.0, 122.0, 101.0, 139.0, 96.0, 114.0, 151.0], "value": 110.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 104.0, 150.0, 90.0, 98.0, 90.0, 90.0, 89.0, 91.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 57.0, 59.0, 59.0, 61.0, 60.0, 60.0, 84.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 70.0, 83.0, 79.0, 77.0, 60.0, 83.0, 103.0, 104.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 105.0, 107.0, 103.0, 82.0, 85.0, 84.0, 81.0, 86.0, 72.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 152.0, 151.0, 135.0, 141.0, 145.0, 144.0, 168.0, 153.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 166.0, 179.0, 209.0, 165.0, 166.0, 162.0, 165.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 84.0, 91.0, 67.0, 69.0, 68.0, 69.0, 80.0, 66.0, 69.0], "value": 72.5, "unit": "score"}]}]} 04:01:26 INFO - Return code: 0 04:01:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:01:26 ERROR - # TBPL SUCCESS # 04:01:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:26 INFO - 2016-10-10 04:01:26.709 screenresolution[1678:10563] starting screenresolution argv=screenresolution get 04:01:26 INFO - 2016-10-10 04:01:26.712 screenresolution[1678:10563] Display 0: 1600x1200x32@60 04:01:26 INFO - 2016-10-10 04:01:26.718 screenresolution[1679:10566] starting screenresolution argv=screenresolution list 04:01:26 INFO - Available Modes on Display 0 04:01:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:26 INFO - Intel Iris: 04:01:26 INFO - Chipset Model: Intel Iris 04:01:26 INFO - Type: GPU 04:01:26 INFO - Bus: Built-In 04:01:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:26 INFO - Vendor: Intel (0x8086) 04:01:26 INFO - Device ID: 0x0a2e 04:01:26 INFO - Revision ID: 0x0009 04:01:26 INFO - Displays: 04:01:26 INFO - Display: 04:01:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:26 INFO - Display Serial Number: 1600x1200 60 04:01:26 INFO - Main Display: Yes 04:01:26 INFO - Mirror: Off 04:01:26 INFO - Online: Yes 04:01:26 INFO - Rotation: Supported 04:01:26 INFO - Return code: 0 04:01:26 INFO - Running post-action listener: _resource_record_post_action 04:01:26 INFO - [mozharness: 2016-10-10 11:01:26.960081Z] Finished run-tests step (success) 04:01:26 INFO - Running post-run listener: _resource_record_post_run 04:01:27 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 37602304; Write bytes: 664178688; Read time: 248; Write time: 1900 04:01:27 INFO - TinderboxPrint: CPU usage
54.3% 04:01:27 INFO - TinderboxPrint: I/O read bytes / time
37,602,304 / 248 04:01:27 INFO - TinderboxPrint: I/O write bytes / time
664,178,688 / 1,900 04:01:27 INFO - TinderboxPrint: CPU idle
2,203.9 (45.7%) 04:01:27 INFO - TinderboxPrint: CPU system
973.0 (20.2%) 04:01:27 INFO - TinderboxPrint: CPU user
1,648.9 (34.2%) 04:01:27 INFO - TinderboxPrint: Swap in / out
400,826,368 / 0 04:01:27 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355174912; Write bytes: 355182080; Read time: 27617; Write time: 707 04:01:27 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36635648; Write bytes: 298813952; Read time: 235; Write time: 1157 04:01:27 INFO - Running post-run listener: _upload_blobber_files 04:01:27 INFO - Blob upload gear active. 04:01:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:27 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 04:01:27 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'] 04:01:27 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 04:01:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:28 INFO - (blobuploader) - INFO - Done attempting. 04:01:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:29 INFO - (blobuploader) - INFO - Done attempting. 04:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:31 INFO - (blobuploader) - INFO - Done attempting. 04:01:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:31 INFO - Return code: 0 04:01:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14fa7533d909a91304012ea3c67ef2651c38ac618bf3c076cd40b8df7fb7e5bd0ad5320076cbcc1b89287f8fd908eb0bd82256864924689d601a42317bb3eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd11ecdcf94cd365b4fe929d1edc9e45fb0ff78ffbaef3661b83bca4f50c3d707f91316f7c76d4702b12b9bedabf1a202411b74c9ff35a4ca338bccfa3a21298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6f6f1d8cafaf4588dd0592b9a9df053402b0e339dfde4f96400826d1219d0b8064c1266cd83b208932fbbfba116db4118edb9fda13f76284ace9476eb884810"} 04:01:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:31 INFO - Contents: 04:01:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14fa7533d909a91304012ea3c67ef2651c38ac618bf3c076cd40b8df7fb7e5bd0ad5320076cbcc1b89287f8fd908eb0bd82256864924689d601a42317bb3eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd11ecdcf94cd365b4fe929d1edc9e45fb0ff78ffbaef3661b83bca4f50c3d707f91316f7c76d4702b12b9bedabf1a202411b74c9ff35a4ca338bccfa3a21298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6f6f1d8cafaf4588dd0592b9a9df053402b0e339dfde4f96400826d1219d0b8064c1266cd83b208932fbbfba116db4118edb9fda13f76284ace9476eb884810"} 04:01:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:31 INFO - Copying logs to upload dir... 04:01:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.210598 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-10 04:01:31.797461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 04:01:31.801187) ========= 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.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14fa7533d909a91304012ea3c67ef2651c38ac618bf3c076cd40b8df7fb7e5bd0ad5320076cbcc1b89287f8fd908eb0bd82256864924689d601a42317bb3eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd11ecdcf94cd365b4fe929d1edc9e45fb0ff78ffbaef3661b83bca4f50c3d707f91316f7c76d4702b12b9bedabf1a202411b74c9ff35a4ca338bccfa3a21298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6f6f1d8cafaf4588dd0592b9a9df053402b0e339dfde4f96400826d1219d0b8064c1266cd83b208932fbbfba116db4118edb9fda13f76284ace9476eb884810"} build_url:https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010964 build_url: 'https://queue.taskcluster.net/v1/task/YmZHAg5QRLiB39701beYWg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14fa7533d909a91304012ea3c67ef2651c38ac618bf3c076cd40b8df7fb7e5bd0ad5320076cbcc1b89287f8fd908eb0bd82256864924689d601a42317bb3eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd11ecdcf94cd365b4fe929d1edc9e45fb0ff78ffbaef3661b83bca4f50c3d707f91316f7c76d4702b12b9bedabf1a202411b74c9ff35a4ca338bccfa3a21298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b6f6f1d8cafaf4588dd0592b9a9df053402b0e339dfde4f96400826d1219d0b8064c1266cd83b208932fbbfba116db4118edb9fda13f76284ace9476eb884810"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 04:01:31.833851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 04:01:31.834201) ========= 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.4fDqRM7R5i/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.03cJtIaSmw/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005091 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 04:01:31.882522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 04:01:31.882877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 04:01:31.883182) ========= ========= Total master_lag: 0.17 =========