builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0215 starttime: 1492823907.83 results: success (0) buildid: 20170421170720 builduid: 27035f1f63c94520b9cf3bf182d70543 revision: bf2654d9c37523800d2f27c7e8c12eac40873f7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:27.834306) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:27.834829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:27.835113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:27.863353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:27.863771) ========= 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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 --2017-04-21 18:18:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2017-04-21 18:18:28 (23.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:28.037708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:28.038096) ========= 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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.028353 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:28.088937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:28.089290) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf2654d9c37523800d2f27c7e8c12eac40873f7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bf2654d9c37523800d2f27c7e8c12eac40873f7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 2017-04-21 18:18:28,195 truncating revision to first 12 chars 2017-04-21 18:18:28,195 Setting DEBUG logging. 2017-04-21 18:18:28,195 attempt 1/10 2017-04-21 18:18:28,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf2654d9c375?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 18:18:28,846 unpacking tar archive at: mozilla-central-bf2654d9c375/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:29.048833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:29.049168) ========= script_repo_revision: bf2654d9c37523800d2f27c7e8c12eac40873f7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:29.049565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:29.049888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 18:18:29.070891) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 18:18:29.071286) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:18:29 INFO - MultiFileLogger online at 20170421 18:18:29 in /builds/slave/test 18:18:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:18:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:29 INFO - {'append_to_log': False, 18:18:29 INFO - 'base_work_dir': '/builds/slave/test', 18:18:29 INFO - 'blob_upload_branch': 'Firefox', 18:18:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:29 INFO - 'branch': 'Firefox', 18:18:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:29 INFO - 'config_files': ('talos/mac_config.py',), 18:18:29 INFO - 'default_actions': ('clobber', 18:18:29 INFO - 'read-buildbot-config', 18:18:29 INFO - 'download-and-extract', 18:18:29 INFO - 'populate-webroot', 18:18:29 INFO - 'create-virtualenv', 18:18:29 INFO - 'install', 18:18:29 INFO - 'run-tests'), 18:18:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:29 INFO - 'download_minidump_stackwalk': True, 18:18:29 INFO - 'download_symbols': 'ondemand', 18:18:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:29 INFO - 'gecko_profile': False, 18:18:29 INFO - 'gecko_profile_interval': 0, 18:18:29 INFO - 'installer_path': 'installer.exe', 18:18:29 INFO - 'log_level': 'info', 18:18:29 INFO - 'log_name': 'talos', 18:18:29 INFO - 'log_to_console': True, 18:18:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:18:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:18:29 INFO - 'opt_config_files': (), 18:18:29 INFO - 'pip_index': False, 18:18:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:29 INFO - 'cmd': ('bash', 18:18:29 INFO - '-c', 18:18:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:29 INFO - 'enabled': True, 18:18:29 INFO - 'halt_on_failure': False, 18:18:29 INFO - 'name': 'check_screen_resolution'},), 18:18:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:18:29 INFO - 'cmd': ('bash', 18:18:29 INFO - '-c', 18:18:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:18:29 INFO - 'enabled': True, 18:18:29 INFO - 'halt_on_failure': False, 18:18:29 INFO - 'name': 'check_screen_resolution'},), 18:18:29 INFO - 'run_cmd_checks_enabled': True, 18:18:29 INFO - 'suite': 'dromaeojs-e10s', 18:18:29 INFO - 'system_bits': '32', 18:18:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:29 INFO - 'title': 't-yosemite-r7-0215', 18:18:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:29 INFO - 'use_talos_json': True, 18:18:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:29 INFO - 'work_dir': 'build'} 18:18:29 INFO - [mozharness: 2017-04-22 01:18:29.283584Z] Running clobber step. 18:18:29 INFO - Running pre-action listener: _resource_record_pre_action 18:18:29 INFO - Running main action method: clobber 18:18:29 INFO - rmtree: /builds/slave/test/build 18:18:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:31 INFO - Running post-action listener: _resource_record_post_action 18:18:31 INFO - [mozharness: 2017-04-22 01:18:31.734719Z] Finished clobber step (success) 18:18:31 INFO - [mozharness: 2017-04-22 01:18:31.734851Z] Running read-buildbot-config step. 18:18:31 INFO - Running pre-action listener: _resource_record_pre_action 18:18:31 INFO - Running main action method: read_buildbot_config 18:18:31 INFO - Using buildbot properties: 18:18:31 INFO - { 18:18:31 INFO - "project": "", 18:18:31 INFO - "product": "firefox", 18:18:31 INFO - "script_repo_revision": "production", 18:18:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:18:31 INFO - "repository": "", 18:18:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:18:31 INFO - "buildid": "20170421170720", 18:18:31 INFO - "pgo_build": "False", 18:18:31 INFO - "basedir": "/builds/slave/test", 18:18:31 INFO - "buildnumber": 198, 18:18:31 INFO - "slavename": "t-yosemite-r7-0215", 18:18:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:18:31 INFO - "platform": "yosemite_r7", 18:18:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:18:31 INFO - "branch": "mozilla-central", 18:18:31 INFO - "repo_path": "mozilla-central", 18:18:31 INFO - "revision": "bf2654d9c37523800d2f27c7e8c12eac40873f7f", 18:18:31 INFO - "stage_platform": "macosx64", 18:18:31 INFO - "builduid": "27035f1f63c94520b9cf3bf182d70543", 18:18:31 INFO - "slavebuilddir": "test" 18:18:31 INFO - } 18:18:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:18:31 INFO - Running post-action listener: _resource_record_post_action 18:18:31 INFO - [mozharness: 2017-04-22 01:18:31.738096Z] Finished read-buildbot-config step (success) 18:18:31 INFO - [mozharness: 2017-04-22 01:18:31.738202Z] Running download-and-extract step. 18:18:31 INFO - Running pre-action listener: _resource_record_pre_action 18:18:31 INFO - Running main action method: download_and_extract 18:18:31 INFO - mkdir: /builds/slave/test/build/tests 18:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:31 INFO - trying https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:18:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 18:18:33 INFO - Downloaded 1325 bytes. 18:18:33 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:18:33 INFO - Using the following test package requirements: 18:18:33 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:18:33 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:18:33 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:18:33 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:18:33 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'jsshell-mac.zip'], 18:18:33 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:18:33 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:18:33 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:18:33 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:18:33 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:18:33 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:18:33 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:18:33 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:18:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:18:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:18:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:18:34 INFO - Expected file size: 52526429 18:18:34 INFO - Obtained file size: 52526429 18:18:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:18:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:18:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:18:51 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:18:53 INFO - Expected file size: 52526429 18:18:53 INFO - Obtained file size: 52526429 18:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:19:09 INFO - Expected file size: 14408811 18:19:09 INFO - Obtained file size: 14408811 18:19: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')]} 18:19:09 INFO - trying https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:19:09 INFO - Downloading https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 18:19:11 INFO - Downloaded 71021566 bytes. 18:19:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:19:11 INFO - mkdir: /builds/slave/test/properties 18:19:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:19:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:19:11 INFO - Contents: 18:19:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:19:12 INFO - Running post-action listener: _resource_record_post_action 18:19:12 INFO - Running post-action listener: set_extra_try_arguments 18:19:12 INFO - [mozharness: 2017-04-22 01:19:12.430106Z] Finished download-and-extract step (success) 18:19:12 INFO - [mozharness: 2017-04-22 01:19:12.430230Z] Running populate-webroot step. 18:19:12 INFO - Running pre-action listener: _resource_record_pre_action 18:19:12 INFO - Running main action method: populate_webroot 18:19:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:19:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:19:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:19:12 INFO - '--tppagecycles', 18:19:12 INFO - '7'], 18:19:12 INFO - 'tests': ['tsvgm']}}, 18:19:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:19:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:19:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:19:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:19:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['damp', 'tps']}, 18:19:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'tests': ['damp', 'tps']}, 18:19:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['dromaeo_dom']}, 18:19:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:19:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:19:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:19:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['a11yr', 18:19:12 INFO - 'ts_paint', 18:19:12 INFO - 'tpaint', 18:19:12 INFO - 'sessionrestore', 18:19:12 INFO - 'sessionrestore_no_auto_restore', 18:19:12 INFO - 'tabpaint']}, 18:19:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:19:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:19:12 INFO - 'bloom_basic_ref']}, 18:19:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['tsvgx', 18:19:12 INFO - 'tsvgr_opacity', 18:19:12 INFO - 'tart', 18:19:12 INFO - 'tscrollx', 18:19:12 INFO - 'cart', 18:19:12 INFO - 'tsvg_static']}, 18:19:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:19:12 INFO - 'tsvgr_opacity', 18:19:12 INFO - 'tart', 18:19:12 INFO - 'tscrollx', 18:19:12 INFO - 'cart', 18:19:12 INFO - 'tsvg_static']}, 18:19:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'talos_options': ['--disable-e10s'], 18:19:12 INFO - 'tests': ['tp5o']}, 18:19:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:19:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'talos_options': ['--disable-e10s', 18:19:12 INFO - '--xperf_path', 18:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:12 INFO - 'tests': ['tp5n']}, 18:19:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:19:12 INFO - 'talos_options': ['--xperf_path', 18:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:12 INFO - 'tests': ['tp5n']}}, 18:19:12 INFO - 'talos.zip': {'path': '', 18:19:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:19:12 INFO - Running post-action listener: _resource_record_post_action 18:19:12 INFO - [mozharness: 2017-04-22 01:19:12.449183Z] Finished populate-webroot step (success) 18:19:12 INFO - [mozharness: 2017-04-22 01:19:12.449315Z] Running create-virtualenv step. 18:19:12 INFO - Running pre-action listener: _resource_record_pre_action 18:19:12 INFO - Running main action method: create_virtualenv 18:19:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:19:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:19:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:19:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:19:12 INFO - Using real prefix '/tools/python27' 18:19:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:19:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:19:16 INFO - Installing pip.................done. 18:19:16 INFO - Return code: 0 18:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:19:16 INFO - Reading from file tmpfile_stdout 18:19:16 INFO - Output received: 18:19:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:19:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:16 INFO - 'HOME': '/Users/cltbld', 18:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PAGER': '/bin/cat', 18:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test', 18:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:16 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - 'XPC_FLAGS': '0x0', 18:19:16 INFO - 'XPC_SERVICE_NAME': '0', 18:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:19:16 INFO - Cleaning up... 18:19:16 INFO - Return code: 0 18:19:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:16 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:16 INFO - 'HOME': '/Users/cltbld', 18:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:16 INFO - 'LOGNAME': 'cltbld', 18:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:16 INFO - 'MOZ_NO_REMOTE': '1', 18:19:16 INFO - 'NO_EM_RESTART': '1', 18:19:16 INFO - 'PAGER': '/bin/cat', 18:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:16 INFO - 'PWD': '/builds/slave/test', 18:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:16 INFO - 'SHELL': '/bin/bash', 18:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:16 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:16 INFO - 'USER': 'cltbld', 18:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:16 INFO - 'XPC_FLAGS': '0x0', 18:19:16 INFO - 'XPC_SERVICE_NAME': '0', 18:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:17 INFO - Downloading/unpacking psutil>=3.1.1 18:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:20 INFO - Installing collected packages: psutil 18:19:20 INFO - Running setup.py install for psutil 18:19:20 INFO - building 'psutil._psutil_osx' extension 18:19:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:19:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:19:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:19:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:19:21 INFO - building 'psutil._psutil_posix' extension 18:19:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:19:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:19:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:19:21 INFO - ^ 18:19:21 INFO - 1 warning generated. 18:19:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:21 INFO - Successfully installed psutil 18:19:21 INFO - Cleaning up... 18:19:21 INFO - Return code: 0 18:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:21 INFO - 'HOME': '/Users/cltbld', 18:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:21 INFO - 'LOGNAME': 'cltbld', 18:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:21 INFO - 'MOZ_NO_REMOTE': '1', 18:19:21 INFO - 'NO_EM_RESTART': '1', 18:19:21 INFO - 'PAGER': '/bin/cat', 18:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:21 INFO - 'PWD': '/builds/slave/test', 18:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:21 INFO - 'SHELL': '/bin/bash', 18:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:21 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:21 INFO - 'USER': 'cltbld', 18:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:21 INFO - 'XPC_FLAGS': '0x0', 18:19:21 INFO - 'XPC_SERVICE_NAME': '0', 18:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:19:24 INFO - Installing collected packages: mozsystemmonitor 18:19:24 INFO - Running setup.py install for mozsystemmonitor 18:19:24 INFO - Successfully installed mozsystemmonitor 18:19:24 INFO - Cleaning up... 18:19:24 INFO - Return code: 0 18:19:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:25 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:25 INFO - 'HOME': '/Users/cltbld', 18:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:25 INFO - 'LOGNAME': 'cltbld', 18:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:25 INFO - 'MOZ_NO_REMOTE': '1', 18:19:25 INFO - 'NO_EM_RESTART': '1', 18:19:25 INFO - 'PAGER': '/bin/cat', 18:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:25 INFO - 'PWD': '/builds/slave/test', 18:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:25 INFO - 'SHELL': '/bin/bash', 18:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:25 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:25 INFO - 'USER': 'cltbld', 18:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:25 INFO - 'XPC_FLAGS': '0x0', 18:19:25 INFO - 'XPC_SERVICE_NAME': '0', 18:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:28 INFO - warning: no files found matching '*.txt' 18:19:28 INFO - no previously-included directories found matching 'build' 18:19:28 INFO - no previously-included directories found matching 'dist' 18:19:28 INFO - no previously-included directories found matching '.git*' 18:19:28 INFO - Installing collected packages: jsonschema, functools32 18:19:29 INFO - Running setup.py install for functools32 18:19:29 INFO - warning: no files found matching '*.txt' 18:19:29 INFO - no previously-included directories found matching 'build' 18:19:29 INFO - no previously-included directories found matching 'dist' 18:19:29 INFO - no previously-included directories found matching '.git*' 18:19:29 INFO - Successfully installed jsonschema functools32 18:19:29 INFO - Cleaning up... 18:19:29 INFO - Return code: 0 18:19:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:29 INFO - 'HOME': '/Users/cltbld', 18:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:29 INFO - 'LOGNAME': 'cltbld', 18:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:29 INFO - 'MOZ_NO_REMOTE': '1', 18:19:29 INFO - 'NO_EM_RESTART': '1', 18:19:29 INFO - 'PAGER': '/bin/cat', 18:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:29 INFO - 'PWD': '/builds/slave/test', 18:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:29 INFO - 'SHELL': '/bin/bash', 18:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:29 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:29 INFO - 'USER': 'cltbld', 18:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:29 INFO - 'XPC_FLAGS': '0x0', 18:19:29 INFO - 'XPC_SERVICE_NAME': '0', 18:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:19:29 INFO - Cleaning up... 18:19:29 INFO - Return code: 0 18:19:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:29 INFO - 'HOME': '/Users/cltbld', 18:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:29 INFO - 'LOGNAME': 'cltbld', 18:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:29 INFO - 'MOZ_NO_REMOTE': '1', 18:19:29 INFO - 'NO_EM_RESTART': '1', 18:19:29 INFO - 'PAGER': '/bin/cat', 18:19:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:29 INFO - 'PWD': '/builds/slave/test', 18:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:29 INFO - 'SHELL': '/bin/bash', 18:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:29 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:29 INFO - 'USER': 'cltbld', 18:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:29 INFO - 'XPC_FLAGS': '0x0', 18:19:29 INFO - 'XPC_SERVICE_NAME': '0', 18:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:19:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:33 INFO - Downloading docopt-0.6.1.tar.gz 18:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:33 INFO - Running setup.py install for blobuploader 18:19:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:19:33 INFO - Running setup.py install for requests 18:19:34 INFO - Running setup.py install for docopt 18:19:34 INFO - Successfully installed blobuploader requests docopt 18:19:34 INFO - Cleaning up... 18:19:34 INFO - Return code: 0 18:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:34 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:34 INFO - 'HOME': '/Users/cltbld', 18:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:34 INFO - 'LOGNAME': 'cltbld', 18:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:34 INFO - 'MOZ_NO_REMOTE': '1', 18:19:34 INFO - 'NO_EM_RESTART': '1', 18:19:34 INFO - 'PAGER': '/bin/cat', 18:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:34 INFO - 'PWD': '/builds/slave/test', 18:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:34 INFO - 'SHELL': '/bin/bash', 18:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:34 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:34 INFO - 'USER': 'cltbld', 18:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:34 INFO - 'XPC_FLAGS': '0x0', 18:19:34 INFO - 'XPC_SERVICE_NAME': '0', 18:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-HnYMtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-odpiWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-PbU8J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-KQraBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-d4icvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-nc7dg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-LF4ubL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-tx8Zx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-mDPPn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-2YNKVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-hCsjOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:35 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-1CNY4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:36 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-76ESpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:36 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Vc4h7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:36 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-wpPjQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:36 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-wRHMqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:36 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Bae34L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:36 INFO - Running setup.py install for manifestparser 18:19:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:19:36 INFO - Running setup.py install for mozcrash 18:19:36 INFO - Running setup.py install for mozdebug 18:19:37 INFO - Running setup.py install for mozdevice 18:19:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Running setup.py install for mozfile 18:19:37 INFO - Running setup.py install for mozhttpd 18:19:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Running setup.py install for mozinfo 18:19:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Running setup.py install for mozInstall 18:19:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:37 INFO - Running setup.py install for mozleak 18:19:37 INFO - Running setup.py install for mozlog 18:19:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Running setup.py install for moznetwork 18:19:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Running setup.py install for mozprocess 18:19:38 INFO - Running setup.py install for mozprofile 18:19:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Running setup.py install for mozrunner 18:19:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:38 INFO - Running setup.py install for mozscreenshot 18:19:38 INFO - Running setup.py install for moztest 18:19:39 INFO - Running setup.py install for mozversion 18:19:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:39 INFO - Cleaning up... 18:19:39 INFO - Return code: 0 18:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:39 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:19:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:39 INFO - 'HOME': '/Users/cltbld', 18:19:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:39 INFO - 'LOGNAME': 'cltbld', 18:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:39 INFO - 'MOZ_NO_REMOTE': '1', 18:19:39 INFO - 'NO_EM_RESTART': '1', 18:19:39 INFO - 'PAGER': '/bin/cat', 18:19:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:39 INFO - 'PWD': '/builds/slave/test', 18:19:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:39 INFO - 'SHELL': '/bin/bash', 18:19:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:39 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:39 INFO - 'USER': 'cltbld', 18:19:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:39 INFO - 'XPC_FLAGS': '0x0', 18:19:39 INFO - 'XPC_SERVICE_NAME': '0', 18:19:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-o5L_rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-t5eumx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-jWB2yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-3QeFox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-kG4fvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:39 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-okkxlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-MpEJBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-CCfv2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-sje_c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-8SSgkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-5JFTKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-OOTQPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-QuozAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-dhow5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:40 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-g_BJTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:41 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Xni9cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:41 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-DtmC81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:19:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:19:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:19:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:43 INFO - Downloading blessings-1.6.tar.gz 18:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:43 INFO - Installing collected packages: blessings 18:19:43 INFO - Running setup.py install for blessings 18:19:44 INFO - Successfully installed blessings 18:19:44 INFO - Cleaning up... 18:19:44 INFO - Return code: 0 18:19:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:44 INFO - Reading from file tmpfile_stdout 18:19:44 INFO - Current package versions: 18:19:44 INFO - blessings == 1.6 18:19:44 INFO - blobuploader == 1.2.4 18:19:44 INFO - docopt == 0.6.1 18:19:44 INFO - functools32 == 3.2.3-2 18:19:44 INFO - jsonschema == 2.5.1 18:19:44 INFO - manifestparser == 1.1 18:19:44 INFO - mozInstall == 1.12 18:19:44 INFO - mozcrash == 1.0 18:19:44 INFO - mozdebug == 0.1 18:19:44 INFO - mozdevice == 0.50 18:19:44 INFO - mozfile == 1.2 18:19:44 INFO - mozhttpd == 0.7 18:19:44 INFO - mozinfo == 0.9 18:19:44 INFO - mozleak == 0.1 18:19:44 INFO - mozlog == 3.4 18:19:44 INFO - moznetwork == 0.27 18:19:44 INFO - mozprocess == 0.25 18:19:44 INFO - mozprofile == 0.28 18:19:44 INFO - mozrunner == 6.13 18:19:44 INFO - mozscreenshot == 0.1 18:19:44 INFO - mozsystemmonitor == 0.3 18:19:44 INFO - moztest == 0.8 18:19:44 INFO - mozversion == 1.4 18:19:44 INFO - psutil == 3.1.1 18:19:44 INFO - requests == 1.2.3 18:19:44 INFO - wsgiref == 0.1.2 18:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:44 INFO - 'HOME': '/Users/cltbld', 18:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:44 INFO - 'LOGNAME': 'cltbld', 18:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:44 INFO - 'MOZ_NO_REMOTE': '1', 18:19:44 INFO - 'NO_EM_RESTART': '1', 18:19:44 INFO - 'PAGER': '/bin/cat', 18:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:44 INFO - 'PWD': '/builds/slave/test', 18:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:44 INFO - 'SHELL': '/bin/bash', 18:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:44 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:44 INFO - 'USER': 'cltbld', 18:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:44 INFO - 'XPC_FLAGS': '0x0', 18:19:44 INFO - 'XPC_SERVICE_NAME': '0', 18:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:19:44 INFO - Cleaning up... 18:19:44 INFO - Return code: 0 18:19:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:44 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 0x109acfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facda569550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, '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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:19:44 INFO - 'HOME': '/Users/cltbld', 18:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:19:44 INFO - 'LOGNAME': 'cltbld', 18:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:44 INFO - 'MOZ_NO_REMOTE': '1', 18:19:44 INFO - 'NO_EM_RESTART': '1', 18:19:44 INFO - 'PAGER': '/bin/cat', 18:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:44 INFO - 'PWD': '/builds/slave/test', 18:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:19:44 INFO - 'SHELL': '/bin/bash', 18:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:19:44 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:19:44 INFO - 'USER': 'cltbld', 18:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:44 INFO - 'XPC_FLAGS': '0x0', 18:19:44 INFO - 'XPC_SERVICE_NAME': '0', 18:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:45 INFO - Cleaning up... 18:19:45 INFO - Return code: 0 18:19:45 INFO - Running post-action listener: _resource_record_post_action 18:19:45 INFO - Running post-action listener: _start_resource_monitoring 18:19:45 INFO - Starting resource monitoring. 18:19:45 INFO - [mozharness: 2017-04-22 01:19:45.110360Z] Finished create-virtualenv step (success) 18:19:45 INFO - [mozharness: 2017-04-22 01:19:45.111310Z] Running install step. 18:19:45 INFO - Running pre-action listener: _resource_record_pre_action 18:19:45 INFO - Running main action method: install 18:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:45 INFO - Reading from file tmpfile_stdout 18:19:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:45 INFO - Reading from file tmpfile_stdout 18:19:45 INFO - Output received: 18:19:45 INFO - Usage: mozinstall [options] installer 18:19:45 INFO - Options: 18:19:45 INFO - -h, --help show this help message and exit 18:19:45 INFO - -d DEST, --destination=DEST 18:19:45 INFO - Directory to install application into. [default: 18:19:45 INFO - "/builds/slave/test"] 18:19:45 INFO - --app=APP Application being installed. [default: firefox] 18:19:45 INFO - mkdir: /builds/slave/test/build/application 18:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:20:05 INFO - Reading from file tmpfile_stdout 18:20:05 INFO - Output received: 18:20:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:20:05 INFO - Running post-action listener: _resource_record_post_action 18:20:05 INFO - [mozharness: 2017-04-22 01:20:05.493307Z] Finished install step (success) 18:20:05 INFO - [mozharness: 2017-04-22 01:20:05.493442Z] Running run-tests step. 18:20:05 INFO - Running pre-action listener: _resource_record_pre_action 18:20:05 INFO - Running main action method: run_tests 18:20:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:20:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:20:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:20:05 INFO - 2017-04-21 18:20:05.508 screenresolution[1626:7431] starting screenresolution argv=screenresolution get 18:20:05 INFO - 2017-04-21 18:20:05.510 screenresolution[1626:7431] Display 0: 1600x1200x32@60 18:20:05 INFO - 2017-04-21 18:20:05.516 screenresolution[1627:7433] starting screenresolution argv=screenresolution list 18:20:05 INFO - Available Modes on Display 0 18:20:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:20:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:20:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:20:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:20:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:20:05 INFO - Intel Iris: 18:20:05 INFO - Chipset Model: Intel Iris 18:20:05 INFO - Type: GPU 18:20:05 INFO - Bus: Built-In 18:20:05 INFO - VRAM (Dynamic, Max): 1536 MB 18:20:05 INFO - Vendor: Intel (0x8086) 18:20:05 INFO - Device ID: 0x0a2e 18:20:05 INFO - Revision ID: 0x0009 18:20:05 INFO - Displays: 18:20:05 INFO - Display: 18:20:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:20:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:20:05 INFO - Display Serial Number: 1600x1200 60 18:20:05 INFO - Main Display: Yes 18:20:05 INFO - Mirror: Off 18:20:05 INFO - Online: Yes 18:20:05 INFO - Rotation: Supported 18:20:05 INFO - Return code: 0 18:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:20:05 INFO - Python 2.7.3 18:20:05 INFO - Return code: 0 18:20:05 INFO - grabbing minidump binary from tooltool 18:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:05 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 0x1098add30>, '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 0x1097d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:20:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:20:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:20:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:20:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:20:05 INFO - Return code: 0 18:20:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:20:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:20:05 INFO - ENV: RUST_BACKTRACE is now 1 18:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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 18:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0215 --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 18:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5r3YrbRnTF/Render', 18:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:05 INFO - 'HOME': '/Users/cltbld', 18:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:05 INFO - 'LOGNAME': 'cltbld', 18:20:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:20:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:05 INFO - 'MOZ_NO_REMOTE': '1', 18:20:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:20:05 INFO - 'NO_EM_RESTART': '1', 18:20:05 INFO - 'PAGER': '/bin/cat', 18:20:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:05 INFO - 'PWD': '/builds/slave/test', 18:20:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:05 INFO - 'RUST_BACKTRACE': '1', 18:20:05 INFO - 'SHELL': '/bin/bash', 18:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UWbKXPO6tO/Listeners', 18:20:05 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 18:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:05 INFO - 'USER': 'cltbld', 18:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:05 INFO - 'XPC_FLAGS': '0x0', 18:20:05 INFO - 'XPC_SERVICE_NAME': '0', 18:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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 18:20:06 INFO - mozversion application_buildid: 20170421170720 18:20:06 INFO - mozversion application_changeset: bf2654d9c37523800d2f27c7e8c12eac40873f7f 18:20:06 INFO - mozversion application_display_name: Nightly 18:20:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:20:06 INFO - mozversion application_name: Firefox 18:20:06 INFO - mozversion application_remotingname: firefox 18:20:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:20:06 INFO - mozversion application_vendor: Mozilla 18:20:06 INFO - mozversion application_version: 55.0a1 18:20:06 INFO - mozversion platform_buildid: 20170421170720 18:20:06 INFO - mozversion platform_changeset: bf2654d9c37523800d2f27c7e8c12eac40873f7f 18:20:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:20:06 INFO - mozversion platform_version: 55.0a1 18:20:06 INFO - using testdate: 1492824006 18:20:06 INFO - actual date: 1492824006 18:20:06 INFO - starting webserver on 'localhost:49242' 18:20:06 INFO - SUITE-START | Running 2 tests 18:20:06 INFO - TEST-START | dromaeo_css 18:20:06 INFO - operating with platform_type : mac_ 18:20:06 INFO - Initialising browser for dromaeo_css test... 18:20:06 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp_oTQ2B/profile http://localhost:49242/getInfo.html) 18:20:09 INFO - PID 1637 | 2017-04-21 18:20:09.014 plugin-container[1639:7621] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983f, name = 'com.apple.tsm.portname' 18:20:09 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:20:09 INFO - PID 1637 | 2017-04-21 18:20:09.017 plugin-container[1639:7621] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 18:20:09 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:20:09 INFO - PID 1637 | 2017-04-21 18:20:09.017 plugin-container[1639:7621] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:20:09 INFO - PID 1637 | __metrics Screen width/height:1600/1200 18:20:09 INFO - PID 1637 | colorDepth:24 18:20:09 INFO - PID 1637 | Browser inner width/height: 1024/689 18:20:09 INFO - PID 1637 | __metrics 18:20:09 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 18:20:10 INFO - TEST-INFO | 1637: exit 0 18:20:10 INFO - Browser initialized. 18:20:10 INFO - Running cycle 1/1 for dromaeo_css test... 18:20:10 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp_oTQ2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:12 INFO - PID 1640 | 2017-04-21 18:20:12.508 plugin-container[1641:7757] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 18:20:12 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:20:12 INFO - PID 1640 | 2017-04-21 18:20:12.509 plugin-container[1641:7757] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 18:20:12 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:20:12 INFO - PID 1640 | 2017-04-21 18:20:12.509 plugin-container[1641:7757] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:20:22 INFO - PID 1640 | RSS: Main: 236220416 18:20:22 INFO - PID 1640 | 18:23:26 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 18:23:27 INFO - PID 1640 | RSS: Main: 252129280 18:23:27 INFO - PID 1640 | 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 18:25:10 INFO - PID 1640 | 18:25:10 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:25:10 INFO - PID 1640 | Full stack: 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 18:25:10 INFO - PID 1640 | 18:25:10 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:25:10 INFO - PID 1640 | Full stack: 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 18:25:10 INFO - PID 1640 | 18:25:10 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:25:10 INFO - PID 1640 | Full stack: 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | ************************* 18:25:10 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 18:25:10 INFO - PID 1640 | 18:25:10 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:25:10 INFO - PID 1640 | Full stack: 18:25:10 INFO - PID 1640 | ************************* 18:26:29 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 18:26:30 INFO - PID 1640 | RSS: Main: 257241088 18:26:30 INFO - PID 1640 | 18:29:32 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 18:29:32 INFO - PID 1640 | RSS: Main: 266121216 18:29:32 INFO - PID 1640 | 18:32:34 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 18:32:35 INFO - PID 1640 | RSS: Main: 259358720 18:32:35 INFO - PID 1640 | 18:35:37 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 18:35:38 INFO - PID 1640 | RSS: Main: 268611584 18:35:38 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 18:38:40 INFO - PID 1640 | RSS: Main: 263221248 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | __start_tp_report 18:38:40 INFO - PID 1640 | _x_x_mozilla_page_load 18:38:40 INFO - PID 1640 | _x_x_mozilla_page_load_details 18:38:40 INFO - PID 1640 | |i|pagename|runs| 18:38:40 INFO - PID 1640 | |0;dojo.html;2955.4975654138793;3120.391523652888;3592.694620957217;3642.016655503014;3647.2705458908217;5737.713114344287;6160.722767475463;6202.751889924403;6212.471939885109;6320.399562041604;6168.4448399644025;6238.251409830816;6256.343083976174;6283.057541368786;6299.307076221612;5515.255440515539;5515.641483303592;5547.472990065938;5560.332760068777;5644.915326270109;5426.511613954744;5556.833295001156;5627.7186140693;5642.1254705520505;5667.348254950672;5395.0558652236095;5490.149026900836;5531.474509921551;5544.61187716858;5564.86087847803;5505.229267902497;5507.366652834895;5517.531009864167;5529.834104976857;5538.556915446755;5405.864853378657;5445.50990410865;5459.890802183973;5481.917771233435;5531.976584331871;5144.74276286188;6100.511959043266;6154.230721159855;6190.907136392958;6264.812055638338;6670.4997125215805;6700.865982680319;6704.497162712767;6707.262201157869;6729.25978142404;6758.256591774901;6758.9324106758795;6796.184457865088;6803;6804.6257455839905;5052.3937127544195;6174.38256174379;6317;6391.10524526562;6402.871942561169;6866.073080134218;6871.690773915186;6906.412954898889;6913.51605387618;6941.514094013472;5045.798168073309;6343.651099189497;6375.968120159462;6423.164988551458;6432.970724684028;6686.13080299558;6697.196336439659;6739.090222819955;6747.527673062937;6761.492888033417;6307.085472606446;6580.1116849224745;6715.026321183401;6739.93260067393;6750.561213521204;5509.752061157257;6309.211348581427;6597.934020659732;6665.266820649725;6678.065070890079;4792.664513484093;5218.7912483500995;5222.764975576109;5229.607779416483;5236.869078272997;4689.6717229793585;4696.953030469652;4714.66997310185;4716.622670186377;4718.268668356411;5461.15352120422;5870.471657550841;6362.077498762654;6370.458511026614;6404.423601875854;5710.2576665033275;6732;6827.419669328064;6836.555623884432;6846.212685541127;5423.860989192235;6354.3963323484195;6374.394432528902;6382.585131966407;6424.196975378078;4871.51418817257;5816.5055970243;5825.825225243249;5846.386129456431;5947.316058653224;5665.915011274917;6837.3162683731225;6972.825679358057;6993.0908981832035;7008.894866576903;6738.191417029988;6782.69477873487;6793.626350550767;6810.897836532555;6812.795616131524;6950.409215216763;6956.79129626112;6991.126109236346;6995.405390541861;6997.685104170223;6395.20059992501;6454.774082907075;6559.245686746085;6636.867262654623;6678.83302917431;6459.935400645933;6536;6794.320567943364;6843.349881761224;6851.862962740817;6378.45783108441;6524.706388212637;6526.282108967915;6534.803955881332;6535.411812936859;6511.446527045254;6528.640924749185;6535.379138981789;6541.34586541342;6560.278369379269;6142.662153581596;6311.842203944754;6348.079528468438;6390.360963903572;6405.8398540035005;6499.837504062436;6532.346765323619;6533.738650454119;6542.280349161493;6555.573887697285;6384.808455746335;6402.711877965409;6412.326705696021;6418.839529011812;6427.132337134427 18:38:40 INFO - PID 1640 | |1;ext.html;662.6885363878976;785.8624740670383;808.1070417189006;1198.3469009389883;1235.950561977521;37480.625193748056;38299.42550861736;38545.421818672745;38568.42147367792;38611.42082868756;38508;38776;38791.80604096982;38907.805460972726;38926.41610375846;7878.290953814156;8019.35845132388;8251.711190108348;8443.11347308533;8525.104863989254;7380.520266182708;8274.627641756106;8453.408261421702;8506.021807492156;8564.48613083217;8432;8441.15588441154;8446.83106337873;8489.95755021224;8523.062463129081;7313.341799238041;8436.493810371336;8460.703875364363;8492.193241642066;8507;8218.260356567878;8279.58602069894;8288.875666865002;8290.585470726439;8320.875186872201;30795.846020769975;37506.812465937495;37548;37614.62385376138;37740.62259377426;3566;3584.5160903277983;3610.151614370621;3610.819459027038;3620;30803.537946930588;30819;30896.691033089606;30912.918047868217;30940.226494337596;3122.6408962969094;3130.4834702274097;3135.529670549413;3137.8274194919272;3147.8740850365957;273061;275207;305334;314004.99999999773;314109;47145.76427117842;47591.28613070807;47630.04739905182;47716;47798;48035.55893323206;48046.75976620164;53529.1970620441;55087.44912550823;55106.44893551013;13859.792103118461;13884.652883677787;14021.369038393297;14042.929785351007;14054.508092216724;10995.175361847894;11116.499757510932;11192.216544841784;11211.047060999907;11222.775544489228;13917.86082139186;13941.512047078304;13942.721145577032;13954.790678139836;13980.930095349662;5162.5869930406225;5209.270702101709;6158.230221222348;6162.691865406712;6181.196444462281;1021.1218352217087;1022.4529876516028;1032.8690084357615;1055.3773273768513;1067.2049323254225;22676.65985010226;23325.7667423327;24781.62827557588;24928.541445961662;24973.87513062423;1051.4795176387738;1124.1512657943201;1142.017864636412;1163.5811108001112;1167.830664553635;11776;12535;12585.307808070462;12636.55772047974;12671.619851404472;336385;336726;338015;338022;338402;54467.45532544703;54654.90690186174;54688.726556366964;54814.45185548173;55135.72432137813;1506.352268524523;1511.3199060422635;1545.3432291276163;1552.8835337349517;1568.756842689385;21211.575768484854;22225.44436389103;22975.966081526036;24367.390815229053;24753.50492990094;37875.62124378721;38026.42960355652;38033.23933521369;38128;38179;277586;278116;279528;279680;279710;35203;35253;35479;35531;35560.64439355573;45501.54498454973;45948.540514594424;46487.53512464832;46560;46730.59808205759;23465.530689385774;29603.259918502208;29848.43721148455;30842.84578577093;31792.841035794674;28550.14895729891;30830;31367.84316078405;31390.843045784626;31776.682233178297;37067.814660926524;37119;37511.24977500489;37700;37891.62108378991;30568.84715576408;31743.682563174072;31892;32190.67809321877;32508.83745581257;23085.538289233784;23635.054597815895;24433.994086949562;24672.876635616707;24849.503009939337 18:38:40 INFO - PID 1640 | |2;jquery.html;434.7826086956522;437.0101719605095;440.56604244818845;459.5840764108482;463.6082510278815;21190.57618847624;21289.680654790172;21827.1446927011;21844.563108737835;21979.010944507496;19247.326343577977;21770.238041668545;22724.318270451913;23060.654090188662;23293.767062329414;4873.366462359888;5730.825180837918;5991.880162396749;6205.22434695663;6222.751089956397;5988.490978266831;6180;6182.443580077792;6182.969085154568;6186.783462578811;5500.724963751816;5859.531237501011;5914.9112763308585;6101.4203650653335;6138.202033735631;6104.206453161083;6112.938870611304;6126.989046807272;6151.200343955257;6184.196054512884;4651.418572678415;5283.418823929364;5474.562035037187;5490.670559766427;5523.309586301712;24523.754762452325;24877.50244995108;27578;27779.444411111665;27974.580381294298;2235.1282999630157;2302.976970230293;2304.8271379646594;2305.2853615379117;2312.4681323295736;14606.488772892897;17350.652986940317;17767.378141765104;17801.02094384808;17989.550261243443;1896.2035944903037;2162.37291185556;2177.4665207024223;2230.7769223077726;2235.441139715071;156093;157590;158249;159914;160831.99999999884;12262.509499620093;12952.740945181233;12955.676108097185;13024.47902083906;13033.218006919615;16480.505584832474;16512.174391280627;16548.172591370385;16556.75164872528;16603.41888033913;8700.4718458861;8991.955040224888;9003.909960900439;9102.635894564144;9155.725328240163;7119.857602847914;8444.493330400195;8521.190486903859;8592.8711069334;8719.258862996716;7687.500312479671;7815.491993020435;7855.567943763033;7857.096433910059;7904.130545639975;2159.4709296222527;2175.782421757843;2179.259051922322;2182.2907555044676;2371.122684606672;866.4454748960544;959.9568019439142;968.4286271100085;969.4958621516772;971.9854202186973;20932.79067209339;21510.46223844385;21713.34859954172;21842.563148736936;21959.231426899983;999.3304485994402;1003.2826529031631;1025.2720568396373;1030.2376241581326;1038.3873514626407;10762.56949722018;11100.906044433412;11161;11215.66353009411;11223.607173749044;397861;500132;503331;507279;535183;98896.01103988868;129411.35294323468;130009;133694;134442;1127.994360028211;1137.175547727907;1183.378726168751;1185.1170877696;1186.9465874035689;13869.930650346683;15150.848491514944;18316.633667326314;18362.990035548173;18855.811441885955;42069.78965105155;46191.538084618725;53088.67278317919;53103;54500.454995451124;69630.65184674044;70441;70708.29291707017;71077.22306942161;72911.27088729045;6810.5913645181445;8546.957265213883;8932.374733768835;8989.46063236208;9005.189532942066;13793.517226897011;13838.23889686077;13977.091489053179;14044.78932816029;14458.783118253024;11661.76676466449;11721.824172637247;12153.331566763913;12233.877661223274;12242.204256723284;11134.665960021212;11182.608608698982;11185.66443006711;11254.662360129209;11477.368744718786;11952.940235298767;11956;12106.455209515418;12259.203151795462;12320.938395307967;8623.956880215559;8777.473351598925;9028.277737781093;9051.637934482547;9190.862137067816;11436;11971;12229;12304.26174429537;12304.75390492203 18:38:40 INFO - PID 1640 | |3;mootools.html;1158.380266557392;1353.0934274036401;1380.4754193406504;1402.495101763365;1411.5059729094814;11348.71628209294;11804.527818887256;11868.347240901747;11883.881161188385;12166;11842.703932401695;11867.991220746226;12019.038476921847;12048.39758012098;12051.975582075534;2535.543602151612;2550.426154115328;2553.9744602553924;2571.1643715792347;2574.0218716887557;2484.8012159027235;2491.0658503061354;2523.747625237471;2529.6837895263093;2536.885840137198;2455.1897873701637;2523.73500782418;2524.810639202058;2527.6208568714746;2527.684039495063;2383.416063064543;2387.85672859629;2408.879556022192;2500.3124140861228;2528.2415275417393;2424.5756992526235;2506.6114752213434;2528.645989561463;2528.683914510686;2536.9238922832346;11809.763804723858;11904.464299106561;11906.523739050428;11914.987226085794;11924.523019079226;6665.900011499832;6835.384815366641;6879.5184337096425;6881.243063263037;6900.2409734929115;4132.73137246081;4303.4190384298345;4319.092990472004;4382.167388196264;4398.186335527937;1258.584667059868;1260.0171865944578;1263.2862432725572;1282.2242543261286;1309.2340980526403;15047.849521504755;15497.767533487007;16645.50063498085;16663.833361666348;16756;4827.927581086286;5525.751341189656;5681.2330335404195;5880.8235752927485;5952.553558483131;12213.389330533439;12459.688507787378;12488.81266780999;12494.750104998031;12508.624741257778;6695.230048544479;6708.664566771642;6711;6720.495962802809;6729.764458243938;6112.694365281718;6213.285472170668;6275.874482510324;6297.4962003039645;6351.2060992375955;4334.674899382559;4433.844815431445;4453.576910193527;4491.640668746492;4499.617532509707;1102.2945314998246;1330.381372661717;1344.6436694276024;1359.4018631801976;1370.6915943912738;686.6635348679112;789.2541548236861;802.3019972623855;805.5972013993004;813.7070654564352;6170.6914654268;6234.1583886174785;6255.937440625627;6335.524835637253;6381.329960354189;594.4887396838715;597.2713289786453;607.1439270628481;618.8391018335175;622.7260005597523;3863.8068096595057;4514.977425112919;4593.379893714373;4629.51390104041;4799.784009719571;14988.550343489713;15039.924800375928;15133.092014478947;15402.075875447508;15478.922605387126;14863.851361486246;15199.240037998277;15237.238138093051;15365.769513457308;15444.45944391941;8545.102764209792;8771.868421973675;8775.692850750193;8788.780280493038;8788.824223515621;5583.972080139573;6813.8977915330315;6849.315068493111;6913.51605387618;7104.04095447108;10948.945255273991;13194.934025330196;13196.60410187696;13476.460941562227;13689;13818.170909745448;14008.159510429407;14016.859831401556;14158.929205353907;14187.64530886736;10659.467026648792;10720.946395268285;10851.782964340828;10859.07697845692;10887.564497420015;10635.468226588795;11005.889941100486;11008.229423940247;11010.834837477283;11045.558177673125;9166.266698663958;9179.265658747418;9330.97359290464;9336.906630933603;9458.95270523643;9032.548372581214;9080;9104.1263845796;9145.222656074042;9278.304127190353;8114.052627369507;8207.507549546808;8272.255497005299;8288.254057134887;8301.709440169565;4848.878778030577;6022.759089636365;6067.332593414632;6114.510839132948;6350.7459701611415;6129.816105516842;6171.84570385744;6232.657203853832;6260;6277 18:38:40 INFO - PID 1640 | |4;prototype.html;406.06807377069623;406.5000049938576;408.5424324756273;410.56890265221546;422.36645032451344;5486.533644640201;6297.559170858041;6361.3956674116;6379.52153588481;6417.133686952254;4869.951300486994;5666.866626674671;5941.64350138992;5968.552358573113;6231.376862313767;4203.4115223868685;4718.528147185271;4735.218688916342;4777.880552986168;4779.928301075487;4622.953770462303;4773.785179666906;4779.426468823746;4799.424069111711;4807.61539076873;4152.56398078202;4542.8864278392975;4600.631949444053;4691.437027556698;4730.337752714623;3911;4631.305304204363;4711.7879695413785;4729.645276604234;4749.667523273372;3682.797446140461;4029.770919869439;4211.43145675333;4214.325707886724;4232.8518501852595;4599;4857.328469341848;5350.5184533392185;5427.972860135674;5892.528597712173;4910.533499317559;5578.497935185812;5582.972085139549;5605.635633683797;5612.466815652507;6066.605670631439;6435.646039467827;6630.336966303379;6696.59820410777;6714.764983225564;3899.640717365981;4672.392588963413;4725.787339569728;4738.241881298975;4750.382450281441;5653.8586535336535;6447.548671593037;6791.151106111736;6795.898061529032;6844.6652902684;3918.549366822795;4119.105211602697;4147.232761939051;4452.844150454784;4491.101779644085;4034.798260086984;4225.19721252961;4421.579949904753;4515.187266292099;4570.337301091323;4499.605122412063;4813.638977076734;5018.623603229772;5369.40936496985;5452.727363631802;5505.6696598204235;6614.8093343197725;6616.503762217853;6651.800445986628;6664.300248473937;1419.921904295253;1503.7068121415573;1556.7197904377094;1568.5921660368158;1573.5515378117182;971.9125278724948;1025.2823023883163;1032.4270030133198;1040.6305761454726;1050.8686414198226;5648.915266271009;5935.762569497172;6374.8525265451735;6415.935840641627;6454.386833250834;6332.208473940757;6374.426301632875;6623.337666233435;6903.965480172667;6942.340477654615;5159.406668233126;5700.344460387026;6346.587471814318;6356.110144579762;6434.8417284889165;3239.7084262416497;3576;3617.8914632561064;3636.5999740028574;3636.8727094551564;5923.674197919069;5990.801839632091;6598;6749.662516874137;7125;6242.344553821874;6803.693833777492;7107.502474826712;7146.249643787328;7163.498555101197;5931.635723783554;6832.856885832473;6846.965765171142;7021.719131234693;7179.425645948416;6864.279250678806;6864.622445765531;6865.210500792473;6884.690188941609;6896.896546551706;6488.935110648833;6743.426808721118;6744.595324280559;6793.592384456949;6850.349216824394;5056.873578160576;6718.798436046926;6773.159109299544;7017.543859649107;7222.602756848424;4506.932396013997;4508;4525.977370113128;4536.705114167568;4556.339330797082;6347.206599175103;6646.501512386493;6734.292899245705;6988.79033628992;7032.402245809163;5521.944780552143;6659.267480577229;6706.631135287606;6734.595924244561;6755.074803680927;5797.565182611405;6408.29508754046;6635.568688035262;6738.012286375433;6771.221309549464;5705.400932902152;6460.289368169404;6514.869702605826;6547.869042619216;6565;5714.742836572281;6130.601510901777;6550.47596192313;6637.668116594247;6800.727970881308;5841.766329346779;6373.920690757826;6462.483001359786;6463.903041454476;6502.902456463063 18:38:40 INFO - PID 1640 | |5;yui.html;812.4921923797626;819.0621738109865;821.5399376349245;838.874168874669;846.5640195299418;13685.863141368583;14301.928490357559;15972.84027159728;16163.434279800209;16507.33970641173;11823.34971576563;16226.594335141597;16748.66502669946;17053.14734263288;17246.482605521855;974.060032069055;979.3732011512637;992.0625009366152;996.5963784667222;997.1275134257525;984.2224642532426;994.4679596415918;996.9850452243222;998.880134383875;1000.3597697473587;1044.582167133149;1048.9824869876209;1052.2266134391216;1056.873175218971;1062.3625824505311;1044.7492601775557;1046.2937517175915;1048.365738728074;1048.7483004079043;1053.0101704397841;768.7078910014159;777.0558771093149;779.5011192836589;779.6608475313257;786.1705900275207;16261;16310.510684679479;16757.83242167575;16906.408275710415;16915.23881425339;14394.208318542476;16513.6697266054;16568.00591964486;16984.065876376793;17156.91421542897;11595.594154204648;13575.321233938264;14070.507532236425;14148.717025659533;14183.078099923472;3493.615702272748;3499.9300013999577;3517.7537572369943;3533.222691007974;3539.4513850353237;109569;117504;124790;125805;128196;12723.80914286268;13006.739865202642;13016.763407476275;13179.55024947255;13242.271675057964;25082.498350033264;25339.366515836882;25408.491830163664;25489.61765573518;25672.743272567037;7201.883708025264;7659.693612255559;7718.845623087507;7994.2805147537;8006.278650090258;3684.2263124744104;3944.9802750986637;3962.0887195945093;3986.2226865761477;3986.5415477219913;4064.898377540585;4117.938230926538;4200.537940826506;4202.85290014848;4203.873883783492;923.5566927874657;949.9525023748785;959.9424034557949;960.7646126698863;960.8366577681811;644.3298969072206;647.2362612117746;655.6557807151283;657.667877721757;682.5495173185674;11154.944225278983;11159.051480624237;11523.250988685877;12004.2197257178;13030.827225549747;562.4319437368206;582.8343313373254;659.0772917914958;662.7415308029872;675.5845155229597;5238.266642670029;5504.614676972574;5528.115501519737;5529.198266251451;5560.110382338807;88443;93179.53410232905;93375.53312233531;93894.5305273483;94802;87561.56219218863;87756.56121719479;88491.11508884828;88556.67164992531;90066.09933900708;75300.62349688326;76258;76783;78242;80738.78891816628;11882.08888822244;12281.570145044881;12381;12413.006959443042;12457.626271211879;31474.337303875134;37687.62312376841;40627.79686101551;41372.379414308205;41832.79083604563;67512;67607.98588021085;69250;69254.65372673105;71523.49667761603;16426.507204783877;16428.67142657164;16632.916835415745;16702.66594668124;16753.581160471087;17770.466885993443;17909.19408626641;17941.551461213574;18101.637967240316;18310.908445457688;14727.484538041117;14815.629609259424;14921.403143874124;15059.548213553611;15092.471763488225;15153.090814551162;16052.518424447286;16249.26878290456;16389.42637007699;16404.343826246815;14035.719285614026;15562.61093472627;15813.288402021706;15878.126703031445;15933.521994340188;11440.370779606868;11448.542058317908;11736.88263117358;12003.759924801281;12043.518259269531;11247.212695111264;12703.174293670882;12753.426095825896;13395.263260520765;13727.519536816164 18:38:40 INFO - PID 1640 | __end_tp_report 18:38:40 INFO - PID 1640 | __start_cc_report 18:38:40 INFO - PID 1640 | _x_x_mozilla_cycle_collect,424 18:38:40 INFO - PID 1640 | __end_cc_report 18:38:40 INFO - PID 1640 | __startTimestamp1492825120507__endTimestamp 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | ------- Summary: start ------- 18:38:40 INFO - PID 1640 | Number of tests: 6 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6122.13 Median:6382.59 stddev:769.87 (12.1%) stddev-sans-first:731.06 18:38:40 INFO - PID 1640 | Values: 2955.5 3120.4 3592.7 3642.0 3647.3 5737.7 6160.7 6202.8 6212.5 6320.4 6168.4 6238.3 6256.3 6283.1 6299.3 5515.3 5515.6 5547.5 5560.3 5644.9 5426.5 5556.8 5627.7 5642.1 5667.3 5395.1 5490.1 5531.5 5544.6 5564.9 5505.2 5507.4 5517.5 5529.8 5538.6 5405.9 5445.5 5459.9 5481.9 5532.0 5144.7 6100.5 6154.2 6190.9 6264.8 6670.5 6700.9 6704.5 6707.3 6729.3 6758.3 6758.9 6796.2 6803.0 6804.6 5052.4 6174.4 6317.0 6391.1 6402.9 6866.1 6871.7 6906.4 6913.5 6941.5 5045.8 6343.7 6376.0 6423.2 6433.0 6686.1 6697.2 6739.1 6747.5 6761.5 6307.1 6580.1 6715.0 6739.9 6750.6 5509.8 6309.2 6597.9 6665.3 6678.1 4792.7 5218.8 5222.8 5229.6 5236.9 4689.7 4697.0 4714.7 4716.6 4718.3 5461.2 5870.5 6362.1 6370.5 6404.4 5710.3 6732.0 6827.4 6836.6 6846.2 5423.9 6354.4 6374.4 6382.6 6424.2 4871.5 5816.5 5825.8 5846.4 5947.3 5665.9 6837.3 6972.8 6993.1 7008.9 6738.2 6782.7 6793.6 6810.9 6812.8 6950.4 6956.8 6991.1 6995.4 6997.7 6395.2 6454.8 6559.2 6636.9 6678.8 6459.9 6536.0 6794.3 6843.3 6851.9 6378.5 6524.7 6526.3 6534.8 6535.4 6511.4 6528.6 6535.4 6541.3 6560.3 6142.7 6311.8 6348.1 6390.4 6405.8 6499.8 6532.3 6533.7 6542.3 6555.6 6384.8 6402.7 6412.3 6418.8 6427.1 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:45599.60 Median:338018.50 stddev:80165.55 (23.7%) stddev-sans-first:80319.43 18:38:40 INFO - PID 1640 | Values: 662.7 785.9 808.1 1198.3 1236.0 37480.6 38299.4 38545.4 38568.4 38611.4 38508.0 38776.0 38791.8 38907.8 38926.4 7878.3 8019.4 8251.7 8443.1 8525.1 7380.5 8274.6 8453.4 8506.0 8564.5 8432.0 8441.2 8446.8 8490.0 8523.1 7313.3 8436.5 8460.7 8492.2 8507.0 8218.3 8279.6 8288.9 8290.6 8320.9 30795.8 37506.8 37548.0 37614.6 37740.6 3566.0 3584.5 3610.2 3610.8 3620.0 30803.5 30819.0 30896.7 30912.9 30940.2 3122.6 3130.5 3135.5 3137.8 3147.9 273061.0 275207.0 305334.0 314005.0 314109.0 47145.8 47591.3 47630.0 47716.0 47798.0 48035.6 48046.8 53529.2 55087.4 55106.4 13859.8 13884.7 14021.4 14042.9 14054.5 10995.2 11116.5 11192.2 11211.0 11222.8 13917.9 13941.5 13942.7 13954.8 13980.9 5162.6 5209.3 6158.2 6162.7 6181.2 1021.1 1022.5 1032.9 1055.4 1067.2 22676.7 23325.8 24781.6 24928.5 24973.9 1051.5 1124.2 1142.0 1163.6 1167.8 11776.0 12535.0 12585.3 12636.6 12671.6 336385.0 336726.0 338015.0 338022.0 338402.0 54467.5 54654.9 54688.7 54814.5 55135.7 1506.4 1511.3 1545.3 1552.9 1568.8 21211.6 22225.4 22976.0 24367.4 24753.5 37875.6 38026.4 38033.2 38128.0 38179.0 277586.0 278116.0 279528.0 279680.0 279710.0 35203.0 35253.0 35479.0 35531.0 35560.6 45501.5 45948.5 46487.5 46560.0 46730.6 23465.5 29603.3 29848.4 30842.8 31792.8 28550.1 30830.0 31367.8 31390.8 31776.7 37067.8 37119.0 37511.2 37700.0 37891.6 30568.8 31743.7 31892.0 32190.7 32508.8 23085.5 23635.1 24434.0 24672.9 24849.5 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:33417.41 Median:12513.65 stddev:84238.19 (673.2%) stddev-sans-first:84438.10 18:38:40 INFO - PID 1640 | Values: 434.8 437.0 440.6 459.6 463.6 21190.6 21289.7 21827.1 21844.6 21979.0 19247.3 21770.2 22724.3 23060.7 23293.8 4873.4 5730.8 5991.9 6205.2 6222.8 5988.5 6180.0 6182.4 6183.0 6186.8 5500.7 5859.5 5914.9 6101.4 6138.2 6104.2 6112.9 6127.0 6151.2 6184.2 4651.4 5283.4 5474.6 5490.7 5523.3 24523.8 24877.5 27578.0 27779.4 27974.6 2235.1 2303.0 2304.8 2305.3 2312.5 14606.5 17350.7 17767.4 17801.0 17989.6 1896.2 2162.4 2177.5 2230.8 2235.4 156093.0 157590.0 158249.0 159914.0 160832.0 12262.5 12952.7 12955.7 13024.5 13033.2 16480.5 16512.2 16548.2 16556.8 16603.4 8700.5 8992.0 9003.9 9102.6 9155.7 7119.9 8444.5 8521.2 8592.9 8719.3 7687.5 7815.5 7855.6 7857.1 7904.1 2159.5 2175.8 2179.3 2182.3 2371.1 866.4 960.0 968.4 969.5 972.0 20932.8 21510.5 21713.3 21842.6 21959.2 999.3 1003.3 1025.3 1030.2 1038.4 10762.6 11100.9 11161.0 11215.7 11223.6 397861.0 500132.0 503331.0 507279.0 535183.0 98896.0 129411.4 130009.0 133694.0 134442.0 1128.0 1137.2 1183.4 1185.1 1186.9 13869.9 15150.8 18316.6 18363.0 18855.8 42069.8 46191.5 53088.7 53103.0 54500.5 69630.7 70441.0 70708.3 71077.2 72911.3 6810.6 8547.0 8932.4 8989.5 9005.2 13793.5 13838.2 13977.1 14044.8 14458.8 11661.8 11721.8 12153.3 12233.9 12242.2 11134.7 11182.6 11185.7 11254.7 11477.4 11952.9 11956.0 12106.5 12259.2 12320.9 8624.0 8777.5 9028.3 9051.6 9190.9 11436.0 11971.0 12229.0 12304.3 12304.8 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7227.35 Median:2543.68 stddev:4583.44 (180.2%) stddev-sans-first:4573.61 18:38:40 INFO - PID 1640 | Values: 1158.4 1353.1 1380.5 1402.5 1411.5 11348.7 11804.5 11868.3 11883.9 12166.0 11842.7 11868.0 12019.0 12048.4 12052.0 2535.5 2550.4 2554.0 2571.2 2574.0 2484.8 2491.1 2523.7 2529.7 2536.9 2455.2 2523.7 2524.8 2527.6 2527.7 2383.4 2387.9 2408.9 2500.3 2528.2 2424.6 2506.6 2528.6 2528.7 2536.9 11809.8 11904.5 11906.5 11915.0 11924.5 6665.9 6835.4 6879.5 6881.2 6900.2 4132.7 4303.4 4319.1 4382.2 4398.2 1258.6 1260.0 1263.3 1282.2 1309.2 15047.8 15497.8 16645.5 16663.8 16756.0 4827.9 5525.8 5681.2 5880.8 5952.6 12213.4 12459.7 12488.8 12494.8 12508.6 6695.2 6708.7 6711.0 6720.5 6729.8 6112.7 6213.3 6275.9 6297.5 6351.2 4334.7 4433.8 4453.6 4491.6 4499.6 1102.3 1330.4 1344.6 1359.4 1370.7 686.7 789.3 802.3 805.6 813.7 6170.7 6234.2 6255.9 6335.5 6381.3 594.5 597.3 607.1 618.8 622.7 3863.8 4515.0 4593.4 4629.5 4799.8 14988.6 15039.9 15133.1 15402.1 15478.9 14863.9 15199.2 15237.2 15365.8 15444.5 8545.1 8771.9 8775.7 8788.8 8788.8 5584.0 6813.9 6849.3 6913.5 7104.0 10948.9 13194.9 13196.6 13476.5 13689.0 13818.2 14008.2 14016.9 14158.9 14187.6 10659.5 10720.9 10851.8 10859.1 10887.6 10635.5 11005.9 11008.2 11010.8 11045.6 9166.3 9179.3 9331.0 9336.9 9459.0 9032.5 9080.0 9104.1 9145.2 9278.3 8114.1 8207.5 8272.3 8288.3 8301.7 4848.9 6022.8 6067.3 6114.5 6350.7 6129.8 6171.8 6232.7 6260.0 6277.0 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5323.14 Median:5819.67 stddev:1659.85 (28.5%) stddev-sans-first:1622.96 18:38:40 INFO - PID 1640 | Values: 406.1 406.5 408.5 410.6 422.4 5486.5 6297.6 6361.4 6379.5 6417.1 4870.0 5666.9 5941.6 5968.6 6231.4 4203.4 4718.5 4735.2 4777.9 4779.9 4623.0 4773.8 4779.4 4799.4 4807.6 4152.6 4542.9 4600.6 4691.4 4730.3 3911.0 4631.3 4711.8 4729.6 4749.7 3682.8 4029.8 4211.4 4214.3 4232.9 4599.0 4857.3 5350.5 5428.0 5892.5 4910.5 5578.5 5583.0 5605.6 5612.5 6066.6 6435.6 6630.3 6696.6 6714.8 3899.6 4672.4 4725.8 4738.2 4750.4 5653.9 6447.5 6791.2 6795.9 6844.7 3918.5 4119.1 4147.2 4452.8 4491.1 4034.8 4225.2 4421.6 4515.2 4570.3 4499.6 4813.6 5018.6 5369.4 5452.7 5505.7 6614.8 6616.5 6651.8 6664.3 1419.9 1503.7 1556.7 1568.6 1573.6 971.9 1025.3 1032.4 1040.6 1050.9 5648.9 5935.8 6374.9 6415.9 6454.4 6332.2 6374.4 6623.3 6904.0 6942.3 5159.4 5700.3 6346.6 6356.1 6434.8 3239.7 3576.0 3617.9 3636.6 3636.9 5923.7 5990.8 6598.0 6749.7 7125.0 6242.3 6803.7 7107.5 7146.2 7163.5 5931.6 6832.9 6847.0 7021.7 7179.4 6864.3 6864.6 6865.2 6884.7 6896.9 6488.9 6743.4 6744.6 6793.6 6850.3 5056.9 6718.8 6773.2 7017.5 7222.6 4506.9 4508.0 4526.0 4536.7 4556.3 6347.2 6646.5 6734.3 6988.8 7032.4 5521.9 6659.3 6706.6 6734.6 6755.1 5797.6 6408.3 6635.6 6738.0 6771.2 5705.4 6460.3 6514.9 6547.9 6565.0 5714.7 6130.6 6550.5 6637.7 6800.7 5841.8 6373.9 6462.5 6463.9 6502.9 18:38:40 INFO - PID 1640 | 18:38:40 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:21272.54 Median:21696.70 stddev:29538.51 (136.1%) stddev-sans-first:29581.42 18:38:40 INFO - PID 1640 | Values: 812.5 819.1 821.5 838.9 846.6 13685.9 14301.9 15972.8 16163.4 16507.3 11823.3 16226.6 16748.7 17053.1 17246.5 974.1 979.4 992.1 996.6 997.1 984.2 994.5 997.0 998.9 1000.4 1044.6 1049.0 1052.2 1056.9 1062.4 1044.7 1046.3 1048.4 1048.7 1053.0 768.7 777.1 779.5 779.7 786.2 16261.0 16310.5 16757.8 16906.4 16915.2 14394.2 16513.7 16568.0 16984.1 17156.9 11595.6 13575.3 14070.5 14148.7 14183.1 3493.6 3499.9 3517.8 3533.2 3539.5 109569.0 117504.0 124790.0 125805.0 128196.0 12723.8 13006.7 13016.8 13179.6 13242.3 25082.5 25339.4 25408.5 25489.6 25672.7 7201.9 7659.7 7718.8 7994.3 8006.3 3684.2 3945.0 3962.1 3986.2 3986.5 4064.9 4117.9 4200.5 4202.9 4203.9 923.6 950.0 959.9 960.8 960.8 644.3 647.2 655.7 657.7 682.5 11154.9 11159.1 11523.3 12004.2 13030.8 562.4 582.8 659.1 662.7 675.6 5238.3 5504.6 5528.1 5529.2 5560.1 88443.0 93179.5 93375.5 93894.5 94802.0 87561.6 87756.6 88491.1 88556.7 90066.1 75300.6 76258.0 76783.0 78242.0 80738.8 11882.1 12281.6 12381.0 12413.0 12457.6 31474.3 37687.6 40627.8 41372.4 41832.8 67512.0 67608.0 69250.0 69254.7 71523.5 16426.5 16428.7 16632.9 16702.7 16753.6 17770.5 17909.2 17941.6 18101.6 18310.9 14727.5 14815.6 14921.4 15059.5 15092.5 15153.1 16052.5 16249.3 16389.4 16404.3 14035.7 15562.6 15813.3 15878.1 15933.5 11440.4 11448.5 11736.9 12003.8 12043.5 11247.2 12703.2 12753.4 13395.3 13727.5 18:38:40 INFO - PID 1640 | -------- Summary: end -------- 18:38:40 INFO - PID 1640 | 18:38:41 INFO - TEST-INFO | 1640: exit 0 18:38:41 INFO - TEST-OK | dromaeo_css | took 1115061ms 18:38:41 INFO - TEST-START | kraken 18:38:41 INFO - operating with platform_type : mac_ 18:38:41 INFO - Initialising browser for kraken test... 18:38:41 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp3KU11k/profile http://localhost:49242/getInfo.html) 18:38:43 INFO - PID 1653 | 2017-04-21 18:38:43.838 plugin-container[1654:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 18:38:43 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:38:43 INFO - PID 1653 | 2017-04-21 18:38:43.840 plugin-container[1654:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 18:38:43 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:38:43 INFO - PID 1653 | 2017-04-21 18:38:43.840 plugin-container[1654:10235] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:38:43 INFO - PID 1653 | __metrics Screen width/height:1600/1200 18:38:43 INFO - PID 1653 | colorDepth:24 18:38:43 INFO - PID 1653 | Browser inner width/height: 1024/689 18:38:43 INFO - PID 1653 | __metrics 18:38:44 ERROR - PID 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 18:38:45 INFO - TEST-INFO | 1653: exit 0 18:38:45 INFO - Browser initialized. 18:38:45 INFO - Running cycle 1/1 for kraken test... 18:38:45 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp3KU11k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:47 INFO - PID 1655 | 2017-04-21 18:38:47.532 plugin-container[1656:10369] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 18:38:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:38:47 INFO - PID 1655 | 2017-04-21 18:38:47.533 plugin-container[1656:10369] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 18:38:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:38:47 INFO - PID 1655 | 2017-04-21 18:38:47.533 plugin-container[1656:10369] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:38:57 INFO - PID 1655 | RSS: Main: 236355584 18:38:57 INFO - PID 1655 | 18:39:00 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 18:39:01 INFO - PID 1655 | RSS: Main: 248934400 18:39:01 INFO - PID 1655 | 18:39:03 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 18:39:04 INFO - PID 1655 | RSS: Main: 257204224 18:39:04 INFO - PID 1655 | 18:39:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 18:39:08 INFO - PID 1655 | RSS: Main: 260075520 18:39:08 INFO - PID 1655 | 18:39:10 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 18:39:10 INFO - PID 1655 | RSS: Main: 260861952 18:39:10 INFO - PID 1655 | 18:39:12 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:39:13 INFO - PID 1655 | RSS: Main: 261259264 18:39:13 INFO - PID 1655 | 18:39:16 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:17 INFO - PID 1655 | RSS: Main: 268021760 18:39:17 INFO - PID 1655 | 18:39:20 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 18:39:20 INFO - PID 1655 | RSS: Main: 269336576 18:39:20 INFO - PID 1655 | 18:39:23 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 18:39:24 INFO - PID 1655 | RSS: Main: 269279232 18:39:24 INFO - PID 1655 | 18:39:25 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:26 INFO - PID 1655 | RSS: Main: 268595200 18:39:26 INFO - PID 1655 | 18:39:28 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:28 INFO - PID 1655 | RSS: Main: 268910592 18:39:28 INFO - PID 1655 | 18:39:31 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:31 INFO - PID 1655 | RSS: Main: 268296192 18:39:31 INFO - PID 1655 | 18:39:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:35 INFO - PID 1655 | RSS: Main: 268410880 18:39:35 INFO - PID 1655 | 18:39:38 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:38 INFO - PID 1655 | RSS: Main: 268705792 18:39:38 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 18:39:40 INFO - PID 1655 | RSS: Main: 270163968 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | __start_tp_report 18:39:40 INFO - PID 1655 | _x_x_mozilla_page_load 18:39:40 INFO - PID 1655 | _x_x_mozilla_page_load_details 18:39:40 INFO - PID 1655 | |i|pagename|runs| 18:39:40 INFO - PID 1655 | |0;ai-astar;102;114;114;113;123;115;115;115;115;115 18:39:40 INFO - PID 1655 | |1;audio-beat-detection;142;126;111;150;126;152;145;102;158;105 18:39:40 INFO - PID 1655 | |2;audio-dft;197;202;211;220;226;199;200;259;200;201 18:39:40 INFO - PID 1655 | |3;audio-fft;82;58;65;83;62;84;83;84;72;87 18:39:40 INFO - PID 1655 | |4;audio-oscillator;91;70;83;70;74;70;100;100;101;117 18:39:40 INFO - PID 1655 | |5;imaging-gaussian-blur;90;97;135;84;136;100;88;88;89;89 18:39:40 INFO - PID 1655 | |6;imaging-darkroom;96;96;97;96;97;96;95;96;97;96 18:39:40 INFO - PID 1655 | |7;imaging-desaturate;117;95;89;90;89;92;83;91;90;140 18:39:40 INFO - PID 1655 | |8;json-parse-financial;51;51;50;51;51;50;52;54;54;71 18:39:40 INFO - PID 1655 | |9;json-stringify-tinderbox;59;60;58;63;64;63;59;60;60;59 18:39:40 INFO - PID 1655 | |10;stanford-crypto-aes;81;85;85;86;83;86;81;87;84;82 18:39:40 INFO - PID 1655 | |11;stanford-crypto-ccm;139;139;139;136;139;135;133;135;192;165 18:39:40 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;187;187;185;188;183;187;182;188;191;185 18:39:40 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;70;69;68;70;69;69;69;68;69;68 18:39:40 INFO - PID 1655 | __end_tp_report 18:39:40 INFO - PID 1655 | __start_cc_report 18:39:40 INFO - PID 1655 | _x_x_mozilla_cycle_collect,1007 18:39:40 INFO - PID 1655 | __end_cc_report 18:39:40 INFO - PID 1655 | __startTimestamp1492825180863__endTimestamp 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | ------- Summary: start ------- 18:39:40 INFO - PID 1655 | Number of tests: 14 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:5.07 (4.4%) stddev-sans-first:2.92 18:39:40 INFO - PID 1655 | Values: 102.0 114.0 114.0 113.0 123.0 115.0 115.0 115.0 115.0 115.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:143.50 stddev:20.58 (14.3%) stddev-sans-first:21.48 18:39:40 INFO - PID 1655 | Values: 142.0 126.0 111.0 150.0 126.0 152.0 145.0 102.0 158.0 105.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:211.50 Median:206.50 stddev:19.35 (9.4%) stddev-sans-first:19.80 18:39:40 INFO - PID 1655 | Values: 197.0 202.0 211.0 220.0 226.0 199.0 200.0 259.0 200.0 201.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:76.00 Median:83.00 stddev:10.75 (13.0%) stddev-sans-first:11.18 18:39:40 INFO - PID 1655 | Values: 82.0 58.0 65.0 83.0 62.0 84.0 83.0 84.0 72.0 87.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:70.00 stddev:16.66 (23.8%) stddev-sans-first:17.63 18:39:40 INFO - PID 1655 | Values: 91.0 70.0 83.0 70.0 74.0 70.0 100.0 100.0 101.0 117.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:88.50 stddev:19.48 (22.0%) stddev-sans-first:20.35 18:39:40 INFO - PID 1655 | Values: 90.0 97.0 135.0 84.0 136.0 100.0 88.0 88.0 89.0 89.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:39:40 INFO - PID 1655 | Values: 96.0 96.0 97.0 96.0 97.0 96.0 95.0 96.0 97.0 96.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:90.00 stddev:17.42 (19.4%) stddev-sans-first:17.01 18:39:40 INFO - PID 1655 | Values: 117.0 95.0 89.0 90.0 89.0 92.0 83.0 91.0 90.0 140.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:51.50 stddev:6.31 (12.3%) stddev-sans-first:6.63 18:39:40 INFO - PID 1655 | Values: 51.0 51.0 50.0 51.0 51.0 50.0 52.0 54.0 54.0 71.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:2.07 (3.4%) stddev-sans-first:2.12 18:39:40 INFO - PID 1655 | Values: 59.0 60.0 58.0 63.0 64.0 63.0 59.0 60.0 60.0 59.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.00 stddev:2.16 (2.5%) stddev-sans-first:2.00 18:39:40 INFO - PID 1655 | Values: 81.0 85.0 85.0 86.0 83.0 86.0 81.0 87.0 84.0 82.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:139.00 stddev:18.79 (13.5%) stddev-sans-first:19.80 18:39:40 INFO - PID 1655 | Values: 139.0 139.0 139.0 136.0 139.0 135.0 133.0 135.0 192.0 165.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:187.00 stddev:2.63 (1.4%) stddev-sans-first:2.77 18:39:40 INFO - PID 1655 | Values: 187.0 187.0 185.0 188.0 183.0 187.0 182.0 188.0 191.0 185.0 18:39:40 INFO - PID 1655 | 18:39:40 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 18:39:40 INFO - PID 1655 | Values: 70.0 69.0 68.0 70.0 69.0 69.0 69.0 68.0 69.0 68.0 18:39:40 INFO - PID 1655 | -------- Summary: end -------- 18:39:40 INFO - PID 1655 | 18:39:42 INFO - TEST-INFO | 1655: exit 0 18:39:42 INFO - TEST-OK | kraken | took 60948ms 18:39:42 INFO - SUITE-END | took 1176s 18:39:42 INFO - Completed test suite (00:19:36) 18:39:42 INFO - javascript benchmark 18:39:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7856.520476804302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.4975654138793, 3120.391523652888, 3592.694620957217, 3642.016655503014, 3647.2705458908217, 5737.713114344287, 6160.722767475463, 6202.751889924403, 6212.471939885109, 6320.399562041604, 6168.4448399644025, 6238.251409830816, 6256.343083976174, 6283.057541368786, 6299.307076221612, 5515.255440515539, 5515.641483303592, 5547.472990065938, 5560.332760068777, 5644.915326270109, 5426.511613954744, 5556.833295001156, 5627.7186140693, 5642.1254705520505, 5667.348254950672, 5395.0558652236095, 5490.149026900836, 5531.474509921551, 5544.61187716858, 5564.86087847803, 5505.229267902497, 5507.366652834895, 5517.531009864167, 5529.834104976857, 5538.556915446755, 5405.864853378657, 5445.50990410865, 5459.890802183973, 5481.917771233435, 5531.976584331871, 5144.74276286188, 6100.511959043266, 6154.230721159855, 6190.907136392958, 6264.812055638338, 6670.4997125215805, 6700.865982680319, 6704.497162712767, 6707.262201157869, 6729.25978142404, 6758.256591774901, 6758.9324106758795, 6796.184457865088, 6803.0, 6804.6257455839905, 5052.3937127544195, 6174.38256174379, 6317.0, 6391.10524526562, 6402.871942561169, 6866.073080134218, 6871.690773915186, 6906.412954898889, 6913.51605387618, 6941.514094013472, 5045.798168073309, 6343.651099189497, 6375.968120159462, 6423.164988551458, 6432.970724684028, 6686.13080299558, 6697.196336439659, 6739.090222819955, 6747.527673062937, 6761.492888033417, 6307.085472606446, 6580.1116849224745, 6715.026321183401, 6739.93260067393, 6750.561213521204, 5509.752061157257, 6309.211348581427, 6597.934020659732, 6665.266820649725, 6678.065070890079, 4792.664513484093, 5218.7912483500995, 5222.764975576109, 5229.607779416483, 5236.869078272997, 4689.6717229793585, 4696.953030469652, 4714.66997310185, 4716.622670186377, 4718.268668356411, 5461.15352120422, 5870.471657550841, 6362.077498762654, 6370.458511026614, 6404.423601875854, 5710.2576665033275, 6732.0, 6827.419669328064, 6836.555623884432, 6846.212685541127, 5423.860989192235, 6354.3963323484195, 6374.394432528902, 6382.585131966407, 6424.196975378078, 4871.51418817257, 5816.5055970243, 5825.825225243249, 5846.386129456431, 5947.316058653224, 5665.915011274917, 6837.3162683731225, 6972.825679358057, 6993.0908981832035, 7008.894866576903, 6738.191417029988, 6782.69477873487, 6793.626350550767, 6810.897836532555, 6812.795616131524, 6950.409215216763, 6956.79129626112, 6991.126109236346, 6995.405390541861, 6997.685104170223, 6395.20059992501, 6454.774082907075, 6559.245686746085, 6636.867262654623, 6678.83302917431, 6459.935400645933, 6536.0, 6794.320567943364, 6843.349881761224, 6851.862962740817, 6378.45783108441, 6524.706388212637, 6526.282108967915, 6534.803955881332, 6535.411812936859, 6511.446527045254, 6528.640924749185, 6535.379138981789, 6541.34586541342, 6560.278369379269, 6142.662153581596, 6311.842203944754, 6348.079528468438, 6390.360963903572, 6405.8398540035005, 6499.837504062436, 6532.346765323619, 6533.738650454119, 6542.280349161493, 6555.573887697285, 6384.808455746335, 6402.711877965409, 6412.326705696021, 6418.839529011812, 6427.132337134427], "value": 6070.246170324683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.6885363878976, 785.8624740670383, 808.1070417189006, 1198.3469009389883, 1235.950561977521, 37480.625193748056, 38299.42550861736, 38545.421818672745, 38568.42147367792, 38611.42082868756, 38508.0, 38776.0, 38791.80604096982, 38907.805460972726, 38926.41610375846, 7878.290953814156, 8019.35845132388, 8251.711190108348, 8443.11347308533, 8525.104863989254, 7380.520266182708, 8274.627641756106, 8453.408261421702, 8506.021807492156, 8564.48613083217, 8432.0, 8441.15588441154, 8446.83106337873, 8489.95755021224, 8523.062463129081, 7313.341799238041, 8436.493810371336, 8460.703875364363, 8492.193241642066, 8507.0, 8218.260356567878, 8279.58602069894, 8288.875666865002, 8290.585470726439, 8320.875186872201, 30795.846020769975, 37506.812465937495, 37548.0, 37614.62385376138, 37740.62259377426, 3566.0, 3584.5160903277983, 3610.151614370621, 3610.819459027038, 3620.0, 30803.537946930588, 30819.0, 30896.691033089606, 30912.918047868217, 30940.226494337596, 3122.6408962969094, 3130.4834702274097, 3135.529670549413, 3137.8274194919272, 3147.8740850365957, 273061.0, 275207.0, 305334.0, 314004.99999999773, 314109.0, 47145.76427117842, 47591.28613070807, 47630.04739905182, 47716.0, 47798.0, 48035.55893323206, 48046.75976620164, 53529.1970620441, 55087.44912550823, 55106.44893551013, 13859.792103118461, 13884.652883677787, 14021.369038393297, 14042.929785351007, 14054.508092216724, 10995.175361847894, 11116.499757510932, 11192.216544841784, 11211.047060999907, 11222.775544489228, 13917.86082139186, 13941.512047078304, 13942.721145577032, 13954.790678139836, 13980.930095349662, 5162.5869930406225, 5209.270702101709, 6158.230221222348, 6162.691865406712, 6181.196444462281, 1021.1218352217087, 1022.4529876516028, 1032.8690084357615, 1055.3773273768513, 1067.2049323254225, 22676.65985010226, 23325.7667423327, 24781.62827557588, 24928.541445961662, 24973.87513062423, 1051.4795176387738, 1124.1512657943201, 1142.017864636412, 1163.5811108001112, 1167.830664553635, 11776.0, 12535.0, 12585.307808070462, 12636.55772047974, 12671.619851404472, 336385.0, 336726.0, 338015.0, 338022.0, 338402.0, 54467.45532544703, 54654.90690186174, 54688.726556366964, 54814.45185548173, 55135.72432137813, 1506.352268524523, 1511.3199060422635, 1545.3432291276163, 1552.8835337349517, 1568.756842689385, 21211.575768484854, 22225.44436389103, 22975.966081526036, 24367.390815229053, 24753.50492990094, 37875.62124378721, 38026.42960355652, 38033.23933521369, 38128.0, 38179.0, 277586.0, 278116.0, 279528.0, 279680.0, 279710.0, 35203.0, 35253.0, 35479.0, 35531.0, 35560.64439355573, 45501.54498454973, 45948.540514594424, 46487.53512464832, 46560.0, 46730.59808205759, 23465.530689385774, 29603.259918502208, 29848.43721148455, 30842.84578577093, 31792.841035794674, 28550.14895729891, 30830.0, 31367.84316078405, 31390.843045784626, 31776.682233178297, 37067.814660926524, 37119.0, 37511.24977500489, 37700.0, 37891.62108378991, 30568.84715576408, 31743.682563174072, 31892.0, 32190.67809321877, 32508.83745581257, 23085.538289233784, 23635.054597815895, 24433.994086949562, 24672.876635616707, 24849.503009939337], "value": 17576.9889425925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.7826086956522, 437.0101719605095, 440.56604244818845, 459.5840764108482, 463.6082510278815, 21190.57618847624, 21289.680654790172, 21827.1446927011, 21844.563108737835, 21979.010944507496, 19247.326343577977, 21770.238041668545, 22724.318270451913, 23060.654090188662, 23293.767062329414, 4873.366462359888, 5730.825180837918, 5991.880162396749, 6205.22434695663, 6222.751089956397, 5988.490978266831, 6180.0, 6182.443580077792, 6182.969085154568, 6186.783462578811, 5500.724963751816, 5859.531237501011, 5914.9112763308585, 6101.4203650653335, 6138.202033735631, 6104.206453161083, 6112.938870611304, 6126.989046807272, 6151.200343955257, 6184.196054512884, 4651.418572678415, 5283.418823929364, 5474.562035037187, 5490.670559766427, 5523.309586301712, 24523.754762452325, 24877.50244995108, 27578.0, 27779.444411111665, 27974.580381294298, 2235.1282999630157, 2302.976970230293, 2304.8271379646594, 2305.2853615379117, 2312.4681323295736, 14606.488772892897, 17350.652986940317, 17767.378141765104, 17801.02094384808, 17989.550261243443, 1896.2035944903037, 2162.37291185556, 2177.4665207024223, 2230.7769223077726, 2235.441139715071, 156093.0, 157590.0, 158249.0, 159914.0, 160831.99999999884, 12262.509499620093, 12952.740945181233, 12955.676108097185, 13024.47902083906, 13033.218006919615, 16480.505584832474, 16512.174391280627, 16548.172591370385, 16556.75164872528, 16603.41888033913, 8700.4718458861, 8991.955040224888, 9003.909960900439, 9102.635894564144, 9155.725328240163, 7119.857602847914, 8444.493330400195, 8521.190486903859, 8592.8711069334, 8719.258862996716, 7687.500312479671, 7815.491993020435, 7855.567943763033, 7857.096433910059, 7904.130545639975, 2159.4709296222527, 2175.782421757843, 2179.259051922322, 2182.2907555044676, 2371.122684606672, 866.4454748960544, 959.9568019439142, 968.4286271100085, 969.4958621516772, 971.9854202186973, 20932.79067209339, 21510.46223844385, 21713.34859954172, 21842.563148736936, 21959.231426899983, 999.3304485994402, 1003.2826529031631, 1025.2720568396373, 1030.2376241581326, 1038.3873514626407, 10762.56949722018, 11100.906044433412, 11161.0, 11215.66353009411, 11223.607173749044, 397861.0, 500132.0, 503331.0, 507279.0, 535183.0, 98896.01103988868, 129411.35294323468, 130009.0, 133694.0, 134442.0, 1127.994360028211, 1137.175547727907, 1183.378726168751, 1185.1170877696, 1186.9465874035689, 13869.930650346683, 15150.848491514944, 18316.633667326314, 18362.990035548173, 18855.811441885955, 42069.78965105155, 46191.538084618725, 53088.67278317919, 53103.0, 54500.454995451124, 69630.65184674044, 70441.0, 70708.29291707017, 71077.22306942161, 72911.27088729045, 6810.5913645181445, 8546.957265213883, 8932.374733768835, 8989.46063236208, 9005.189532942066, 13793.517226897011, 13838.23889686077, 13977.091489053179, 14044.78932816029, 14458.783118253024, 11661.76676466449, 11721.824172637247, 12153.331566763913, 12233.877661223274, 12242.204256723284, 11134.665960021212, 11182.608608698982, 11185.66443006711, 11254.662360129209, 11477.368744718786, 11952.940235298767, 11956.0, 12106.455209515418, 12259.203151795462, 12320.938395307967, 8623.956880215559, 8777.473351598925, 9028.277737781093, 9051.637934482547, 9190.862137067816, 11436.0, 11971.0, 12229.0, 12304.26174429537, 12304.75390492203], "value": 10300.961443585056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1158.380266557392, 1353.0934274036401, 1380.4754193406504, 1402.495101763365, 1411.5059729094814, 11348.71628209294, 11804.527818887256, 11868.347240901747, 11883.881161188385, 12166.0, 11842.703932401695, 11867.991220746226, 12019.038476921847, 12048.39758012098, 12051.975582075534, 2535.543602151612, 2550.426154115328, 2553.9744602553924, 2571.1643715792347, 2574.0218716887557, 2484.8012159027235, 2491.0658503061354, 2523.747625237471, 2529.6837895263093, 2536.885840137198, 2455.1897873701637, 2523.73500782418, 2524.810639202058, 2527.6208568714746, 2527.684039495063, 2383.416063064543, 2387.85672859629, 2408.879556022192, 2500.3124140861228, 2528.2415275417393, 2424.5756992526235, 2506.6114752213434, 2528.645989561463, 2528.683914510686, 2536.9238922832346, 11809.763804723858, 11904.464299106561, 11906.523739050428, 11914.987226085794, 11924.523019079226, 6665.900011499832, 6835.384815366641, 6879.5184337096425, 6881.243063263037, 6900.2409734929115, 4132.73137246081, 4303.4190384298345, 4319.092990472004, 4382.167388196264, 4398.186335527937, 1258.584667059868, 1260.0171865944578, 1263.2862432725572, 1282.2242543261286, 1309.2340980526403, 15047.849521504755, 15497.767533487007, 16645.50063498085, 16663.833361666348, 16756.0, 4827.927581086286, 5525.751341189656, 5681.2330335404195, 5880.8235752927485, 5952.553558483131, 12213.389330533439, 12459.688507787378, 12488.81266780999, 12494.750104998031, 12508.624741257778, 6695.230048544479, 6708.664566771642, 6711.0, 6720.495962802809, 6729.764458243938, 6112.694365281718, 6213.285472170668, 6275.874482510324, 6297.4962003039645, 6351.2060992375955, 4334.674899382559, 4433.844815431445, 4453.576910193527, 4491.640668746492, 4499.617532509707, 1102.2945314998246, 1330.381372661717, 1344.6436694276024, 1359.4018631801976, 1370.6915943912738, 686.6635348679112, 789.2541548236861, 802.3019972623855, 805.5972013993004, 813.7070654564352, 6170.6914654268, 6234.1583886174785, 6255.937440625627, 6335.524835637253, 6381.329960354189, 594.4887396838715, 597.2713289786453, 607.1439270628481, 618.8391018335175, 622.7260005597523, 3863.8068096595057, 4514.977425112919, 4593.379893714373, 4629.51390104041, 4799.784009719571, 14988.550343489713, 15039.924800375928, 15133.092014478947, 15402.075875447508, 15478.922605387126, 14863.851361486246, 15199.240037998277, 15237.238138093051, 15365.769513457308, 15444.45944391941, 8545.102764209792, 8771.868421973675, 8775.692850750193, 8788.780280493038, 8788.824223515621, 5583.972080139573, 6813.8977915330315, 6849.315068493111, 6913.51605387618, 7104.04095447108, 10948.945255273991, 13194.934025330196, 13196.60410187696, 13476.460941562227, 13689.0, 13818.170909745448, 14008.159510429407, 14016.859831401556, 14158.929205353907, 14187.64530886736, 10659.467026648792, 10720.946395268285, 10851.782964340828, 10859.07697845692, 10887.564497420015, 10635.468226588795, 11005.889941100486, 11008.229423940247, 11010.834837477283, 11045.558177673125, 9166.266698663958, 9179.265658747418, 9330.97359290464, 9336.906630933603, 9458.95270523643, 9032.548372581214, 9080.0, 9104.1263845796, 9145.222656074042, 9278.304127190353, 8114.052627369507, 8207.507549546808, 8272.255497005299, 8288.254057134887, 8301.709440169565, 4848.878778030577, 6022.759089636365, 6067.332593414632, 6114.510839132948, 6350.7459701611415, 6129.816105516842, 6171.84570385744, 6232.657203853832, 6260.0, 6277.0], "value": 5393.521793975819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.06807377069623, 406.5000049938576, 408.5424324756273, 410.56890265221546, 422.36645032451344, 5486.533644640201, 6297.559170858041, 6361.3956674116, 6379.52153588481, 6417.133686952254, 4869.951300486994, 5666.866626674671, 5941.64350138992, 5968.552358573113, 6231.376862313767, 4203.4115223868685, 4718.528147185271, 4735.218688916342, 4777.880552986168, 4779.928301075487, 4622.953770462303, 4773.785179666906, 4779.426468823746, 4799.424069111711, 4807.61539076873, 4152.56398078202, 4542.8864278392975, 4600.631949444053, 4691.437027556698, 4730.337752714623, 3911.0, 4631.305304204363, 4711.7879695413785, 4729.645276604234, 4749.667523273372, 3682.797446140461, 4029.770919869439, 4211.43145675333, 4214.325707886724, 4232.8518501852595, 4599.0, 4857.328469341848, 5350.5184533392185, 5427.972860135674, 5892.528597712173, 4910.533499317559, 5578.497935185812, 5582.972085139549, 5605.635633683797, 5612.466815652507, 6066.605670631439, 6435.646039467827, 6630.336966303379, 6696.59820410777, 6714.764983225564, 3899.640717365981, 4672.392588963413, 4725.787339569728, 4738.241881298975, 4750.382450281441, 5653.8586535336535, 6447.548671593037, 6791.151106111736, 6795.898061529032, 6844.6652902684, 3918.549366822795, 4119.105211602697, 4147.232761939051, 4452.844150454784, 4491.101779644085, 4034.798260086984, 4225.19721252961, 4421.579949904753, 4515.187266292099, 4570.337301091323, 4499.605122412063, 4813.638977076734, 5018.623603229772, 5369.40936496985, 5452.727363631802, 5505.6696598204235, 6614.8093343197725, 6616.503762217853, 6651.800445986628, 6664.300248473937, 1419.921904295253, 1503.7068121415573, 1556.7197904377094, 1568.5921660368158, 1573.5515378117182, 971.9125278724948, 1025.2823023883163, 1032.4270030133198, 1040.6305761454726, 1050.8686414198226, 5648.915266271009, 5935.762569497172, 6374.8525265451735, 6415.935840641627, 6454.386833250834, 6332.208473940757, 6374.426301632875, 6623.337666233435, 6903.965480172667, 6942.340477654615, 5159.406668233126, 5700.344460387026, 6346.587471814318, 6356.110144579762, 6434.8417284889165, 3239.7084262416497, 3576.0, 3617.8914632561064, 3636.5999740028574, 3636.8727094551564, 5923.674197919069, 5990.801839632091, 6598.0, 6749.662516874137, 7125.0, 6242.344553821874, 6803.693833777492, 7107.502474826712, 7146.249643787328, 7163.498555101197, 5931.635723783554, 6832.856885832473, 6846.965765171142, 7021.719131234693, 7179.425645948416, 6864.279250678806, 6864.622445765531, 6865.210500792473, 6884.690188941609, 6896.896546551706, 6488.935110648833, 6743.426808721118, 6744.595324280559, 6793.592384456949, 6850.349216824394, 5056.873578160576, 6718.798436046926, 6773.159109299544, 7017.543859649107, 7222.602756848424, 4506.932396013997, 4508.0, 4525.977370113128, 4536.705114167568, 4556.339330797082, 6347.206599175103, 6646.501512386493, 6734.292899245705, 6988.79033628992, 7032.402245809163, 5521.944780552143, 6659.267480577229, 6706.631135287606, 6734.595924244561, 6755.074803680927, 5797.565182611405, 6408.29508754046, 6635.568688035262, 6738.012286375433, 6771.221309549464, 5705.400932902152, 6460.289368169404, 6514.869702605826, 6547.869042619216, 6565.0, 5714.742836572281, 6130.601510901777, 6550.47596192313, 6637.668116594247, 6800.727970881308, 5841.766329346779, 6373.920690757826, 6462.483001359786, 6463.903041454476, 6502.902456463063], "value": 4810.328607703507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.4921923797626, 819.0621738109865, 821.5399376349245, 838.874168874669, 846.5640195299418, 13685.863141368583, 14301.928490357559, 15972.84027159728, 16163.434279800209, 16507.33970641173, 11823.34971576563, 16226.594335141597, 16748.66502669946, 17053.14734263288, 17246.482605521855, 974.060032069055, 979.3732011512637, 992.0625009366152, 996.5963784667222, 997.1275134257525, 984.2224642532426, 994.4679596415918, 996.9850452243222, 998.880134383875, 1000.3597697473587, 1044.582167133149, 1048.9824869876209, 1052.2266134391216, 1056.873175218971, 1062.3625824505311, 1044.7492601775557, 1046.2937517175915, 1048.365738728074, 1048.7483004079043, 1053.0101704397841, 768.7078910014159, 777.0558771093149, 779.5011192836589, 779.6608475313257, 786.1705900275207, 16261.0, 16310.510684679479, 16757.83242167575, 16906.408275710415, 16915.23881425339, 14394.208318542476, 16513.6697266054, 16568.00591964486, 16984.065876376793, 17156.91421542897, 11595.594154204648, 13575.321233938264, 14070.507532236425, 14148.717025659533, 14183.078099923472, 3493.615702272748, 3499.9300013999577, 3517.7537572369943, 3533.222691007974, 3539.4513850353237, 109569.0, 117504.0, 124790.0, 125805.0, 128196.0, 12723.80914286268, 13006.739865202642, 13016.763407476275, 13179.55024947255, 13242.271675057964, 25082.498350033264, 25339.366515836882, 25408.491830163664, 25489.61765573518, 25672.743272567037, 7201.883708025264, 7659.693612255559, 7718.845623087507, 7994.2805147537, 8006.278650090258, 3684.2263124744104, 3944.9802750986637, 3962.0887195945093, 3986.2226865761477, 3986.5415477219913, 4064.898377540585, 4117.938230926538, 4200.537940826506, 4202.85290014848, 4203.873883783492, 923.5566927874657, 949.9525023748785, 959.9424034557949, 960.7646126698863, 960.8366577681811, 644.3298969072206, 647.2362612117746, 655.6557807151283, 657.667877721757, 682.5495173185674, 11154.944225278983, 11159.051480624237, 11523.250988685877, 12004.2197257178, 13030.827225549747, 562.4319437368206, 582.8343313373254, 659.0772917914958, 662.7415308029872, 675.5845155229597, 5238.266642670029, 5504.614676972574, 5528.115501519737, 5529.198266251451, 5560.110382338807, 88443.0, 93179.53410232905, 93375.53312233531, 93894.5305273483, 94802.0, 87561.56219218863, 87756.56121719479, 88491.11508884828, 88556.67164992531, 90066.09933900708, 75300.62349688326, 76258.0, 76783.0, 78242.0, 80738.78891816628, 11882.08888822244, 12281.570145044881, 12381.0, 12413.006959443042, 12457.626271211879, 31474.337303875134, 37687.62312376841, 40627.79686101551, 41372.379414308205, 41832.79083604563, 67512.0, 67607.98588021085, 69250.0, 69254.65372673105, 71523.49667761603, 16426.507204783877, 16428.67142657164, 16632.916835415745, 16702.66594668124, 16753.581160471087, 17770.466885993443, 17909.19408626641, 17941.551461213574, 18101.637967240316, 18310.908445457688, 14727.484538041117, 14815.629609259424, 14921.403143874124, 15059.548213553611, 15092.471763488225, 15153.090814551162, 16052.518424447286, 16249.26878290456, 16389.42637007699, 16404.343826246815, 14035.719285614026, 15562.61093472627, 15813.288402021706, 15878.126703031445, 15933.521994340188, 11440.370779606868, 11448.542058317908, 11736.88263117358, 12003.759924801281, 12043.518259269531, 11247.212695111264, 12703.174293670882, 12753.426095825896, 13395.263260520765, 13727.519536816164], "value": 8246.611727836673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 114.0, 113.0, 123.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 126.0, 111.0, 150.0, 126.0, 152.0, 145.0, 102.0, 158.0, 105.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 202.0, 211.0, 220.0, 226.0, 199.0, 200.0, 259.0, 200.0, 201.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 65.0, 83.0, 62.0, 84.0, 83.0, 84.0, 72.0, 87.0], "value": 76.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 83.0, 70.0, 74.0, 70.0, 100.0, 100.0, 101.0, 117.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 97.0, 135.0, 84.0, 136.0, 100.0, 88.0, 88.0, 89.0, 89.0], "value": 99.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 96.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 95.0, 89.0, 90.0, 89.0, 92.0, 83.0, 91.0, 90.0, 140.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 51.0, 50.0, 52.0, 54.0, 54.0, 71.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 63.0, 64.0, 63.0, 59.0, 60.0, 60.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 85.0, 86.0, 83.0, 86.0, 81.0, 87.0, 84.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 139.0, 136.0, 139.0, 135.0, 133.0, 135.0, 192.0, 165.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 185.0, 188.0, 183.0, 187.0, 182.0, 188.0, 191.0, 185.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0], "value": 68.9, "unit": "score"}]}]} 18:39:42 INFO - Return code: 0 18:39:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:42 ERROR - # TBPL SUCCESS # 18:39:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:39:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:39:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:39:42 INFO - 2017-04-21 18:39:42.679 screenresolution[1660:10754] starting screenresolution argv=screenresolution get 18:39:42 INFO - 2017-04-21 18:39:42.682 screenresolution[1660:10754] Display 0: 1600x1200x32@60 18:39:42 INFO - 2017-04-21 18:39:42.688 screenresolution[1661:10757] starting screenresolution argv=screenresolution list 18:39:42 INFO - Available Modes on Display 0 18:39:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:39:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:39:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:39:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:39:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:39:42 INFO - Intel Iris: 18:39:42 INFO - Chipset Model: Intel Iris 18:39:42 INFO - Type: GPU 18:39:42 INFO - Bus: Built-In 18:39:42 INFO - VRAM (Dynamic, Max): 1536 MB 18:39:42 INFO - Vendor: Intel (0x8086) 18:39:42 INFO - Device ID: 0x0a2e 18:39:42 INFO - Revision ID: 0x0009 18:39:42 INFO - Displays: 18:39:42 INFO - Display: 18:39:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:39:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:39:42 INFO - Display Serial Number: 1600x1200 60 18:39:42 INFO - Main Display: Yes 18:39:42 INFO - Mirror: Off 18:39:42 INFO - Online: Yes 18:39:42 INFO - Rotation: Supported 18:39:42 INFO - Return code: 0 18:39:42 INFO - Running post-action listener: _resource_record_post_action 18:39:42 INFO - [mozharness: 2017-04-22 01:39:42.923595Z] Finished run-tests step (success) 18:39:42 INFO - Running post-run listener: _resource_record_post_run 18:39:42 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39094784; Write bytes: 518269952; Read time: 251; Write time: 1632 18:39:42 INFO - TinderboxPrint: CPU usage
54.2% 18:39:42 INFO - TinderboxPrint: I/O read bytes / time
39,094,784 / 251 18:39:42 INFO - TinderboxPrint: I/O write bytes / time
518,269,952 / 1,632 18:39:42 INFO - TinderboxPrint: CPU idle
2,194.3 (45.8%) 18:39:42 INFO - TinderboxPrint: CPU system
962.9 (20.1%) 18:39:42 INFO - TinderboxPrint: CPU user
1,632.5 (34.1%) 18:39:42 INFO - TinderboxPrint: Swap in / out
247,103,488 / 0 18:39:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205548032; Write bytes: 205539328; Read time: 16000; Write time: 444 18:39:43 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36932096; Write bytes: 305648640; Read time: 229; Write time: 1160 18:39:43 INFO - Running post-run listener: _upload_blobber_files 18:39:43 INFO - Blob upload gear active. 18:39:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:39:43 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:43 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:45 INFO - (blobuploader) - INFO - Done attempting. 18:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:39:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:46 INFO - (blobuploader) - INFO - Done attempting. 18:39:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:39:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:39:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:47 INFO - (blobuploader) - INFO - Done attempting. 18:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:48 INFO - (blobuploader) - INFO - Done attempting. 18:39:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:48 INFO - Return code: 0 18:39:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd0d1e3fbcd074d7b0936f28c77db244ac62d00205a3994e1858e4bc3589663da46f48485b97c41759a0ecee44634ac5d497e3450a9f4397eb7b3e47a41432b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec64af007d3cb88dfa543a366c6145001d6744cacdd7683578a6ee4b4ba2123fd4e099c522248efb2d96b0759c773e52a1a40b4497e82271e57f3dfd2607a864", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54ae02b92865df7b8e3d9d52df06ffc856e5d0591143bf4326809e3c2e1497d5d89beb54854fedf77ccd358e4abcc0ae4260dbc6dadf42420ffd74e76eb372d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed423417ec1075f061686e9d61f024c1c0d086f7cb61e257647ab518f71f33daf100221965074bae34d8e83db0cbc72c4d58f5ebe0c9476965b127a117cfa4d"} 18:39:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:48 INFO - Contents: 18:39:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd0d1e3fbcd074d7b0936f28c77db244ac62d00205a3994e1858e4bc3589663da46f48485b97c41759a0ecee44634ac5d497e3450a9f4397eb7b3e47a41432b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec64af007d3cb88dfa543a366c6145001d6744cacdd7683578a6ee4b4ba2123fd4e099c522248efb2d96b0759c773e52a1a40b4497e82271e57f3dfd2607a864", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54ae02b92865df7b8e3d9d52df06ffc856e5d0591143bf4326809e3c2e1497d5d89beb54854fedf77ccd358e4abcc0ae4260dbc6dadf42420ffd74e76eb372d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed423417ec1075f061686e9d61f024c1c0d086f7cb61e257647ab518f71f33daf100221965074bae34d8e83db0cbc72c4d58f5ebe0c9476965b127a117cfa4d"} 18:39:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:48 INFO - Copying logs to upload dir... 18:39:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.942548 ========= master_lag: 2.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 18:39:51.302310) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-04-21 18:39:51.307235) ========= 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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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/Firefox/sha512/ddd0d1e3fbcd074d7b0936f28c77db244ac62d00205a3994e1858e4bc3589663da46f48485b97c41759a0ecee44634ac5d497e3450a9f4397eb7b3e47a41432b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec64af007d3cb88dfa543a366c6145001d6744cacdd7683578a6ee4b4ba2123fd4e099c522248efb2d96b0759c773e52a1a40b4497e82271e57f3dfd2607a864", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54ae02b92865df7b8e3d9d52df06ffc856e5d0591143bf4326809e3c2e1497d5d89beb54854fedf77ccd358e4abcc0ae4260dbc6dadf42420ffd74e76eb372d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed423417ec1075f061686e9d61f024c1c0d086f7cb61e257647ab518f71f33daf100221965074bae34d8e83db0cbc72c4d58f5ebe0c9476965b127a117cfa4d"} build_url:https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011758 build_url: 'https://queue.taskcluster.net/v1/task/SqA_GFcaRmizUrkf8B6dxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd0d1e3fbcd074d7b0936f28c77db244ac62d00205a3994e1858e4bc3589663da46f48485b97c41759a0ecee44634ac5d497e3450a9f4397eb7b3e47a41432b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec64af007d3cb88dfa543a366c6145001d6744cacdd7683578a6ee4b4ba2123fd4e099c522248efb2d96b0759c773e52a1a40b4497e82271e57f3dfd2607a864", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54ae02b92865df7b8e3d9d52df06ffc856e5d0591143bf4326809e3c2e1497d5d89beb54854fedf77ccd358e4abcc0ae4260dbc6dadf42420ffd74e76eb372d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ed423417ec1075f061686e9d61f024c1c0d086f7cb61e257647ab518f71f33daf100221965074bae34d8e83db0cbc72c4d58f5ebe0c9476965b127a117cfa4d"}' ========= master_lag: 2.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-04-21 18:39:53.434287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:39:53.434632) ========= 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.5r3YrbRnTF/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.UWbKXPO6tO/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.005131 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:39:53.527983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:39:53.528290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:39:53.530180) ========= ========= Total master_lag: 4.56 =========