builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1485568700.97 results: success (0) buildid: 20170127163821 builduid: 3faa2cc9ee844429bf1dd6b5bbf43e94 revision: dfb191cf603902107a80559996d0d5b37661287a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:20.969564) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:20.970095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:20.970475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:20.997443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:20.997778) ========= 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.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-01-27 17:58:21-- 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% 15.1M=0.001s 2017-01-27 17:58:21 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:21.161238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:21.161609) ========= 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.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.028070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:21.215452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-27 17:58:21.216361) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dfb191cf603902107a80559996d0d5b37661287a --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 dfb191cf603902107a80559996d0d5b37661287a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-01-27 17:58:21,318 truncating revision to first 12 chars 2017-01-27 17:58:21,318 Setting DEBUG logging. 2017-01-27 17:58:21,318 attempt 1/10 2017-01-27 17:58:21,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dfb191cf6039?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 17:58:22,463 unpacking tar archive at: mozilla-central-dfb191cf6039/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407139 ========= master_lag: 3.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-27 17:58:25.832107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:25.832540) ========= script_repo_revision: dfb191cf603902107a80559996d0d5b37661287a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:25.833044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:25.833384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 17:58:25.857095) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-27 17:58:25.857864) ========= /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.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:58:26 INFO - MultiFileLogger online at 20170127 17:58:26 in /builds/slave/test 17:58:26 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 17:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:58:26 INFO - {'append_to_log': False, 17:58:26 INFO - 'base_work_dir': '/builds/slave/test', 17:58:26 INFO - 'blob_upload_branch': 'Firefox', 17:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:58:26 INFO - 'branch': 'Firefox', 17:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:58:26 INFO - 'config_files': ('talos/mac_config.py',), 17:58:26 INFO - 'default_actions': ('clobber', 17:58:26 INFO - 'read-buildbot-config', 17:58:26 INFO - 'download-and-extract', 17:58:26 INFO - 'populate-webroot', 17:58:26 INFO - 'create-virtualenv', 17:58:26 INFO - 'install', 17:58:26 INFO - 'run-tests'), 17:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:58:26 INFO - 'download_minidump_stackwalk': True, 17:58:26 INFO - 'download_symbols': 'ondemand', 17:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:58:26 INFO - 'installer_path': 'installer.exe', 17:58:26 INFO - 'log_level': 'info', 17:58:26 INFO - 'log_name': 'talos', 17:58:26 INFO - 'log_to_console': True, 17:58:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:58:26 INFO - 'opt_config_files': (), 17:58:26 INFO - 'pip_index': False, 17:58:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:58:26 INFO - 'cmd': ('bash', 17:58:26 INFO - '-c', 17:58:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:58:26 INFO - 'enabled': True, 17:58:26 INFO - 'halt_on_failure': False, 17:58:26 INFO - 'name': 'check_screen_resolution'},), 17:58:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:58:26 INFO - 'cmd': ('bash', 17:58:26 INFO - '-c', 17:58:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:58:26 INFO - 'enabled': True, 17:58:26 INFO - 'halt_on_failure': False, 17:58:26 INFO - 'name': 'check_screen_resolution'},), 17:58:26 INFO - 'run_cmd_checks_enabled': True, 17:58:26 INFO - 'sps_profile': False, 17:58:26 INFO - 'sps_profile_interval': 0, 17:58:26 INFO - 'suite': 'dromaeojs-e10s', 17:58:26 INFO - 'system_bits': '32', 17:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:58:26 INFO - 'title': 't-yosemite-r7-0124', 17:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:58:26 INFO - 'use_talos_json': True, 17:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:58:26 INFO - 'work_dir': 'build'} 17:58:26 INFO - [mozharness: 2017-01-28 01:58:26.075308Z] Running clobber step. 17:58:26 INFO - Running pre-action listener: _resource_record_pre_action 17:58:26 INFO - Running main action method: clobber 17:58:26 INFO - rmtree: /builds/slave/test/build 17:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:58:28 INFO - Running post-action listener: _resource_record_post_action 17:58:28 INFO - [mozharness: 2017-01-28 01:58:28.516404Z] Finished clobber step (success) 17:58:28 INFO - [mozharness: 2017-01-28 01:58:28.516563Z] Running read-buildbot-config step. 17:58:28 INFO - Running pre-action listener: _resource_record_pre_action 17:58:28 INFO - Running main action method: read_buildbot_config 17:58:28 INFO - Using buildbot properties: 17:58:28 INFO - { 17:58:28 INFO - "project": "", 17:58:28 INFO - "product": "firefox", 17:58:28 INFO - "script_repo_revision": "production", 17:58:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:58:28 INFO - "repository": "", 17:58:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:58:28 INFO - "buildid": "20170127163821", 17:58:28 INFO - "pgo_build": "False", 17:58:28 INFO - "basedir": "/builds/slave/test", 17:58:28 INFO - "buildnumber": 131, 17:58:28 INFO - "slavename": "t-yosemite-r7-0124", 17:58:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:58:28 INFO - "platform": "yosemite_r7", 17:58:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:58:28 INFO - "branch": "mozilla-central", 17:58:28 INFO - "repo_path": "mozilla-central", 17:58:28 INFO - "revision": "dfb191cf603902107a80559996d0d5b37661287a", 17:58:28 INFO - "stage_platform": "macosx64", 17:58:28 INFO - "builduid": "3faa2cc9ee844429bf1dd6b5bbf43e94", 17:58:28 INFO - "slavebuilddir": "test" 17:58:28 INFO - } 17:58:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:58:28 INFO - Running post-action listener: _resource_record_post_action 17:58:28 INFO - [mozharness: 2017-01-28 01:58:28.520064Z] Finished read-buildbot-config step (success) 17:58:28 INFO - [mozharness: 2017-01-28 01:58:28.520168Z] Running download-and-extract step. 17:58:28 INFO - Running pre-action listener: _resource_record_pre_action 17:58:28 INFO - Running main action method: download_and_extract 17:58:28 INFO - mkdir: /builds/slave/test/build/tests 17:58:28 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')]} 17:58:28 INFO - trying https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:58:28 INFO - Downloading https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:58:29 INFO - Downloaded 1199 bytes. 17:58:29 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:58:29 INFO - Using the following test package requirements: 17:58:29 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:58:29 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:58:29 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:58:29 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'jsshell-mac.zip'], 17:58:29 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:58:29 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:58:29 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:58:29 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:58:29 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:58:29 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:58:29 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:58:29 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:58:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:58:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:58:29 INFO - Fetch https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:58:30 INFO - Expected file size: 16361146 17:58:30 INFO - Obtained file size: 16361146 17:58:37 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:58:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:58:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:58:37 INFO - Fetch https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:58:38 INFO - Expected file size: 16361146 17:58:38 INFO - Obtained file size: 16361146 17:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:58:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:58:45 INFO - Expected file size: 14403454 17:58:45 INFO - Obtained file size: 14403454 17:58:45 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')]} 17:58:45 INFO - trying https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:58:45 INFO - Downloading https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:58:47 INFO - Downloaded 70169420 bytes. 17:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:58:47 INFO - mkdir: /builds/slave/test/properties 17:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:58:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:58:47 INFO - Contents: 17:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:58:48 INFO - Running post-action listener: _resource_record_post_action 17:58:48 INFO - Running post-action listener: set_extra_try_arguments 17:58:48 INFO - [mozharness: 2017-01-28 01:58:48.542155Z] Finished download-and-extract step (success) 17:58:48 INFO - [mozharness: 2017-01-28 01:58:48.542308Z] Running populate-webroot step. 17:58:48 INFO - Running pre-action listener: _resource_record_pre_action 17:58:48 INFO - Running main action method: populate_webroot 17:58:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:58:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:58:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:58:48 INFO - '--tppagecycles', 17:58:48 INFO - '7'], 17:58:48 INFO - 'tests': ['tsvgm']}}, 17:58:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:58:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:58:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:58:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:58:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:58:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:58:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['damp', 'tps']}, 17:58:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'tests': ['damp', 'tps']}, 17:58:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['dromaeo_dom']}, 17:58:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:58:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['basic_compositor_video']}, 17:58:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:58:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['a11yr', 17:58:48 INFO - 'ts_paint', 17:58:48 INFO - 'tpaint', 17:58:48 INFO - 'sessionrestore', 17:58:48 INFO - 'sessionrestore_no_auto_restore', 17:58:48 INFO - 'tabpaint']}, 17:58:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['tsvgx', 17:58:48 INFO - 'tsvgr_opacity', 17:58:48 INFO - 'tart', 17:58:48 INFO - 'tscrollx', 17:58:48 INFO - 'cart', 17:58:48 INFO - 'tsvg_static']}, 17:58:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:58:48 INFO - 'tsvgr_opacity', 17:58:48 INFO - 'tart', 17:58:48 INFO - 'tscrollx', 17:58:48 INFO - 'cart', 17:58:48 INFO - 'tsvg_static']}, 17:58:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'talos_options': ['--disable-e10s'], 17:58:48 INFO - 'tests': ['tp5o']}, 17:58:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:58:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'talos_options': ['--disable-e10s', 17:58:48 INFO - '--xperf_path', 17:58:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:58:48 INFO - 'tests': ['tp5n']}, 17:58:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:58:48 INFO - 'talos_options': ['--xperf_path', 17:58:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:58:48 INFO - 'tests': ['tp5n']}}, 17:58:48 INFO - 'talos.zip': {'path': '', 17:58:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:58:48 INFO - Running post-action listener: _resource_record_post_action 17:58:48 INFO - [mozharness: 2017-01-28 01:58:48.560866Z] Finished populate-webroot step (success) 17:58:48 INFO - [mozharness: 2017-01-28 01:58:48.560999Z] Running create-virtualenv step. 17:58:48 INFO - Running pre-action listener: _resource_record_pre_action 17:58:48 INFO - Running main action method: create_virtualenv 17:58:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:58:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:58:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:58:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:58:48 INFO - Using real prefix '/tools/python27' 17:58:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:58:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:58:52 INFO - Installing pip.................done. 17:58:52 INFO - Return code: 0 17:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:58:52 INFO - Reading from file tmpfile_stdout 17:58:52 INFO - Output received: 17:58:52 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) 17:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:58:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:58:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:52 INFO - 'HOME': '/Users/cltbld', 17:58:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:52 INFO - 'LOGNAME': 'cltbld', 17:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:52 INFO - 'MOZ_NO_REMOTE': '1', 17:58:52 INFO - 'NO_EM_RESTART': '1', 17:58:52 INFO - 'PAGER': '/bin/cat', 17:58:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:52 INFO - 'PWD': '/builds/slave/test', 17:58:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:52 INFO - 'SHELL': '/bin/bash', 17:58:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:58:52 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:58:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:52 INFO - 'USER': 'cltbld', 17:58:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:52 INFO - 'XPC_FLAGS': '0x0', 17:58:52 INFO - 'XPC_SERVICE_NAME': '0', 17:58:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:58:52 INFO - Cleaning up... 17:58:52 INFO - Return code: 0 17:58:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:58:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:58:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:52 INFO - 'HOME': '/Users/cltbld', 17:58:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:52 INFO - 'LOGNAME': 'cltbld', 17:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:52 INFO - 'MOZ_NO_REMOTE': '1', 17:58:52 INFO - 'NO_EM_RESTART': '1', 17:58:52 INFO - 'PAGER': '/bin/cat', 17:58:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:52 INFO - 'PWD': '/builds/slave/test', 17:58:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:52 INFO - 'SHELL': '/bin/bash', 17:58:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:58:52 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:58:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:52 INFO - 'USER': 'cltbld', 17:58:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:52 INFO - 'XPC_FLAGS': '0x0', 17:58:52 INFO - 'XPC_SERVICE_NAME': '0', 17:58:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:53 INFO - Downloading/unpacking psutil>=3.1.1 17:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:56 INFO - Installing collected packages: psutil 17:58:56 INFO - Running setup.py install for psutil 17:58:56 INFO - building 'psutil._psutil_osx' extension 17:58:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:58:57 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 17:58:57 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 17:58:57 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 17:58:57 INFO - building 'psutil._psutil_posix' extension 17:58:57 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 17:58:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:58:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:58:57 INFO - ^ 17:58:57 INFO - 1 warning generated. 17:58:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:57 INFO - Successfully installed psutil 17:58:57 INFO - Cleaning up... 17:58:57 INFO - Return code: 0 17:58:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:57 INFO - 'HOME': '/Users/cltbld', 17:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:57 INFO - 'LOGNAME': 'cltbld', 17:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:57 INFO - 'MOZ_NO_REMOTE': '1', 17:58:57 INFO - 'NO_EM_RESTART': '1', 17:58:57 INFO - 'PAGER': '/bin/cat', 17:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:57 INFO - 'PWD': '/builds/slave/test', 17:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:57 INFO - 'SHELL': '/bin/bash', 17:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:58:57 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:57 INFO - 'USER': 'cltbld', 17:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:57 INFO - 'XPC_FLAGS': '0x0', 17:58:57 INFO - 'XPC_SERVICE_NAME': '0', 17:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:59:00 INFO - Installing collected packages: mozsystemmonitor 17:59:00 INFO - Running setup.py install for mozsystemmonitor 17:59:00 INFO - Successfully installed mozsystemmonitor 17:59:00 INFO - Cleaning up... 17:59:00 INFO - Return code: 0 17:59:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:00 INFO - 'HOME': '/Users/cltbld', 17:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:00 INFO - 'LOGNAME': 'cltbld', 17:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:00 INFO - 'MOZ_NO_REMOTE': '1', 17:59:00 INFO - 'NO_EM_RESTART': '1', 17:59:00 INFO - 'PAGER': '/bin/cat', 17:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:00 INFO - 'PWD': '/builds/slave/test', 17:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:00 INFO - 'SHELL': '/bin/bash', 17:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:00 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:00 INFO - 'USER': 'cltbld', 17:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:00 INFO - 'XPC_FLAGS': '0x0', 17:59:00 INFO - 'XPC_SERVICE_NAME': '0', 17:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:01 INFO - Downloading/unpacking jsonschema==2.5.1 17:59:01 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 17:59:01 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 17:59:01 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 17:59:01 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 17:59:01 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 17:59:01 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 17:59:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:59:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:59:04 INFO - warning: no files found matching '*.txt' 17:59:04 INFO - no previously-included directories found matching 'build' 17:59:04 INFO - no previously-included directories found matching 'dist' 17:59:04 INFO - no previously-included directories found matching '.git*' 17:59:04 INFO - Installing collected packages: jsonschema, functools32 17:59:04 INFO - Running setup.py install for functools32 17:59:04 INFO - warning: no files found matching '*.txt' 17:59:04 INFO - no previously-included directories found matching 'build' 17:59:04 INFO - no previously-included directories found matching 'dist' 17:59:04 INFO - no previously-included directories found matching '.git*' 17:59:04 INFO - Successfully installed jsonschema functools32 17:59:04 INFO - Cleaning up... 17:59:04 INFO - Return code: 0 17:59:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:04 INFO - 'HOME': '/Users/cltbld', 17:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:04 INFO - 'LOGNAME': 'cltbld', 17:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:04 INFO - 'MOZ_NO_REMOTE': '1', 17:59:04 INFO - 'NO_EM_RESTART': '1', 17:59:04 INFO - 'PAGER': '/bin/cat', 17:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:04 INFO - 'PWD': '/builds/slave/test', 17:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:04 INFO - 'SHELL': '/bin/bash', 17:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:04 INFO - 'USER': 'cltbld', 17:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:04 INFO - 'XPC_FLAGS': '0x0', 17:59:04 INFO - 'XPC_SERVICE_NAME': '0', 17:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:59:04 INFO - Cleaning up... 17:59:04 INFO - Return code: 0 17:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:04 INFO - 'HOME': '/Users/cltbld', 17:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:04 INFO - 'LOGNAME': 'cltbld', 17:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:04 INFO - 'MOZ_NO_REMOTE': '1', 17:59:04 INFO - 'NO_EM_RESTART': '1', 17:59:04 INFO - 'PAGER': '/bin/cat', 17:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:04 INFO - 'PWD': '/builds/slave/test', 17:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:04 INFO - 'SHELL': '/bin/bash', 17:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:04 INFO - 'USER': 'cltbld', 17:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:04 INFO - 'XPC_FLAGS': '0x0', 17:59:04 INFO - 'XPC_SERVICE_NAME': '0', 17:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:59:05 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 17:59:05 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 17:59:05 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 17:59:05 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 17:59:05 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 17:59:05 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 17:59:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:59:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:59:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:59:08 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 17:59:08 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 17:59:08 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 17:59:08 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 17:59:08 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 17:59:08 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 17:59:08 INFO - Downloading docopt-0.6.1.tar.gz 17:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:59:09 INFO - Installing collected packages: blobuploader, requests, docopt 17:59:09 INFO - Running setup.py install for blobuploader 17:59:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:59:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:59:09 INFO - Running setup.py install for requests 17:59:09 INFO - Running setup.py install for docopt 17:59:09 INFO - Successfully installed blobuploader requests docopt 17:59:09 INFO - Cleaning up... 17:59:09 INFO - Return code: 0 17:59:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59: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')]} 17:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59: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')]} 17:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:10 INFO - 'HOME': '/Users/cltbld', 17:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:10 INFO - 'LOGNAME': 'cltbld', 17:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:10 INFO - 'MOZ_NO_REMOTE': '1', 17:59:10 INFO - 'NO_EM_RESTART': '1', 17:59:10 INFO - 'PAGER': '/bin/cat', 17:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:10 INFO - 'PWD': '/builds/slave/test', 17:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:10 INFO - 'SHELL': '/bin/bash', 17:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:10 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:10 INFO - 'USER': 'cltbld', 17:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:10 INFO - 'XPC_FLAGS': '0x0', 17:59:10 INFO - 'XPC_SERVICE_NAME': '0', 17:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-AwKnjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-nPoeF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-yCPqIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zxAtuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-QfUIJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-XYI2LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-URXEUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-agHHsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ZLz94_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-WUINAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JZMCfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-QOvU2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-1ni5lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-1tlfjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-NruyEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-7PlHMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-H_ml2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:59:12 INFO - Running setup.py install for manifestparser 17:59:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:59:12 INFO - Running setup.py install for mozcrash 17:59:12 INFO - Running setup.py install for mozdebug 17:59:12 INFO - Running setup.py install for mozdevice 17:59:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:59:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:59:12 INFO - Running setup.py install for mozfile 17:59:12 INFO - Running setup.py install for mozhttpd 17:59:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:59:12 INFO - Running setup.py install for mozinfo 17:59:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozInstall 17:59:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozleak 17:59:13 INFO - Running setup.py install for mozlog 17:59:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for moznetwork 17:59:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozprocess 17:59:13 INFO - Running setup.py install for mozprofile 17:59:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozrunner 17:59:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozscreenshot 17:59:14 INFO - Running setup.py install for moztest 17:59:14 INFO - Running setup.py install for mozversion 17:59:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:59:14 INFO - Cleaning up... 17:59:14 INFO - Return code: 0 17:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:14 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')]} 17:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:14 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')]} 17:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:14 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 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:14 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 17:59:14 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 17:59:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:14 INFO - 'HOME': '/Users/cltbld', 17:59:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:14 INFO - 'LOGNAME': 'cltbld', 17:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:14 INFO - 'MOZ_NO_REMOTE': '1', 17:59:14 INFO - 'NO_EM_RESTART': '1', 17:59:14 INFO - 'PAGER': '/bin/cat', 17:59:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:14 INFO - 'PWD': '/builds/slave/test', 17:59:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:14 INFO - 'SHELL': '/bin/bash', 17:59:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:14 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:14 INFO - 'USER': 'cltbld', 17:59:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:14 INFO - 'XPC_FLAGS': '0x0', 17:59:14 INFO - 'XPC_SERVICE_NAME': '0', 17:59:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-SG0fbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zl1OLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-G81RXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-6AXUFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-72tPRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-nIVRcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jS6jMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-WtDtkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-HM0Xc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-DmujiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-n8fM7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-gRDXmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-I6y87l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ixGaU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-SpNbfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-BCYZmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:16 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-TsMFqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:59:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:16 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 17:59:16 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 17:59:16 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 17:59:16 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 17:59:16 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 17:59:16 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 17:59:19 INFO - Downloading blessings-1.6.tar.gz 17:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:59:19 INFO - Installing collected packages: blessings 17:59:19 INFO - Running setup.py install for blessings 17:59:19 INFO - Successfully installed blessings 17:59:19 INFO - Cleaning up... 17:59:19 INFO - Return code: 0 17:59:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:59:20 INFO - Reading from file tmpfile_stdout 17:59:20 INFO - Current package versions: 17:59:20 INFO - blessings == 1.6 17:59:20 INFO - blobuploader == 1.2.4 17:59:20 INFO - docopt == 0.6.1 17:59:20 INFO - functools32 == 3.2.3-2 17:59:20 INFO - jsonschema == 2.5.1 17:59:20 INFO - manifestparser == 1.1 17:59:20 INFO - mozInstall == 1.12 17:59:20 INFO - mozcrash == 1.0 17:59:20 INFO - mozdebug == 0.1 17:59:20 INFO - mozdevice == 0.49 17:59:20 INFO - mozfile == 1.2 17:59:20 INFO - mozhttpd == 0.7 17:59:20 INFO - mozinfo == 0.9 17:59:20 INFO - mozleak == 0.1 17:59:20 INFO - mozlog == 3.4 17:59:20 INFO - moznetwork == 0.27 17:59:20 INFO - mozprocess == 0.24 17:59:20 INFO - mozprofile == 0.28 17:59:20 INFO - mozrunner == 6.13 17:59:20 INFO - mozscreenshot == 0.1 17:59:20 INFO - mozsystemmonitor == 0.3 17:59:20 INFO - moztest == 0.8 17:59:20 INFO - mozversion == 1.4 17:59:20 INFO - psutil == 3.1.1 17:59:20 INFO - requests == 1.2.3 17:59:20 INFO - wsgiref == 0.1.2 17:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:20 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')]} 17:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:20 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')]} 17:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:20 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 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:20 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 17:59:20 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 17:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:20 INFO - 'HOME': '/Users/cltbld', 17:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:20 INFO - 'LOGNAME': 'cltbld', 17:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:20 INFO - 'MOZ_NO_REMOTE': '1', 17:59:20 INFO - 'NO_EM_RESTART': '1', 17:59:20 INFO - 'PAGER': '/bin/cat', 17:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:20 INFO - 'PWD': '/builds/slave/test', 17:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:20 INFO - 'SHELL': '/bin/bash', 17:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:20 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:20 INFO - 'USER': 'cltbld', 17:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:20 INFO - 'XPC_FLAGS': '0x0', 17:59:20 INFO - 'XPC_SERVICE_NAME': '0', 17:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 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)) 17:59:20 INFO - Cleaning up... 17:59:20 INFO - Return code: 0 17:59:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:59:20 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')]} 17:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:20 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')]} 17:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b70bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b70e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb4b4a77e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, '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.T813OLXfFH/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.qa7aBNMyxo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 17:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:21 INFO - 'HOME': '/Users/cltbld', 17:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:21 INFO - 'LOGNAME': 'cltbld', 17:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:21 INFO - 'MOZ_NO_REMOTE': '1', 17:59:21 INFO - 'NO_EM_RESTART': '1', 17:59:21 INFO - 'PAGER': '/bin/cat', 17:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:21 INFO - 'PWD': '/builds/slave/test', 17:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:21 INFO - 'SHELL': '/bin/bash', 17:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:21 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:21 INFO - 'USER': 'cltbld', 17:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:21 INFO - 'XPC_FLAGS': '0x0', 17:59:21 INFO - 'XPC_SERVICE_NAME': '0', 17:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:59:21 INFO - Cleaning up... 17:59:21 INFO - Return code: 0 17:59:21 INFO - Running post-action listener: _resource_record_post_action 17:59:21 INFO - Running post-action listener: _start_resource_monitoring 17:59:21 INFO - Starting resource monitoring. 17:59:21 INFO - [mozharness: 2017-01-28 01:59:21.669686Z] Finished create-virtualenv step (success) 17:59:21 INFO - [mozharness: 2017-01-28 01:59:21.670509Z] Running install step. 17:59:21 INFO - Running pre-action listener: _resource_record_pre_action 17:59:21 INFO - Running main action method: install 17:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:59:21 INFO - Reading from file tmpfile_stdout 17:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:59:22 INFO - Reading from file tmpfile_stdout 17:59:22 INFO - Output received: 17:59:22 INFO - Usage: mozinstall [options] installer 17:59:22 INFO - Options: 17:59:22 INFO - -h, --help show this help message and exit 17:59:22 INFO - -d DEST, --destination=DEST 17:59:22 INFO - Directory to install application into. [default: 17:59:22 INFO - "/builds/slave/test"] 17:59:22 INFO - --app=APP Application being installed. [default: firefox] 17:59:22 INFO - mkdir: /builds/slave/test/build/application 17:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:59:43 INFO - Reading from file tmpfile_stdout 17:59:43 INFO - Output received: 17:59:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:59:43 INFO - Running post-action listener: _resource_record_post_action 17:59:43 INFO - [mozharness: 2017-01-28 01:59:43.927261Z] Finished install step (success) 17:59:43 INFO - [mozharness: 2017-01-28 01:59:43.927427Z] Running run-tests step. 17:59:43 INFO - Running pre-action listener: _resource_record_pre_action 17:59:43 INFO - Running main action method: run_tests 17:59:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:43 INFO - 2017-01-27 17:59:43.942 screenresolution[1624:7437] starting screenresolution argv=screenresolution get 17:59:43 INFO - 2017-01-27 17:59:43.944 screenresolution[1624:7437] Display 0: 1600x1200x32@60 17:59:43 INFO - 2017-01-27 17:59:43.951 screenresolution[1625:7439] starting screenresolution argv=screenresolution list 17:59:43 INFO - Available Modes on Display 0 17:59:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:44 INFO - Intel Iris: 17:59:44 INFO - Chipset Model: Intel Iris 17:59:44 INFO - Type: GPU 17:59:44 INFO - Bus: Built-In 17:59:44 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:44 INFO - Vendor: Intel (0x8086) 17:59:44 INFO - Device ID: 0x0a2e 17:59:44 INFO - Revision ID: 0x0009 17:59:44 INFO - Displays: 17:59:44 INFO - Display: 17:59:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:44 INFO - Display Serial Number: 1600x1200 60 17:59:44 INFO - Main Display: Yes 17:59:44 INFO - Mirror: Off 17:59:44 INFO - Online: Yes 17:59:44 INFO - Rotation: Supported 17:59:44 INFO - Return code: 0 17:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:59:44 INFO - Python 2.7.3 17:59:44 INFO - Return code: 0 17:59:44 INFO - grabbing minidump binary from tooltool 17:59: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')]} 17:59:44 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 0x10b4e9d30>, '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 0x10b410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4debe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:59:44 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 17:59:44 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 17:59:44 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 17:59:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:59:44 INFO - Return code: 0 17:59:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:59:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:59:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:59:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:59:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:59:44 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/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 17:59:44 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/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 17:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T813OLXfFH/Render', 17:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:44 INFO - 'HOME': '/Users/cltbld', 17:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:44 INFO - 'LOGNAME': 'cltbld', 17:59:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:44 INFO - 'MOZ_NO_REMOTE': '1', 17:59:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:44 INFO - 'NO_EM_RESTART': '1', 17:59:44 INFO - 'PAGER': '/bin/cat', 17:59:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:44 INFO - 'PWD': '/builds/slave/test', 17:59:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:44 INFO - 'SHELL': '/bin/bash', 17:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qa7aBNMyxo/Listeners', 17:59:44 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 17:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:44 INFO - 'USER': 'cltbld', 17:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:44 INFO - 'XPC_FLAGS': '0x0', 17:59:44 INFO - 'XPC_SERVICE_NAME': '0', 17:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:44 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/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 17:59:44 INFO - mozversion application_buildid: 20170127163821 17:59:44 INFO - mozversion application_changeset: dfb191cf603902107a80559996d0d5b37661287a 17:59:44 INFO - mozversion application_display_name: Nightly 17:59:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:59:44 INFO - mozversion application_name: Firefox 17:59:44 INFO - mozversion application_remotingname: firefox 17:59:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:59:44 INFO - mozversion application_vendor: Mozilla 17:59:44 INFO - mozversion application_version: 54.0a1 17:59:44 INFO - mozversion platform_buildid: 20170127163821 17:59:44 INFO - mozversion platform_changeset: dfb191cf603902107a80559996d0d5b37661287a 17:59:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:59:44 INFO - mozversion platform_version: 54.0a1 17:59:44 INFO - using testdate: 1485568784 17:59:44 INFO - actual date: 1485568784 17:59:44 INFO - starting webserver on 'localhost:49241' 17:59:44 INFO - SUITE-START | Running 2 tests 17:59:44 INFO - TEST-START | dromaeo_css 17:59:44 INFO - operating with platform_type : mac_ 17:59:44 INFO - Initialising browser for dromaeo_css test... 17:59:44 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmppynUIz/profile http://localhost:49241/getInfo.html) 17:59:47 INFO - PROCESS | 1635 | 2017-01-27 17:59:47.460 plugin-container[1637:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 17:59:47 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:59:47 INFO - PROCESS | 1635 | 2017-01-27 17:59:47.463 plugin-container[1637:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 17:59:47 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:59:47 INFO - PROCESS | 1635 | 2017-01-27 17:59:47.463 plugin-container[1637:7610] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:59:47 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 17:59:47 INFO - PROCESS | 1635 | colorDepth:24 17:59:47 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 17:59:47 INFO - PROCESS | 1635 | __metrics 17:59:47 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 17:59:48 INFO - TEST-INFO | 1635: exit 0 17:59:48 INFO - Browser initialized. 17:59:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:59:48 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmppynUIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:50 INFO - PROCESS | 1638 | 2017-01-27 17:59:50.720 plugin-container[1639:7728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 17:59:50 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:59:50 INFO - PROCESS | 1638 | 2017-01-27 17:59:50.721 plugin-container[1639:7728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 17:59:50 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:59:50 INFO - PROCESS | 1638 | 2017-01-27 17:59:50.721 plugin-container[1639:7728] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:00:00 INFO - PROCESS | 1638 | RSS: Main: 232935424 18:00:00 INFO - PROCESS | 1638 | 18:03:02 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 18:03:04 INFO - PROCESS | 1638 | RSS: Main: 255037440 18:03:04 INFO - PROCESS | 1638 | 18:04:48 INFO - PROCESS | 1638 | ************************* 18:04:48 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 18:04:48 INFO - PROCESS | 1638 | 18:04:48 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:04:48 INFO - PROCESS | 1638 | Full stack: 18:04:48 INFO - PROCESS | 1638 | ************************* 18:06:06 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 18:06:07 INFO - PROCESS | 1638 | RSS: Main: 262533120 18:06:07 INFO - PROCESS | 1638 | 18:09:09 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 18:09:10 INFO - PROCESS | 1638 | RSS: Main: 274460672 18:09:10 INFO - PROCESS | 1638 | 18:12:12 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 18:12:12 INFO - PROCESS | 1638 | RSS: Main: 269914112 18:12:12 INFO - PROCESS | 1638 | 18:15:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 18:15:16 INFO - PROCESS | 1638 | RSS: Main: 274960384 18:15:16 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 18:18:19 INFO - PROCESS | 1638 | RSS: Main: 276877312 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | __start_tp_report 18:18:19 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 18:18:19 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 18:18:19 INFO - PROCESS | 1638 | |i|pagename|runs| 18:18:19 INFO - PROCESS | 1638 | |0;dojo.html;3275.5086736989465;3313.7349012079035;3346.7657263991514;3358;3358.9496157557624;4689.320048592952;4726.91281005369;5532.197831314457;5550.417206193347;5628.155776633507;4886.706797592147;5541.030319694058;5572.7770889164385;5595.63628364156;5631;5052.368453943257;5062.443131255559;5111.258867464216;5169.741512924357;5212.244224587433;4325.891852703692;5107.489251074881;5270.314859068316;5274.103402421598;5302.814401495948;5072.2391641253735;5085.567726743231;5226.137687281594;5230.738463076831;5251.76367063483;4261.595148460891;4270.38079478477;5020.623453241022;5104.719240441774;5154.484551544853;5067.315912351823;5079.3650793650795;5084.415292241402;5106.8212612558755;5140.511651393112;5429.647072940246;5471.413290145853;5570.805021824217;5610.354809196913;5625.5218306444;5128.384593848725;6099.756009759604;6107.786227482061;6122.398155112023;6198.81403557894;5413.619527020584;6044.546659000593;6208.720607572625;6220.87558248837;6225.408586184305;5807.88384232313;5810.6513609183585;5843.532517398683;5847.473727364558;5872.119182122673;6131.468419844996;6138.449706860586;6140.964409184426;6169.444749972524;6185.597936134137;6038.849028774316;6053.606515576474;6081.3614570470345;6095.085737139376;6111.51107911366;6087.634741915499;6175.96912015437;6181.134641150243;6189.133521307021;6189.783357582553;5963.850903727354;6045.576809623284;6059.909101363483;6095.573309868355;6124.908126378108;6141.07883817431;6150.815475535741;6165.0444181152;6167.599106058092;6173.969130154321;4925.187344088257;4931.309616653672;4932.926006109911;4938.38270216223;4971.1549036663855;4398.450193725785;4410.4927933287445;4444.000099977544;4446.421965144576;4450.443694538183;5514.751836167302;5639.407862174495;5690.231818704505;5738.368779434259;5767.077267637158;6141.766804168937;6199.907001394983;6225.3774622537385;6240.719167637467;6241.500679945684;5529.695866727368;5615.129654903497;5694.914576281359;5710.314762228559;5712.371639119777;4858.902821943541;5242.606804489602;5388.568914486832;5395.271638328853;5422.0511410503;6236.282827474808;6246.219222597176;6248.062790581449;6248.687565621792;6253.030780229072;6065.545084118797;6206.658633775186;6210.099535567408;6221.160143380585;6222.408871157233;6126.487138464006;6158.661273629993;6161.199044124235;6210.378962103753;6251.968425209971;6071.666058366655;6132.448079672851;6133.417325354084;6135.07973803933;6157.353477884937;4593.127305812019;5817.301923769175;6148.815535533941;6207.65857877803;6221.96889015552;5263.5525980292105;5875.41245875409;5932.940670593412;5989.550783691154;6009.759609615567;6040.36576159497;6044.667543284985;6045.063015232646;6066.3023752269055;6080.3919608040615;4373.475182978063;5737.368889422077;5742.3109226891365;5917.260342457193;5960.046392577166;5929.85175370602;5999.070144127667;6009.849753756191;6065.54508411862;6090.177825993612;5376.951494458543;5842;5889.499392551681;5909.02501087333;5921.7631294747725 18:18:19 INFO - PROCESS | 1638 | |1;ext.html;424.77911486027267;459.74024676058025;462.59754014007797;511.8483412322276;523.1159340714195;37709.43435848464;39692;41452;41473.377899331455;43587;42229.7888510557;42806.92982675435;42812.35781463281;42827.571724282745;43078.353824692575;8425.410221284512;9366;9543.618255269781;9568.138867501924;9590.520473976308;8478.703245386412;11208.831867521994;11495.195336326418;11502.3673697947;11680.0655947524;11356.148288878327;11380.374079425628;11390.658280251606;11430.71423214418;11432.37121958292;11424.42877856108;11497.770044599145;11499.080073594092;11511.769764604745;11528.59649912249;11281.266717663326;11358.943205284004;11361.943190284079;11372.37451940143;11388;39999.200015999806;40237.79881100605;40315.798421007705;40350.59649403498;40409.797951010056;3976.522817261918;3992.7803970781597;4014.8394064237395;4046.817893194813;4048.838046478137;27882.581761273595;28605.71394286051;29052.70947290521;30788.692113078807;31178.844105779324;3174.7301479374282;3196.824174670392;3205.6954589313978;3301.4717645176656;3305.3719793239206;457269;458265;458781;460778;461951;56851.71574142103;57010.72881982978;57213;57245.71377143088;57306.56733581694;58802.705986469795;59055;59062.704686476296;59106.70446647825;59310;15162.696746065018;15585.922070389575;15647;15654;15699.843001570067;10859.2398532102;11173.162012849069;11858.110641701907;12020.97821685149;12119.39403029845;17489.38787142444;17973.393857890795;17995.280188792563;18006.099695015197;18050.548736281697;6950;7957.960210198912;7991.4006449515355;8027.879581806277;8048.5170889746805;842.3682238321259;857.9742607721778;869.2350731356366;872.8609165039558;876.6361959786617;28928.566071508943;29048.41903161925;29781.213127212435;30262.243443914078;30806.691933080383;1009.399407352624;1014.9289549731448;1041.4063983529468;1070.973225669349;1172.7302720374362;15023.399064037316;15814.288357023732;15859.444919427764;15891.920540397456;16141.838581614034;627321;633238;640010;641368;642954;60879.39120608826;61477.077843832376;61631.69184154051;61755.38244617586;61765.073523897176;1393.052724147569;1408.8520705325793;1425;1427.7001829615897;1428.292994967477;28678.713212867606;29357.55963660504;29669.25826854346;30284.394312113192;30327.848360758937;50459.495405046946;50462.74768626133;50844;50960.49039509558;51100.74449627728;526964;529480;532747;535265;535377;25239.242822715347;25893.96424143013;26021.869890650425;26740.732592673823;26799.464010720065;42719;42956.57043429526;43384.783076084415;43521.34717979169;43868.56131438645;35610.46584301186;35625;36208.913732588066;36267;36865;30588.694113058584;35502.112447187996;35701.57193712222;36265;36328.46878651476;34798.30403391867;34827.60689572389;34924.65075349214;35023;35450;29701.851490742407;31548.526772098896;31582.842085789423;31744.6825531751;31810.681893181696;19014.42956711301;23774.405639859142;23786.572805631717;23967.760322396553;25062.874685626455 18:18:19 INFO - PROCESS | 1638 | |2;jquery.html;386.0524892446173;387.8002828543301;393.4982896806572;401.31375348154654;415.883353196667;15810.920945395257;16861.915690421545;20713.585728285427;21223.46941326466;21340;21292.041858116383;21354.35936921895;21446.678299825475;21450;21743.565128697417;5629.662220266797;5780.739866705987;5823.010088285002;5829.795957141501;5842.853928651775;5593.972030139844;5686.9146962795385;5705.572082093839;5755.884882302373;5769.0192667246665;5735.913961290563;5740.339860915986;5745.224394706703;5746.913796293059;5758.971205143968;4727.621790256789;5030.723310217936;5264.315638966929;5329.920051199216;6040.788572399989;5083.440821509668;5986.880262394771;5992.8501787455225;6033.456988870978;6042.093685947099;12993.350332483433;22279.888600557057;24039.759602403927;24769.00923963039;24892.626610600855;2539.961900571493;2647.404334024848;2661.946761064787;2671.0407643438325;2716.4023914738727;9405.341626086176;9826.852597211047;10201.132903703194;10302.845457318146;11510;1817.8545716342794;1823.4438496258635;1833.6607727570442;1842.4012196036208;1850.5466160790559;137552;138775;140526.59473405237;142119.57880421166;143788.28105859403;9290.303227257982;10656.946715266375;11865.703357416134;11881.584144555072;12044.578439754567;13799.586012419644;14460.421583136556;15263.92368038175;15266.847331526542;15280.617984550476;8158.755237342889;8419.621117049748;8544.060153383123;8554.486730796172;8708.564571771387;8399;8399.076101628816;8402.621882015324;8519.361047921431;8573.442726222776;4713.717176969393;4758.286257061469;4769.618430525549;4793.904121917542;4819.975900120477;1993.9531745833262;2030.8679935804125;2035.104553996237;2038.347728726793;2046.31448464763;968.6270785747397;994.627014869424;995.382862625177;1005.2812239248972;1048.418127938986;20753.377398678065;20883.37349879506;20959.8952005239;20972.79027209739;21051.052702628418;1021.7037059252733;1021.7496713305288;1040.9635662751768;1049.4228174503992;1057.3655806516183;9196.586153623102;10720.571177152982;10835.133189344833;10888.564457421615;10899.400532970763;355937;751164;759300.203498979;767116;775667;141544.39884222476;155735;159071;162224.07767572897;163304;996.7490799047149;1015.1979935850595;1037.7768779712399;1043.6503771236569;1046.2937517176028;19416;19435.8056419434;19602.54968128984;19854.801451985295;19974.800251997294;47256.29115563338;52234.73882630563;60678.78642427215;60978.39021609727;61784.455388613846;65512;89846.55076724575;90469;91388.08611913795;92382.6142607848;7112.253213412724;7394.030798539477;7437.144728356308;8021.639026243716;8483.95758021206;9264.814703706023;11945.641630751092;12917.870821292043;13063.648543262305;13469.528566500125;8993.595288211915;11053.447327633425;11346.432678366215;11680.824787628362;11740.530378784753;11057.391843448688;11178.888211117785;11228.66314010581;11511.827322590001;11592.960063818387;11452.713682157679;11743.41282935867;11877.990370818578;11929.701757455787;11967.581134660246;7440.330370266702;7659.348955338635;7690.884636730565;7770.22297770241;7831.765047048598;10187.388756674623;11036.5033573491;11498.310101393943;11583.247088939192;11787.469563869476 18:18:19 INFO - PROCESS | 1638 | |3;mootools.html;1343.4357569820675;1394.1356359057386;1394.4422231107555;1412.7779470757791;1426.7003929174869;7385.076865391826;7600.885986710204;7900.209979002097;8329.583520823957;8391.370647201462;7817.843643127148;8100.392470564701;8107.797305067376;8172.305354044914;8195.672173113084;1948;2253.830962677802;2286.325533967484;2289.6565515172774;2292.8165746740306;2027.290448343083;2104.7895210478982;2260.8304377171694;2301.2175860207526;2312.2947501012186;2208.4699672078664;2280.851744636602;2287.6911616931666;2289.53064621753;2303.009705826494;2256.4471704432435;2263.909443622253;2280.8859557022083;2281.1673739085113;2282.8744419056943;1895.9146838392305;2077.387170784607;2111.19774485696;2133.1787261904124;2143.3677065265783;8230.62962166698;8244.54654993981;8287.709930152416;8297.12880147588;8326.292265157468;4997.100521906055;5137.7944882204665;5143.485651434864;5172.793088276464;5174.2238664200295;3323.2356557991557;3422.2984288220855;3457.567804024497;3481.7388695847912;3487.5640544931885;1008.4503945349802;1180.9725538781315;1203.6990752311922;1231.335079057308;1237.2623837592012;10429.843552346721;10479.109275711497;10488.685339439753;10530.52612632441;10677.893221067767;4152.522459917148;4352.412424322739;4423.977880110579;4426.601605855489;4432.49026361966;8433.451825631315;8527.147285271423;8544.145585441405;8546.829063418822;8553.786155346166;5041.521055499722;5044.772985215674;5044.772985215674;5050.267711181858;5055.317532133115;4579.633629309647;4656.41794775653;4692;4730;4746.762661866893;3832.137769001952;3874.49631547897;3886.300465916162;3918.529776426847;3938.350172221609;1177.0818761366147;1213.9453724582415;1265.576032029262;1289.2264641215195;1297.5523444411663;735.9484836061424;749.5427789048676;766.4902839611595;786.8268980824324;809.8055368331782;4907.288443175719;5669.773209071674;5741.540676745851;5771.134329850472;5789.768409263583;952.0975900029725;957.7366224288377;974.5370948799406;982.4891056650645;996.5017491254373;3677.4483827425565;3692.095436618046;3769.3968964965475;3808.295465338921;3866.2654095721723;9452.716418507456;9683.080107389787;9753;9770.462624555717;9771.21830253578;9701.854472182922;9709.029097090375;9723.513824308757;9725.027497250217;9744.902550974399;7596.658150383246;7726.922730772732;7737.729179478803;7744.341730952932;7745.651445684957;4704.729722974709;5180.48195180494;5254.7898084076205;5528.585356098229;5564.137558678412;8705.651773929225;8768.210861022539;8835.293176545989;8878.289736821169;8972.327075469235;8351.540665263468;8530.872036919576;8945.955270223607;9087.454752714859;9154;6481.5138864584405;6670.499712521483;6677.797996360701;6685.966570167118;6690.799276021728;7335.816604584928;7653.387728981556;7695.4997925134685;7699.422543309162;7712.38300935935;6068.969655151696;7066.858662826612;7123.679434425567;7164.462665300019;7183.604901730455;6894.689738961859;6964.477664175106;6966.5471744336455;6984.511084224056;6994.475414343843;6041.69791510414;6130.448259656652;6134.171886795404;6140.539459540463;6143.907841382294;4041.9191616166922;4775.832845850378;4791.161546729239;4810.254410566367;4853.39332583427;4892.92660610084;4898.926516102332;5000.999800039934;5074.695518268915;5083.5678967288195 18:18:19 INFO - PROCESS | 1638 | |4;prototype.html;357.76387584194435;362.53052297275025;371.16858237547893;374.83694592852095;377.2699825837007;3963.960360396395;4690.437147542296;4893.021395720857;5276.472352764731;5508.7796488140475;4419.823207071713;5081.517255860696;5191.506806853352;5348.277982472365;5375.516203541691;3539.5752509698873;3996.960030399702;4220.978895105535;4259.76571288579;4263.742196052172;3495.5106285120105;3955.32759430896;4222.366645003243;4258.339957306623;4261.318189089746;4027.9798601006955;4030.2342554914617;4036.9008115779775;4044.858429954952;4044.9483134385123;3293;3302.3725492156414;3944.7435916665327;4041.454403655513;4043.8272900858715;3433.656634336571;3480.617132115465;3509.6314886937016;3537.876174333912;3552.9111772205642;4020.9396859047138;4798.904021919542;5069.923951140736;5190.948090519084;5227.47725227478;3729.981350093259;4089.44792453018;4446.843820606633;4629.537046295343;4678.134545109166;4305.483341998949;5412.9458705412835;5558.610897237195;5564.998300305984;5643.867653452332;3336.96663033369;3633.582138054131;3839.347310957144;3839.865604703822;3852.0755018795567;5172.6379153459275;5264.921026184572;5981.547565498168;5983.431574000463;6000.459958603703;3819.751716138442;3945.3292940200236;3961.960380396217;3966;3971.160620156602;3858.2476417098956;3991.6207960243732;3992.321305378093;4001.6198461146146;4030.7581545107387;3873.903152421212;4560.468939738477;4647.279671650899;4662.557057079572;4674.672772905864;5110.795568177231;5730.799422020209;5783.479486846204;5786.3056433228285;5812;1238.4612693478366;1246.2958428488057;1253.755517674063;1281.5450515067203;1296.546208826903;765.6669348833275;768.1243382543904;808.551254053994;817.8078151634361;864.1790299215645;4997.625178111656;5004.224345226496;5069.721165335942;5089.134847076006;5095.617828662865;4771.379720636295;4872.6589138760655;5392.91910621341;5643.717814109278;5697.344805347355;4571.47428045779;4614.953850461452;4675.708902637683;4681.789319480631;5002.274670172805;2949.301389228832;2952.892665250531;2962.762978961678;2964.303388703653;2964.688707685705;4986.850394488171;5507.934524553292;5512;5624.746886390122;5818.5054270386645;5499.697516636544;5581.488330251403;5805.54570030831;5822.650640961556;5831.854203644943;4798.664093513421;5434;5835.416458354131;5867;5871.4715675589405;5080.034793389244;5215.582753379645;5241.903238704549;5517.724113794375;5855.414458554111;4881.511848815232;5556.749946252347;5855.648661080349;5914.615549989237;5924.7926322578505;4561;5032.370953630796;5119.385673719029;5621.437856214509;6061.787837425669;3410.948835767515;3863.7295389322476;3900.1419687668667;3921.6862650988423;3925.450436938888;5580.525655319343;5795.420457954171;5887.941120588911;5904.61619994699;5920;4505.774711264358;5638.323401191883;5656.161747432019;5674.460926212003;5705.657660540381;4943.777530011086;5302.814401495929;5679.716014199356;5688.914666279927;5698.694757040989;4854.902901942012;5189.4032186299055;5295.093766244226;5322.737836419429;5364.827244965795;5171.595208228192;5253.868653283545;5464.551893748239;5676.517496012885;5693.658380497018;5264.868378290574;5531.834044978657;5554.91667624994;5556.333240011063;5564.276644036249 18:18:19 INFO - PROCESS | 1638 | |5;yui.html;699.7725739134776;710.8578284343133;752.1388010727713;807.9272865442111;848.9745307640769;14661.926690366547;15550.45573404931;15603.609909752233;15622.609434764123;15745.842541574595;10979.341239525635;13907.930460347685;14030.73723364897;14566.708665826676;14764.557063288119;857.3569822633025;859.8495263328892;871.8038441350709;873.4977388001893;877.4735158904638;689.0731965506386;698.8497473043294;858.8840506531632;859.7979474823443;860.849351363512;888.6401007591936;916.5325683901225;922.8523436250201;922.9353945223837;926;910.9726708198765;912.4023764434306;913.0549880873265;915.0026471146449;915.1580545897757;673.0879658063303;678.1116737074449;679.8572299817044;682.6791408038214;685.143570536829;14711.63220919475;14949.551513454613;15130.092194468258;15133.33533311335;15142.242887855564;13462.499750064955;13621.846055573324;13705.588832335046;13763.31183440824;13805.792913106312;10929.234953553254;11470.627699066206;11522.539098436137;12273.202241854251;12981;4508.098380323949;4523.909521809578;4563.589276965089;4666.556677115668;4682.461516925529;79801.60099199525;86959.13040869574;105094;106273.46863265634;111740.32389514083;10621.362718236931;10682.985116413929;10697.358158510358;10830.278024755593;10994.120470362352;20986.790132098482;21001.89499052495;21031.68452473214;21072.683909741365;21116;7426.554406735613;7445.739399121113;7515.436342274351;7553.471257012066;7673.386129109769;4098.159877225162;4098.631123198867;4165.604267594574;4175.269327867611;4297.097609501977;3462.6191118976894;3532.5760908691122;3540.6990405815795;3549.597908826051;3554.289142171576;610.8272117534256;655.6459511863636;665.2383021440423;665.8102440804347;678.6301465701106;587.8883012227664;621.8041316985135;637.7417146055855;662.1987395251703;666.380266352297;8074.869518267447;9568.186704130088;9874.654387096562;9998.400255959157;10029.448380339152;573.21755803329;640.5683297829347;650.1223348479515;657.2999755260632;664.5182242873877;4635;4936.728479933567;4939.753012349368;4953.950460495349;4957.578605818474;87707;96052.51973740227;100219;103309;104611;89423.65864512038;89710;91475.54262228646;91899.62150567747;95977;80804.19195807967;81024.18975810167;81638;82307;82610.58694706488;9571.33000689945;9646.372985755903;9673.661421850202;9678.467684277432;9688.51557422112;48251.51748482611;54084;55100.17349739837;55205.17192242039;55951.16073258823;58033.70983145057;62726.37273627205;67410.32589674236;68380;69802.65098674475;11760.88239117598;12023.579174728842;12901.677458063623;13053;13136.540221092217;14302.832244008467;14463.49377771773;14608.519652149773;14741.11553306805;14943.77584336214;11480.518449415507;13400.731985360433;13713.314334283046;13739.931300343434;13886.722265554834;11197.425423938606;13170.539031133865;13523.256220907944;13560;13590.048696591539;13135.211887286794;13367;13483.595492135251;13749.793753093512;13762.724745505235;10529.57881684724;10731.153225324375;10969.396683182502;11011.889881101086;11344.489497972447;8743.781405464913;10431.634892778717;10580.259381843198;10624.628138015132;10737.838932415863 18:18:19 INFO - PROCESS | 1638 | __end_tp_report 18:18:19 INFO - PROCESS | 1638 | __start_cc_report 18:18:19 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,390 18:18:19 INFO - PROCESS | 1638 | __end_cc_report 18:18:19 INFO - PROCESS | 1638 | __startTimestamp1485569899688__endTimestamp 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | ------- Summary: start ------- 18:18:19 INFO - PROCESS | 1638 | Number of tests: 6 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5608.40 Median:5843.53 stddev:668.33 (11.4%) stddev-sans-first:644.83 18:18:19 INFO - PROCESS | 1638 | Values: 3275.5 3313.7 3346.8 3358.0 3358.9 4689.3 4726.9 5532.2 5550.4 5628.2 4886.7 5541.0 5572.8 5595.6 5631.0 5052.4 5062.4 5111.3 5169.7 5212.2 4325.9 5107.5 5270.3 5274.1 5302.8 5072.2 5085.6 5226.1 5230.7 5251.8 4261.6 4270.4 5020.6 5104.7 5154.5 5067.3 5079.4 5084.4 5106.8 5140.5 5429.6 5471.4 5570.8 5610.4 5625.5 5128.4 6099.8 6107.8 6122.4 6198.8 5413.6 6044.5 6208.7 6220.9 6225.4 5807.9 5810.7 5843.5 5847.5 5872.1 6131.5 6138.4 6141.0 6169.4 6185.6 6038.8 6053.6 6081.4 6095.1 6111.5 6087.6 6176.0 6181.1 6189.1 6189.8 5963.9 6045.6 6059.9 6095.6 6124.9 6141.1 6150.8 6165.0 6167.6 6174.0 4925.2 4931.3 4932.9 4938.4 4971.2 4398.5 4410.5 4444.0 4446.4 4450.4 5514.8 5639.4 5690.2 5738.4 5767.1 6141.8 6199.9 6225.4 6240.7 6241.5 5529.7 5615.1 5694.9 5710.3 5712.4 4858.9 5242.6 5388.6 5395.3 5422.1 6236.3 6246.2 6248.1 6248.7 6253.0 6065.5 6206.7 6210.1 6221.2 6222.4 6126.5 6158.7 6161.2 6210.4 6252.0 6071.7 6132.4 6133.4 6135.1 6157.4 4593.1 5817.3 6148.8 6207.7 6222.0 5263.6 5875.4 5932.9 5989.6 6009.8 6040.4 6044.7 6045.1 6066.3 6080.4 4373.5 5737.4 5742.3 5917.3 5960.0 5929.9 5999.1 6009.8 6065.5 6090.2 5377.0 5842.0 5889.5 5909.0 5921.8 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67595.90 Median:35556.29 stddev:146244.49 (411.3%) stddev-sans-first:146567.78 18:18:19 INFO - PROCESS | 1638 | Values: 424.8 459.7 462.6 511.8 523.1 37709.4 39692.0 41452.0 41473.4 43587.0 42229.8 42806.9 42812.4 42827.6 43078.4 8425.4 9366.0 9543.6 9568.1 9590.5 8478.7 11208.8 11495.2 11502.4 11680.1 11356.1 11380.4 11390.7 11430.7 11432.4 11424.4 11497.8 11499.1 11511.8 11528.6 11281.3 11358.9 11361.9 11372.4 11388.0 39999.2 40237.8 40315.8 40350.6 40409.8 3976.5 3992.8 4014.8 4046.8 4048.8 27882.6 28605.7 29052.7 30788.7 31178.8 3174.7 3196.8 3205.7 3301.5 3305.4 457269.0 458265.0 458781.0 460778.0 461951.0 56851.7 57010.7 57213.0 57245.7 57306.6 58802.7 59055.0 59062.7 59106.7 59310.0 15162.7 15585.9 15647.0 15654.0 15699.8 10859.2 11173.2 11858.1 12021.0 12119.4 17489.4 17973.4 17995.3 18006.1 18050.5 6950.0 7958.0 7991.4 8027.9 8048.5 842.4 858.0 869.2 872.9 876.6 28928.6 29048.4 29781.2 30262.2 30806.7 1009.4 1014.9 1041.4 1071.0 1172.7 15023.4 15814.3 15859.4 15891.9 16141.8 627321.0 633238.0 640010.0 641368.0 642954.0 60879.4 61477.1 61631.7 61755.4 61765.1 1393.1 1408.9 1425.0 1427.7 1428.3 28678.7 29357.6 29669.3 30284.4 30327.8 50459.5 50462.7 50844.0 50960.5 51100.7 526964.0 529480.0 532747.0 535265.0 535377.0 25239.2 25894.0 26021.9 26740.7 26799.5 42719.0 42956.6 43384.8 43521.3 43868.6 35610.5 35625.0 36208.9 36267.0 36865.0 30588.7 35502.1 35701.6 36265.0 36328.5 34798.3 34827.6 34924.7 35023.0 35450.0 29701.9 31548.5 31582.8 31744.7 31810.7 19014.4 23774.4 23786.6 23967.8 25062.9 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:38995.04 Median:22011.73 stddev:117661.02 (534.5%) stddev-sans-first:117955.38 18:18:19 INFO - PROCESS | 1638 | Values: 386.1 387.8 393.5 401.3 415.9 15810.9 16861.9 20713.6 21223.5 21340.0 21292.0 21354.4 21446.7 21450.0 21743.6 5629.7 5780.7 5823.0 5829.8 5842.9 5594.0 5686.9 5705.6 5755.9 5769.0 5735.9 5740.3 5745.2 5746.9 5759.0 4727.6 5030.7 5264.3 5329.9 6040.8 5083.4 5986.9 5992.9 6033.5 6042.1 12993.4 22279.9 24039.8 24769.0 24892.6 2540.0 2647.4 2661.9 2671.0 2716.4 9405.3 9826.9 10201.1 10302.8 11510.0 1817.9 1823.4 1833.7 1842.4 1850.5 137552.0 138775.0 140526.6 142119.6 143788.3 9290.3 10656.9 11865.7 11881.6 12044.6 13799.6 14460.4 15263.9 15266.8 15280.6 8158.8 8419.6 8544.1 8554.5 8708.6 8399.0 8399.1 8402.6 8519.4 8573.4 4713.7 4758.3 4769.6 4793.9 4820.0 1994.0 2030.9 2035.1 2038.3 2046.3 968.6 994.6 995.4 1005.3 1048.4 20753.4 20883.4 20959.9 20972.8 21051.1 1021.7 1021.7 1041.0 1049.4 1057.4 9196.6 10720.6 10835.1 10888.6 10899.4 355937.0 751164.0 759300.2 767116.0 775667.0 141544.4 155735.0 159071.0 162224.1 163304.0 996.7 1015.2 1037.8 1043.7 1046.3 19416.0 19435.8 19602.5 19854.8 19974.8 47256.3 52234.7 60678.8 60978.4 61784.5 65512.0 89846.6 90469.0 91388.1 92382.6 7112.3 7394.0 7437.1 8021.6 8484.0 9264.8 11945.6 12917.9 13063.6 13469.5 8993.6 11053.4 11346.4 11680.8 11740.5 11057.4 11178.9 11228.7 11511.8 11593.0 11452.7 11743.4 11878.0 11929.7 11967.6 7440.3 7659.3 7690.9 7770.2 7831.8 10187.4 11036.5 11498.3 11583.2 11787.5 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5269.49 Median:5173.51 stddev:2847.29 (55.0%) stddev-sans-first:2839.98 18:18:19 INFO - PROCESS | 1638 | Values: 1343.4 1394.1 1394.4 1412.8 1426.7 7385.1 7600.9 7900.2 8329.6 8391.4 7817.8 8100.4 8107.8 8172.3 8195.7 1948.0 2253.8 2286.3 2289.7 2292.8 2027.3 2104.8 2260.8 2301.2 2312.3 2208.5 2280.9 2287.7 2289.5 2303.0 2256.4 2263.9 2280.9 2281.2 2282.9 1895.9 2077.4 2111.2 2133.2 2143.4 8230.6 8244.5 8287.7 8297.1 8326.3 4997.1 5137.8 5143.5 5172.8 5174.2 3323.2 3422.3 3457.6 3481.7 3487.6 1008.5 1181.0 1203.7 1231.3 1237.3 10429.8 10479.1 10488.7 10530.5 10677.9 4152.5 4352.4 4424.0 4426.6 4432.5 8433.5 8527.1 8544.1 8546.8 8553.8 5041.5 5044.8 5044.8 5050.3 5055.3 4579.6 4656.4 4692.0 4730.0 4746.8 3832.1 3874.5 3886.3 3918.5 3938.4 1177.1 1213.9 1265.6 1289.2 1297.6 735.9 749.5 766.5 786.8 809.8 4907.3 5669.8 5741.5 5771.1 5789.8 952.1 957.7 974.5 982.5 996.5 3677.4 3692.1 3769.4 3808.3 3866.3 9452.7 9683.1 9753.0 9770.5 9771.2 9701.9 9709.0 9723.5 9725.0 9744.9 7596.7 7726.9 7737.7 7744.3 7745.7 4704.7 5180.5 5254.8 5528.6 5564.1 8705.7 8768.2 8835.3 8878.3 8972.3 8351.5 8530.9 8946.0 9087.5 9154.0 6481.5 6670.5 6677.8 6686.0 6690.8 7335.8 7653.4 7695.5 7699.4 7712.4 6069.0 7066.9 7123.7 7164.5 7183.6 6894.7 6964.5 6966.5 6984.5 6994.5 6041.7 6130.4 6134.2 6140.5 6143.9 4041.9 4775.8 4791.2 4810.3 4853.4 4892.9 4898.9 5001.0 5074.7 5083.6 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4482.02 Median:4999.95 stddev:1374.25 (27.5%) stddev-sans-first:1342.79 18:18:19 INFO - PROCESS | 1638 | Values: 357.8 362.5 371.2 374.8 377.3 3964.0 4690.4 4893.0 5276.5 5508.8 4419.8 5081.5 5191.5 5348.3 5375.5 3539.6 3997.0 4221.0 4259.8 4263.7 3495.5 3955.3 4222.4 4258.3 4261.3 4028.0 4030.2 4036.9 4044.9 4044.9 3293.0 3302.4 3944.7 4041.5 4043.8 3433.7 3480.6 3509.6 3537.9 3552.9 4020.9 4798.9 5069.9 5190.9 5227.5 3730.0 4089.4 4446.8 4629.5 4678.1 4305.5 5412.9 5558.6 5565.0 5643.9 3337.0 3633.6 3839.3 3839.9 3852.1 5172.6 5264.9 5981.5 5983.4 6000.5 3819.8 3945.3 3962.0 3966.0 3971.2 3858.2 3991.6 3992.3 4001.6 4030.8 3873.9 4560.5 4647.3 4662.6 4674.7 5110.8 5730.8 5783.5 5786.3 5812.0 1238.5 1246.3 1253.8 1281.5 1296.5 765.7 768.1 808.6 817.8 864.2 4997.6 5004.2 5069.7 5089.1 5095.6 4771.4 4872.7 5392.9 5643.7 5697.3 4571.5 4615.0 4675.7 4681.8 5002.3 2949.3 2952.9 2962.8 2964.3 2964.7 4986.9 5507.9 5512.0 5624.7 5818.5 5499.7 5581.5 5805.5 5822.7 5831.9 4798.7 5434.0 5835.4 5867.0 5871.5 5080.0 5215.6 5241.9 5517.7 5855.4 4881.5 5556.7 5855.6 5914.6 5924.8 4561.0 5032.4 5119.4 5621.4 6061.8 3410.9 3863.7 3900.1 3921.7 3925.5 5580.5 5795.4 5887.9 5904.6 5920.0 4505.8 5638.3 5656.2 5674.5 5705.7 4943.8 5302.8 5679.7 5688.9 5698.7 4854.9 5189.4 5295.1 5322.7 5364.8 5171.6 5253.9 5464.6 5676.5 5693.7 5264.9 5531.8 5554.9 5556.3 5564.3 18:18:19 INFO - PROCESS | 1638 | 18:18:19 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20247.90 Median:4674.51 stddev:28923.65 (618.8%) stddev-sans-first:28967.55 18:18:19 INFO - PROCESS | 1638 | Values: 699.8 710.9 752.1 807.9 849.0 14661.9 15550.5 15603.6 15622.6 15745.8 10979.3 13907.9 14030.7 14566.7 14764.6 857.4 859.8 871.8 873.5 877.5 689.1 698.8 858.9 859.8 860.8 888.6 916.5 922.9 922.9 926.0 911.0 912.4 913.1 915.0 915.2 673.1 678.1 679.9 682.7 685.1 14711.6 14949.6 15130.1 15133.3 15142.2 13462.5 13621.8 13705.6 13763.3 13805.8 10929.2 11470.6 11522.5 12273.2 12981.0 4508.1 4523.9 4563.6 4666.6 4682.5 79801.6 86959.1 105094.0 106273.5 111740.3 10621.4 10683.0 10697.4 10830.3 10994.1 20986.8 21001.9 21031.7 21072.7 21116.0 7426.6 7445.7 7515.4 7553.5 7673.4 4098.2 4098.6 4165.6 4175.3 4297.1 3462.6 3532.6 3540.7 3549.6 3554.3 610.8 655.6 665.2 665.8 678.6 587.9 621.8 637.7 662.2 666.4 8074.9 9568.2 9874.7 9998.4 10029.4 573.2 640.6 650.1 657.3 664.5 4635.0 4936.7 4939.8 4954.0 4957.6 87707.0 96052.5 100219.0 103309.0 104611.0 89423.7 89710.0 91475.5 91899.6 95977.0 80804.2 81024.2 81638.0 82307.0 82610.6 9571.3 9646.4 9673.7 9678.5 9688.5 48251.5 54084.0 55100.2 55205.2 55951.2 58033.7 62726.4 67410.3 68380.0 69802.7 11760.9 12023.6 12901.7 13053.0 13136.5 14302.8 14463.5 14608.5 14741.1 14943.8 11480.5 13400.7 13713.3 13739.9 13886.7 11197.4 13170.5 13523.3 13560.0 13590.0 13135.2 13367.0 13483.6 13749.8 13762.7 10529.6 10731.2 10969.4 11011.9 11344.5 8743.8 10431.6 10580.3 10624.6 10737.8 18:18:19 INFO - PROCESS | 1638 | -------- Summary: end -------- 18:18:19 INFO - PROCESS | 1638 | 18:18:20 INFO - TEST-INFO | 1638: exit 0 18:18:20 INFO - TEST-OK | dromaeo_css | took 1115799ms 18:18:20 INFO - TEST-START | kraken 18:18:20 INFO - operating with platform_type : mac_ 18:18:20 INFO - Initialising browser for kraken test... 18:18:20 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpu6McIW/profile http://localhost:49241/getInfo.html) 18:18:23 INFO - PROCESS | 1649 | 2017-01-27 18:18:23.166 plugin-container[1650:9957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 18:18:23 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:18:23 INFO - PROCESS | 1649 | 2017-01-27 18:18:23.169 plugin-container[1650:9957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 18:18:23 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:18:23 INFO - PROCESS | 1649 | 2017-01-27 18:18:23.169 plugin-container[1650:9957] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:18:23 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 18:18:23 INFO - PROCESS | 1649 | colorDepth:24 18:18:23 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 18:18:23 INFO - PROCESS | 1649 | __metrics 18:18:23 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 18:18:24 INFO - TEST-INFO | 1649: exit 0 18:18:24 INFO - Browser initialized. 18:18:24 INFO - Running cycle 1/1 for kraken test... 18:18:24 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpu6McIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:26 INFO - PROCESS | 1651 | 2017-01-27 18:18:26.553 plugin-container[1652:10072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463f, name = 'com.apple.tsm.portname' 18:18:26 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:18:26 INFO - PROCESS | 1651 | 2017-01-27 18:18:26.556 plugin-container[1652:10072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 18:18:26 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:18:26 INFO - PROCESS | 1651 | 2017-01-27 18:18:26.556 plugin-container[1652:10072] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:18:36 INFO - PROCESS | 1651 | RSS: Main: 233598976 18:18:36 INFO - PROCESS | 1651 | 18:18:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 18:18:40 INFO - PROCESS | 1651 | RSS: Main: 247066624 18:18:40 INFO - PROCESS | 1651 | 18:18:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 18:18:43 INFO - PROCESS | 1651 | RSS: Main: 254939136 18:18:43 INFO - PROCESS | 1651 | 18:18:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 18:18:47 INFO - PROCESS | 1651 | RSS: Main: 257646592 18:18:47 INFO - PROCESS | 1651 | 18:18:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 18:18:50 INFO - PROCESS | 1651 | RSS: Main: 258785280 18:18:50 INFO - PROCESS | 1651 | 18:18:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:18:52 INFO - PROCESS | 1651 | RSS: Main: 260571136 18:18:52 INFO - PROCESS | 1651 | 18:18:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 18:18:56 INFO - PROCESS | 1651 | RSS: Main: 266100736 18:18:56 INFO - PROCESS | 1651 | 18:18:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 18:18:59 INFO - PROCESS | 1651 | RSS: Main: 266014720 18:18:59 INFO - PROCESS | 1651 | 18:19:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 18:19:03 INFO - PROCESS | 1651 | RSS: Main: 266117120 18:19:03 INFO - PROCESS | 1651 | 18:19:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:19:05 INFO - PROCESS | 1651 | RSS: Main: 265396224 18:19:05 INFO - PROCESS | 1651 | 18:19:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:19:08 INFO - PROCESS | 1651 | RSS: Main: 265580544 18:19:08 INFO - PROCESS | 1651 | 18:19:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:19:11 INFO - PROCESS | 1651 | RSS: Main: 265519104 18:19:11 INFO - PROCESS | 1651 | 18:19:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:19:15 INFO - PROCESS | 1651 | RSS: Main: 265781248 18:19:15 INFO - PROCESS | 1651 | 18:19:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:19:18 INFO - PROCESS | 1651 | RSS: Main: 265834496 18:19:18 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 18:19:20 INFO - PROCESS | 1651 | RSS: Main: 267685888 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | __start_tp_report 18:19:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 18:19:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 18:19:20 INFO - PROCESS | 1651 | |i|pagename|runs| 18:19:20 INFO - PROCESS | 1651 | |0;ai-astar;107;134;175;117;116;119;119;118;117;118 18:19:20 INFO - PROCESS | 1651 | |1;audio-beat-detection;147;97;142;183;141;125;111;113;123;141 18:19:20 INFO - PROCESS | 1651 | |2;audio-dft;207;207;249;253;197;211;191;199;193;195 18:19:20 INFO - PROCESS | 1651 | |3;audio-fft;82;60;60;86;59;65;52;62;91;84 18:19:20 INFO - PROCESS | 1651 | |4;audio-oscillator;90;86;82;71;72;95;67;72;99;111 18:19:20 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;88;88;87;102;87;91;88;89;86 18:19:20 INFO - PROCESS | 1651 | |6;imaging-darkroom;152;151;95;96;96;95;96;95;97;102 18:19:20 INFO - PROCESS | 1651 | |7;imaging-desaturate;94;97;93;93;96;93;93;91;76;138 18:19:20 INFO - PROCESS | 1651 | |8;json-parse-financial;60;61;59;60;59;62;61;67;70;91 18:19:20 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;59;104;67;84;84;101;101;105;102;77 18:19:20 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;88;87;90;89;99;83;78;79;76;76 18:19:20 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;147;132;140;139;137;148;163;197;165 18:19:20 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;187;210;174;172;202;237;209;172;173;180 18:19:20 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;72;85;67;60;85;89;88;87;79;71 18:19:20 INFO - PROCESS | 1651 | __end_tp_report 18:19:20 INFO - PROCESS | 1651 | __start_cc_report 18:19:20 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,933 18:19:20 INFO - PROCESS | 1651 | __end_cc_report 18:19:20 INFO - PROCESS | 1651 | __startTimestamp1485569960894__endTimestamp 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | ------- Summary: start ------- 18:19:20 INFO - PROCESS | 1651 | Number of tests: 14 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:124.00 Median:118.50 stddev:19.07 (16.1%) stddev-sans-first:19.21 18:19:20 INFO - PROCESS | 1651 | Values: 107.0 134.0 175.0 117.0 116.0 119.0 119.0 118.0 117.0 118.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:141.50 stddev:24.14 (17.1%) stddev-sans-first:25.01 18:19:20 INFO - PROCESS | 1651 | Values: 147.0 97.0 142.0 183.0 141.0 125.0 111.0 113.0 123.0 141.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:210.20 Median:207.00 stddev:22.49 (10.9%) stddev-sans-first:23.83 18:19:20 INFO - PROCESS | 1651 | Values: 207.0 207.0 249.0 253.0 197.0 211.0 191.0 199.0 193.0 195.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:70.10 Median:73.50 stddev:14.03 (19.1%) stddev-sans-first:14.20 18:19:20 INFO - PROCESS | 1651 | Values: 82.0 60.0 60.0 86.0 59.0 65.0 52.0 62.0 91.0 84.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:84.00 stddev:14.39 (17.1%) stddev-sans-first:15.12 18:19:20 INFO - PROCESS | 1651 | Values: 90.0 86.0 82.0 71.0 72.0 95.0 67.0 72.0 99.0 111.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:88.00 stddev:4.62 (5.3%) stddev-sans-first:4.88 18:19:20 INFO - PROCESS | 1651 | Values: 88.0 88.0 88.0 87.0 102.0 87.0 91.0 88.0 89.0 86.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.50 stddev:23.28 (24.4%) stddev-sans-first:18.30 18:19:20 INFO - PROCESS | 1651 | Values: 152.0 151.0 95.0 96.0 96.0 95.0 96.0 95.0 97.0 102.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:93.00 stddev:15.74 (16.9%) stddev-sans-first:16.67 18:19:20 INFO - PROCESS | 1651 | Values: 94.0 97.0 93.0 93.0 96.0 93.0 93.0 91.0 76.0 138.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:61.50 stddev:9.82 (16.0%) stddev-sans-first:10.25 18:19:20 INFO - PROCESS | 1651 | Values: 60.0 61.0 59.0 60.0 59.0 62.0 61.0 67.0 70.0 91.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:88.40 Median:63.00 stddev:16.71 (26.5%) stddev-sans-first:13.93 18:19:20 INFO - PROCESS | 1651 | Values: 59.0 104.0 67.0 84.0 84.0 101.0 101.0 105.0 102.0 77.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:87.50 stddev:7.44 (8.5%) stddev-sans-first:7.79 18:19:20 INFO - PROCESS | 1651 | Values: 88.0 87.0 90.0 89.0 99.0 83.0 78.0 79.0 76.0 76.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:147.50 stddev:19.57 (13.3%) stddev-sans-first:20.29 18:19:20 INFO - PROCESS | 1651 | Values: 139.0 147.0 132.0 140.0 139.0 137.0 148.0 163.0 197.0 165.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:194.50 stddev:22.09 (11.4%) stddev-sans-first:23.36 18:19:20 INFO - PROCESS | 1651 | Values: 187.0 210.0 174.0 172.0 202.0 237.0 209.0 172.0 173.0 180.0 18:19:20 INFO - PROCESS | 1651 | 18:19:20 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:85.00 stddev:10.17 (12.0%) stddev-sans-first:10.52 18:19:20 INFO - PROCESS | 1651 | Values: 72.0 85.0 67.0 60.0 85.0 89.0 88.0 87.0 79.0 71.0 18:19:20 INFO - PROCESS | 1651 | -------- Summary: end -------- 18:19:20 INFO - PROCESS | 1651 | 18:19:21 INFO - TEST-INFO | 1651: exit 0 18:19:21 INFO - TEST-OK | kraken | took 61437ms 18:19:21 INFO - SUITE-END | took 1177s 18:19:22 INFO - Completed test suite (00:19:37) 18:19:22 INFO - javascript benchmark 18:19:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.977685742474, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.5086736989465, 3313.7349012079035, 3346.7657263991514, 3358.0, 3358.9496157557624, 4689.320048592952, 4726.91281005369, 5532.197831314457, 5550.417206193347, 5628.155776633507, 4886.706797592147, 5541.030319694058, 5572.7770889164385, 5595.63628364156, 5631.0, 5052.368453943257, 5062.443131255559, 5111.258867464216, 5169.741512924357, 5212.244224587433, 4325.891852703692, 5107.489251074881, 5270.314859068316, 5274.103402421598, 5302.814401495948, 5072.2391641253735, 5085.567726743231, 5226.137687281594, 5230.738463076831, 5251.76367063483, 4261.595148460891, 4270.38079478477, 5020.623453241022, 5104.719240441774, 5154.484551544853, 5067.315912351823, 5079.3650793650795, 5084.415292241402, 5106.8212612558755, 5140.511651393112, 5429.647072940246, 5471.413290145853, 5570.805021824217, 5610.354809196913, 5625.5218306444, 5128.384593848725, 6099.756009759604, 6107.786227482061, 6122.398155112023, 6198.81403557894, 5413.619527020584, 6044.546659000593, 6208.720607572625, 6220.87558248837, 6225.408586184305, 5807.88384232313, 5810.6513609183585, 5843.532517398683, 5847.473727364558, 5872.119182122673, 6131.468419844996, 6138.449706860586, 6140.964409184426, 6169.444749972524, 6185.597936134137, 6038.849028774316, 6053.606515576474, 6081.3614570470345, 6095.085737139376, 6111.51107911366, 6087.634741915499, 6175.96912015437, 6181.134641150243, 6189.133521307021, 6189.783357582553, 5963.850903727354, 6045.576809623284, 6059.909101363483, 6095.573309868355, 6124.908126378108, 6141.07883817431, 6150.815475535741, 6165.0444181152, 6167.599106058092, 6173.969130154321, 4925.187344088257, 4931.309616653672, 4932.926006109911, 4938.38270216223, 4971.1549036663855, 4398.450193725785, 4410.4927933287445, 4444.000099977544, 4446.421965144576, 4450.443694538183, 5514.751836167302, 5639.407862174495, 5690.231818704505, 5738.368779434259, 5767.077267637158, 6141.766804168937, 6199.907001394983, 6225.3774622537385, 6240.719167637467, 6241.500679945684, 5529.695866727368, 5615.129654903497, 5694.914576281359, 5710.314762228559, 5712.371639119777, 4858.902821943541, 5242.606804489602, 5388.568914486832, 5395.271638328853, 5422.0511410503, 6236.282827474808, 6246.219222597176, 6248.062790581449, 6248.687565621792, 6253.030780229072, 6065.545084118797, 6206.658633775186, 6210.099535567408, 6221.160143380585, 6222.408871157233, 6126.487138464006, 6158.661273629993, 6161.199044124235, 6210.378962103753, 6251.968425209971, 6071.666058366655, 6132.448079672851, 6133.417325354084, 6135.07973803933, 6157.353477884937, 4593.127305812019, 5817.301923769175, 6148.815535533941, 6207.65857877803, 6221.96889015552, 5263.5525980292105, 5875.41245875409, 5932.940670593412, 5989.550783691154, 6009.759609615567, 6040.36576159497, 6044.667543284985, 6045.063015232646, 6066.3023752269055, 6080.3919608040615, 4373.475182978063, 5737.368889422077, 5742.3109226891365, 5917.260342457193, 5960.046392577166, 5929.85175370602, 5999.070144127667, 6009.849753756191, 6065.54508411862, 6090.177825993612, 5376.951494458543, 5842.0, 5889.499392551681, 5909.02501087333, 5921.7631294747725], "value": 5567.683241636401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.77911486027267, 459.74024676058025, 462.59754014007797, 511.8483412322276, 523.1159340714195, 37709.43435848464, 39692.0, 41452.0, 41473.377899331455, 43587.0, 42229.7888510557, 42806.92982675435, 42812.35781463281, 42827.571724282745, 43078.353824692575, 8425.410221284512, 9366.0, 9543.618255269781, 9568.138867501924, 9590.520473976308, 8478.703245386412, 11208.831867521994, 11495.195336326418, 11502.3673697947, 11680.0655947524, 11356.148288878327, 11380.374079425628, 11390.658280251606, 11430.71423214418, 11432.37121958292, 11424.42877856108, 11497.770044599145, 11499.080073594092, 11511.769764604745, 11528.59649912249, 11281.266717663326, 11358.943205284004, 11361.943190284079, 11372.37451940143, 11388.0, 39999.200015999806, 40237.79881100605, 40315.798421007705, 40350.59649403498, 40409.797951010056, 3976.522817261918, 3992.7803970781597, 4014.8394064237395, 4046.817893194813, 4048.838046478137, 27882.581761273595, 28605.71394286051, 29052.70947290521, 30788.692113078807, 31178.844105779324, 3174.7301479374282, 3196.824174670392, 3205.6954589313978, 3301.4717645176656, 3305.3719793239206, 457269.0, 458265.0, 458781.0, 460778.0, 461951.0, 56851.71574142103, 57010.72881982978, 57213.0, 57245.71377143088, 57306.56733581694, 58802.705986469795, 59055.0, 59062.704686476296, 59106.70446647825, 59310.0, 15162.696746065018, 15585.922070389575, 15647.0, 15654.0, 15699.843001570067, 10859.2398532102, 11173.162012849069, 11858.110641701907, 12020.97821685149, 12119.39403029845, 17489.38787142444, 17973.393857890795, 17995.280188792563, 18006.099695015197, 18050.548736281697, 6950.0, 7957.960210198912, 7991.4006449515355, 8027.879581806277, 8048.5170889746805, 842.3682238321259, 857.9742607721778, 869.2350731356366, 872.8609165039558, 876.6361959786617, 28928.566071508943, 29048.41903161925, 29781.213127212435, 30262.243443914078, 30806.691933080383, 1009.399407352624, 1014.9289549731448, 1041.4063983529468, 1070.973225669349, 1172.7302720374362, 15023.399064037316, 15814.288357023732, 15859.444919427764, 15891.920540397456, 16141.838581614034, 627321.0, 633238.0, 640010.0, 641368.0, 642954.0, 60879.39120608826, 61477.077843832376, 61631.69184154051, 61755.38244617586, 61765.073523897176, 1393.052724147569, 1408.8520705325793, 1425.0, 1427.7001829615897, 1428.292994967477, 28678.713212867606, 29357.55963660504, 29669.25826854346, 30284.394312113192, 30327.848360758937, 50459.495405046946, 50462.74768626133, 50844.0, 50960.49039509558, 51100.74449627728, 526964.0, 529480.0, 532747.0, 535265.0, 535377.0, 25239.242822715347, 25893.96424143013, 26021.869890650425, 26740.732592673823, 26799.464010720065, 42719.0, 42956.57043429526, 43384.783076084415, 43521.34717979169, 43868.56131438645, 35610.46584301186, 35625.0, 36208.913732588066, 36267.0, 36865.0, 30588.694113058584, 35502.112447187996, 35701.57193712222, 36265.0, 36328.46878651476, 34798.30403391867, 34827.60689572389, 34924.65075349214, 35023.0, 35450.0, 29701.851490742407, 31548.526772098896, 31582.842085789423, 31744.6825531751, 31810.681893181696, 19014.42956711301, 23774.405639859142, 23786.572805631717, 23967.760322396553, 25062.874685626455], "value": 19847.582492193393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.0524892446173, 387.8002828543301, 393.4982896806572, 401.31375348154654, 415.883353196667, 15810.920945395257, 16861.915690421545, 20713.585728285427, 21223.46941326466, 21340.0, 21292.041858116383, 21354.35936921895, 21446.678299825475, 21450.0, 21743.565128697417, 5629.662220266797, 5780.739866705987, 5823.010088285002, 5829.795957141501, 5842.853928651775, 5593.972030139844, 5686.9146962795385, 5705.572082093839, 5755.884882302373, 5769.0192667246665, 5735.913961290563, 5740.339860915986, 5745.224394706703, 5746.913796293059, 5758.971205143968, 4727.621790256789, 5030.723310217936, 5264.315638966929, 5329.920051199216, 6040.788572399989, 5083.440821509668, 5986.880262394771, 5992.8501787455225, 6033.456988870978, 6042.093685947099, 12993.350332483433, 22279.888600557057, 24039.759602403927, 24769.00923963039, 24892.626610600855, 2539.961900571493, 2647.404334024848, 2661.946761064787, 2671.0407643438325, 2716.4023914738727, 9405.341626086176, 9826.852597211047, 10201.132903703194, 10302.845457318146, 11510.0, 1817.8545716342794, 1823.4438496258635, 1833.6607727570442, 1842.4012196036208, 1850.5466160790559, 137552.0, 138775.0, 140526.59473405237, 142119.57880421166, 143788.28105859403, 9290.303227257982, 10656.946715266375, 11865.703357416134, 11881.584144555072, 12044.578439754567, 13799.586012419644, 14460.421583136556, 15263.92368038175, 15266.847331526542, 15280.617984550476, 8158.755237342889, 8419.621117049748, 8544.060153383123, 8554.486730796172, 8708.564571771387, 8399.0, 8399.076101628816, 8402.621882015324, 8519.361047921431, 8573.442726222776, 4713.717176969393, 4758.286257061469, 4769.618430525549, 4793.904121917542, 4819.975900120477, 1993.9531745833262, 2030.8679935804125, 2035.104553996237, 2038.347728726793, 2046.31448464763, 968.6270785747397, 994.627014869424, 995.382862625177, 1005.2812239248972, 1048.418127938986, 20753.377398678065, 20883.37349879506, 20959.8952005239, 20972.79027209739, 21051.052702628418, 1021.7037059252733, 1021.7496713305288, 1040.9635662751768, 1049.4228174503992, 1057.3655806516183, 9196.586153623102, 10720.571177152982, 10835.133189344833, 10888.564457421615, 10899.400532970763, 355937.0, 751164.0, 759300.203498979, 767116.0, 775667.0, 141544.39884222476, 155735.0, 159071.0, 162224.07767572897, 163304.0, 996.7490799047149, 1015.1979935850595, 1037.7768779712399, 1043.6503771236569, 1046.2937517176028, 19416.0, 19435.8056419434, 19602.54968128984, 19854.801451985295, 19974.800251997294, 47256.29115563338, 52234.73882630563, 60678.78642427215, 60978.39021609727, 61784.455388613846, 65512.0, 89846.55076724575, 90469.0, 91388.08611913795, 92382.6142607848, 7112.253213412724, 7394.030798539477, 7437.144728356308, 8021.639026243716, 8483.95758021206, 9264.814703706023, 11945.641630751092, 12917.870821292043, 13063.648543262305, 13469.528566500125, 8993.595288211915, 11053.447327633425, 11346.432678366215, 11680.824787628362, 11740.530378784753, 11057.391843448688, 11178.888211117785, 11228.66314010581, 11511.827322590001, 11592.960063818387, 11452.713682157679, 11743.41282935867, 11877.990370818578, 11929.701757455787, 11967.581134660246, 7440.330370266702, 7659.348955338635, 7690.884636730565, 7770.22297770241, 7831.765047048598, 10187.388756674623, 11036.5033573491, 11498.310101393943, 11583.247088939192, 11787.469563869476], "value": 9793.370839519663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.4357569820675, 1394.1356359057386, 1394.4422231107555, 1412.7779470757791, 1426.7003929174869, 7385.076865391826, 7600.885986710204, 7900.209979002097, 8329.583520823957, 8391.370647201462, 7817.843643127148, 8100.392470564701, 8107.797305067376, 8172.305354044914, 8195.672173113084, 1948.0, 2253.830962677802, 2286.325533967484, 2289.6565515172774, 2292.8165746740306, 2027.290448343083, 2104.7895210478982, 2260.8304377171694, 2301.2175860207526, 2312.2947501012186, 2208.4699672078664, 2280.851744636602, 2287.6911616931666, 2289.53064621753, 2303.009705826494, 2256.4471704432435, 2263.909443622253, 2280.8859557022083, 2281.1673739085113, 2282.8744419056943, 1895.9146838392305, 2077.387170784607, 2111.19774485696, 2133.1787261904124, 2143.3677065265783, 8230.62962166698, 8244.54654993981, 8287.709930152416, 8297.12880147588, 8326.292265157468, 4997.100521906055, 5137.7944882204665, 5143.485651434864, 5172.793088276464, 5174.2238664200295, 3323.2356557991557, 3422.2984288220855, 3457.567804024497, 3481.7388695847912, 3487.5640544931885, 1008.4503945349802, 1180.9725538781315, 1203.6990752311922, 1231.335079057308, 1237.2623837592012, 10429.843552346721, 10479.109275711497, 10488.685339439753, 10530.52612632441, 10677.893221067767, 4152.522459917148, 4352.412424322739, 4423.977880110579, 4426.601605855489, 4432.49026361966, 8433.451825631315, 8527.147285271423, 8544.145585441405, 8546.829063418822, 8553.786155346166, 5041.521055499722, 5044.772985215674, 5044.772985215674, 5050.267711181858, 5055.317532133115, 4579.633629309647, 4656.41794775653, 4692.0, 4730.0, 4746.762661866893, 3832.137769001952, 3874.49631547897, 3886.300465916162, 3918.529776426847, 3938.350172221609, 1177.0818761366147, 1213.9453724582415, 1265.576032029262, 1289.2264641215195, 1297.5523444411663, 735.9484836061424, 749.5427789048676, 766.4902839611595, 786.8268980824324, 809.8055368331782, 4907.288443175719, 5669.773209071674, 5741.540676745851, 5771.134329850472, 5789.768409263583, 952.0975900029725, 957.7366224288377, 974.5370948799406, 982.4891056650645, 996.5017491254373, 3677.4483827425565, 3692.095436618046, 3769.3968964965475, 3808.295465338921, 3866.2654095721723, 9452.716418507456, 9683.080107389787, 9753.0, 9770.462624555717, 9771.21830253578, 9701.854472182922, 9709.029097090375, 9723.513824308757, 9725.027497250217, 9744.902550974399, 7596.658150383246, 7726.922730772732, 7737.729179478803, 7744.341730952932, 7745.651445684957, 4704.729722974709, 5180.48195180494, 5254.7898084076205, 5528.585356098229, 5564.137558678412, 8705.651773929225, 8768.210861022539, 8835.293176545989, 8878.289736821169, 8972.327075469235, 8351.540665263468, 8530.872036919576, 8945.955270223607, 9087.454752714859, 9154.0, 6481.5138864584405, 6670.499712521483, 6677.797996360701, 6685.966570167118, 6690.799276021728, 7335.816604584928, 7653.387728981556, 7695.4997925134685, 7699.422543309162, 7712.38300935935, 6068.969655151696, 7066.858662826612, 7123.679434425567, 7164.462665300019, 7183.604901730455, 6894.689738961859, 6964.477664175106, 6966.5471744336455, 6984.511084224056, 6994.475414343843, 6041.69791510414, 6130.448259656652, 6134.171886795404, 6140.539459540463, 6143.907841382294, 4041.9191616166922, 4775.832845850378, 4791.161546729239, 4810.254410566367, 4853.39332583427, 4892.92660610084, 4898.926516102332, 5000.999800039934, 5074.695518268915, 5083.5678967288195], "value": 4288.048845307391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.76387584194435, 362.53052297275025, 371.16858237547893, 374.83694592852095, 377.2699825837007, 3963.960360396395, 4690.437147542296, 4893.021395720857, 5276.472352764731, 5508.7796488140475, 4419.823207071713, 5081.517255860696, 5191.506806853352, 5348.277982472365, 5375.516203541691, 3539.5752509698873, 3996.960030399702, 4220.978895105535, 4259.76571288579, 4263.742196052172, 3495.5106285120105, 3955.32759430896, 4222.366645003243, 4258.339957306623, 4261.318189089746, 4027.9798601006955, 4030.2342554914617, 4036.9008115779775, 4044.858429954952, 4044.9483134385123, 3293.0, 3302.3725492156414, 3944.7435916665327, 4041.454403655513, 4043.8272900858715, 3433.656634336571, 3480.617132115465, 3509.6314886937016, 3537.876174333912, 3552.9111772205642, 4020.9396859047138, 4798.904021919542, 5069.923951140736, 5190.948090519084, 5227.47725227478, 3729.981350093259, 4089.44792453018, 4446.843820606633, 4629.537046295343, 4678.134545109166, 4305.483341998949, 5412.9458705412835, 5558.610897237195, 5564.998300305984, 5643.867653452332, 3336.96663033369, 3633.582138054131, 3839.347310957144, 3839.865604703822, 3852.0755018795567, 5172.6379153459275, 5264.921026184572, 5981.547565498168, 5983.431574000463, 6000.459958603703, 3819.751716138442, 3945.3292940200236, 3961.960380396217, 3966.0, 3971.160620156602, 3858.2476417098956, 3991.6207960243732, 3992.321305378093, 4001.6198461146146, 4030.7581545107387, 3873.903152421212, 4560.468939738477, 4647.279671650899, 4662.557057079572, 4674.672772905864, 5110.795568177231, 5730.799422020209, 5783.479486846204, 5786.3056433228285, 5812.0, 1238.4612693478366, 1246.2958428488057, 1253.755517674063, 1281.5450515067203, 1296.546208826903, 765.6669348833275, 768.1243382543904, 808.551254053994, 817.8078151634361, 864.1790299215645, 4997.625178111656, 5004.224345226496, 5069.721165335942, 5089.134847076006, 5095.617828662865, 4771.379720636295, 4872.6589138760655, 5392.91910621341, 5643.717814109278, 5697.344805347355, 4571.47428045779, 4614.953850461452, 4675.708902637683, 4681.789319480631, 5002.274670172805, 2949.301389228832, 2952.892665250531, 2962.762978961678, 2964.303388703653, 2964.688707685705, 4986.850394488171, 5507.934524553292, 5512.0, 5624.746886390122, 5818.5054270386645, 5499.697516636544, 5581.488330251403, 5805.54570030831, 5822.650640961556, 5831.854203644943, 4798.664093513421, 5434.0, 5835.416458354131, 5867.0, 5871.4715675589405, 5080.034793389244, 5215.582753379645, 5241.903238704549, 5517.724113794375, 5855.414458554111, 4881.511848815232, 5556.749946252347, 5855.648661080349, 5914.615549989237, 5924.7926322578505, 4561.0, 5032.370953630796, 5119.385673719029, 5621.437856214509, 6061.787837425669, 3410.948835767515, 3863.7295389322476, 3900.1419687668667, 3921.6862650988423, 3925.450436938888, 5580.525655319343, 5795.420457954171, 5887.941120588911, 5904.61619994699, 5920.0, 4505.774711264358, 5638.323401191883, 5656.161747432019, 5674.460926212003, 5705.657660540381, 4943.777530011086, 5302.814401495929, 5679.716014199356, 5688.914666279927, 5698.694757040989, 4854.902901942012, 5189.4032186299055, 5295.093766244226, 5322.737836419429, 5364.827244965795, 5171.595208228192, 5253.868653283545, 5464.551893748239, 5676.517496012885, 5693.658380497018, 5264.868378290574, 5531.834044978657, 5554.91667624994, 5556.333240011063, 5564.276644036249], "value": 4057.0880568268085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.7725739134776, 710.8578284343133, 752.1388010727713, 807.9272865442111, 848.9745307640769, 14661.926690366547, 15550.45573404931, 15603.609909752233, 15622.609434764123, 15745.842541574595, 10979.341239525635, 13907.930460347685, 14030.73723364897, 14566.708665826676, 14764.557063288119, 857.3569822633025, 859.8495263328892, 871.8038441350709, 873.4977388001893, 877.4735158904638, 689.0731965506386, 698.8497473043294, 858.8840506531632, 859.7979474823443, 860.849351363512, 888.6401007591936, 916.5325683901225, 922.8523436250201, 922.9353945223837, 926.0, 910.9726708198765, 912.4023764434306, 913.0549880873265, 915.0026471146449, 915.1580545897757, 673.0879658063303, 678.1116737074449, 679.8572299817044, 682.6791408038214, 685.143570536829, 14711.63220919475, 14949.551513454613, 15130.092194468258, 15133.33533311335, 15142.242887855564, 13462.499750064955, 13621.846055573324, 13705.588832335046, 13763.31183440824, 13805.792913106312, 10929.234953553254, 11470.627699066206, 11522.539098436137, 12273.202241854251, 12981.0, 4508.098380323949, 4523.909521809578, 4563.589276965089, 4666.556677115668, 4682.461516925529, 79801.60099199525, 86959.13040869574, 105094.0, 106273.46863265634, 111740.32389514083, 10621.362718236931, 10682.985116413929, 10697.358158510358, 10830.278024755593, 10994.120470362352, 20986.790132098482, 21001.89499052495, 21031.68452473214, 21072.683909741365, 21116.0, 7426.554406735613, 7445.739399121113, 7515.436342274351, 7553.471257012066, 7673.386129109769, 4098.159877225162, 4098.631123198867, 4165.604267594574, 4175.269327867611, 4297.097609501977, 3462.6191118976894, 3532.5760908691122, 3540.6990405815795, 3549.597908826051, 3554.289142171576, 610.8272117534256, 655.6459511863636, 665.2383021440423, 665.8102440804347, 678.6301465701106, 587.8883012227664, 621.8041316985135, 637.7417146055855, 662.1987395251703, 666.380266352297, 8074.869518267447, 9568.186704130088, 9874.654387096562, 9998.400255959157, 10029.448380339152, 573.21755803329, 640.5683297829347, 650.1223348479515, 657.2999755260632, 664.5182242873877, 4635.0, 4936.728479933567, 4939.753012349368, 4953.950460495349, 4957.578605818474, 87707.0, 96052.51973740227, 100219.0, 103309.0, 104611.0, 89423.65864512038, 89710.0, 91475.54262228646, 91899.62150567747, 95977.0, 80804.19195807967, 81024.18975810167, 81638.0, 82307.0, 82610.58694706488, 9571.33000689945, 9646.372985755903, 9673.661421850202, 9678.467684277432, 9688.51557422112, 48251.51748482611, 54084.0, 55100.17349739837, 55205.17192242039, 55951.16073258823, 58033.70983145057, 62726.37273627205, 67410.32589674236, 68380.0, 69802.65098674475, 11760.88239117598, 12023.579174728842, 12901.677458063623, 13053.0, 13136.540221092217, 14302.832244008467, 14463.49377771773, 14608.519652149773, 14741.11553306805, 14943.77584336214, 11480.518449415507, 13400.731985360433, 13713.314334283046, 13739.931300343434, 13886.722265554834, 11197.425423938606, 13170.539031133865, 13523.256220907944, 13560.0, 13590.048696591539, 13135.211887286794, 13367.0, 13483.595492135251, 13749.793753093512, 13762.724745505235, 10529.57881684724, 10731.153225324375, 10969.396683182502, 11011.889881101086, 11344.489497972447, 8743.781405464913, 10431.634892778717, 10580.259381843198, 10624.628138015132, 10737.838932415863], "value": 7454.255123031592, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 134.0, 175.0, 117.0, 116.0, 119.0, 119.0, 118.0, 117.0, 118.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 97.0, 142.0, 183.0, 141.0, 125.0, 111.0, 113.0, 123.0, 141.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 207.0, 249.0, 253.0, 197.0, 211.0, 191.0, 199.0, 193.0, 195.0], "value": 210.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 86.0, 59.0, 65.0, 52.0, 62.0, 91.0, 84.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 82.0, 71.0, 72.0, 95.0, 67.0, 72.0, 99.0, 111.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 102.0, 87.0, 91.0, 88.0, 89.0, 86.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 102.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 93.0, 93.0, 96.0, 93.0, 93.0, 91.0, 76.0, 138.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 59.0, 62.0, 61.0, 67.0, 70.0, 91.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 104.0, 67.0, 84.0, 84.0, 101.0, 101.0, 105.0, 102.0, 77.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 89.0, 99.0, 83.0, 78.0, 79.0, 76.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 132.0, 140.0, 139.0, 137.0, 148.0, 163.0, 197.0, 165.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 210.0, 174.0, 172.0, 202.0, 237.0, 209.0, 172.0, 173.0, 180.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 85.0, 67.0, 60.0, 85.0, 89.0, 88.0, 87.0, 79.0, 71.0], "value": 78.3, "unit": "score"}]}]} 18:19:22 INFO - Return code: 0 18:19:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:19:22 ERROR - # TBPL SUCCESS # 18:19:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:19:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:19:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:19:22 INFO - 2017-01-27 18:19:22.216 screenresolution[1656:10456] starting screenresolution argv=screenresolution get 18:19:22 INFO - 2017-01-27 18:19:22.219 screenresolution[1656:10456] Display 0: 1600x1200x32@60 18:19:22 INFO - 2017-01-27 18:19:22.225 screenresolution[1657:10459] starting screenresolution argv=screenresolution list 18:19:22 INFO - Available Modes on Display 0 18:19:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:19:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:19:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:19:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:19:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:19:22 INFO - Intel Iris: 18:19:22 INFO - Chipset Model: Intel Iris 18:19:22 INFO - Type: GPU 18:19:22 INFO - Bus: Built-In 18:19:22 INFO - VRAM (Dynamic, Max): 1536 MB 18:19:22 INFO - Vendor: Intel (0x8086) 18:19:22 INFO - Device ID: 0x0a2e 18:19:22 INFO - Revision ID: 0x0009 18:19:22 INFO - Displays: 18:19:22 INFO - Display: 18:19:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:19:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:19:22 INFO - Display Serial Number: 1600x1200 60 18:19:22 INFO - Main Display: Yes 18:19:22 INFO - Mirror: Off 18:19:22 INFO - Online: Yes 18:19:22 INFO - Rotation: Supported 18:19:22 INFO - Return code: 0 18:19:22 INFO - Running post-action listener: _resource_record_post_action 18:19:22 INFO - [mozharness: 2017-01-28 02:19:22.460474Z] Finished run-tests step (success) 18:19:22 INFO - Running post-run listener: _resource_record_post_run 18:19:22 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 40262144; Write bytes: 556732416; Read time: 390; Write time: 1849 18:19:22 INFO - TinderboxPrint: CPU usage
54.7% 18:19:22 INFO - TinderboxPrint: I/O read bytes / time
40,262,144 / 390 18:19:22 INFO - TinderboxPrint: I/O write bytes / time
556,732,416 / 1,849 18:19:22 INFO - TinderboxPrint: CPU idle
2,176.0 (45.3%) 18:19:22 INFO - TinderboxPrint: CPU system
970.3 (20.2%) 18:19:22 INFO - TinderboxPrint: CPU user
1,655.4 (34.5%) 18:19:22 INFO - TinderboxPrint: Swap in / out
291,524,608 / 0 18:19:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248416768; Write bytes: 240717824; Read time: 17805; Write time: 446 18:19:22 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35727872; Write bytes: 302632960; Read time: 359; Write time: 1358 18:19:22 INFO - Running post-run listener: _upload_blobber_files 18:19:22 INFO - Blob upload gear active. 18:19:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:19:22 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:19:22 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:19:22 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:19:23 INFO - (blobuploader) - INFO - Open directory for files ... 18:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:24 INFO - (blobuploader) - INFO - Done attempting. 18:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:25 INFO - (blobuploader) - INFO - Done attempting. 18:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:26 INFO - (blobuploader) - INFO - Done attempting. 18:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:28 INFO - (blobuploader) - INFO - Done attempting. 18:19:28 INFO - (blobuploader) - INFO - Iteration through files over. 18:19:28 INFO - Return code: 0 18:19:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:19:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:19:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71dec1c1316938ad3e85001a193c118ea1bdac03c9f8e54655e97d1d03fc7954f233260383713146784c2de6be919ced3293a490691744feaed201b0843e67bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fde3d2628901395ae4f7ab5c2252645fa9d3f3672aeced209388dabf1b9c2e4de19ec3551237fcef918a25270e110738e30dcc59a143d6471caea27fede2a39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb0c86441efb51e38e90ed4e1e9a7f244605fa6e30034c42b1551f3242129fdaad51df1e95001696ca973c0a65dd5f1750acbdb8dc345a1757355370f1398ab9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf0a8cef9f7baf027bdde2d9299a15a53ac8fd71efd09565c692d1fa6177f4320c4898eda335b086082752ab12978958b4905a0f56e5dc877b4a597746ec8f98"} 18:19:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:19:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:19:28 INFO - Contents: 18:19:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71dec1c1316938ad3e85001a193c118ea1bdac03c9f8e54655e97d1d03fc7954f233260383713146784c2de6be919ced3293a490691744feaed201b0843e67bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fde3d2628901395ae4f7ab5c2252645fa9d3f3672aeced209388dabf1b9c2e4de19ec3551237fcef918a25270e110738e30dcc59a143d6471caea27fede2a39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb0c86441efb51e38e90ed4e1e9a7f244605fa6e30034c42b1551f3242129fdaad51df1e95001696ca973c0a65dd5f1750acbdb8dc345a1757355370f1398ab9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf0a8cef9f7baf027bdde2d9299a15a53ac8fd71efd09565c692d1fa6177f4320c4898eda335b086082752ab12978958b4905a0f56e5dc877b4a597746ec8f98"} 18:19:28 INFO - Running post-run listener: copy_logs_to_upload_dir 18:19:28 INFO - Copying logs to upload dir... 18:19:28 INFO - mkdir: /builds/slave/test/build/upload/logs 18:19:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.645771 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-27 18:19:28.546602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 18:19:28.552720) ========= 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.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/71dec1c1316938ad3e85001a193c118ea1bdac03c9f8e54655e97d1d03fc7954f233260383713146784c2de6be919ced3293a490691744feaed201b0843e67bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fde3d2628901395ae4f7ab5c2252645fa9d3f3672aeced209388dabf1b9c2e4de19ec3551237fcef918a25270e110738e30dcc59a143d6471caea27fede2a39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb0c86441efb51e38e90ed4e1e9a7f244605fa6e30034c42b1551f3242129fdaad51df1e95001696ca973c0a65dd5f1750acbdb8dc345a1757355370f1398ab9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf0a8cef9f7baf027bdde2d9299a15a53ac8fd71efd09565c692d1fa6177f4320c4898eda335b086082752ab12978958b4905a0f56e5dc877b4a597746ec8f98"} build_url:https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/GH9p1kE2QPi8WodLAfirlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71dec1c1316938ad3e85001a193c118ea1bdac03c9f8e54655e97d1d03fc7954f233260383713146784c2de6be919ced3293a490691744feaed201b0843e67bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fde3d2628901395ae4f7ab5c2252645fa9d3f3672aeced209388dabf1b9c2e4de19ec3551237fcef918a25270e110738e30dcc59a143d6471caea27fede2a39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb0c86441efb51e38e90ed4e1e9a7f244605fa6e30034c42b1551f3242129fdaad51df1e95001696ca973c0a65dd5f1750acbdb8dc345a1757355370f1398ab9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf0a8cef9f7baf027bdde2d9299a15a53ac8fd71efd09565c692d1fa6177f4320c4898eda335b086082752ab12978958b4905a0f56e5dc877b4a597746ec8f98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 18:19:28.586489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 18:19:28.586827) ========= 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.T813OLXfFH/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.qa7aBNMyxo/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 18:19:28.635032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 18:19:28.635370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 18:19:28.635703) ========= ========= Total master_lag: 3.37 =========