builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0135 starttime: 1491512168.05 results: success (0) buildid: 20170406123529 builduid: 86f796422adc4ef7a88f1e5be31eb89c revision: fc66dce2192b788956c6b5c1bfaf090f1c067af1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.053169) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.053616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.053892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.080768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.081113) ========= 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.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-06 13:56:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2017-04-06 13:56:08 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.202249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.305621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.305953) ========= 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.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.028769 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:08.395646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 13:56:08.395998) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc66dce2192b788956c6b5c1bfaf090f1c067af1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc66dce2192b788956c6b5c1bfaf090f1c067af1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-06 13:56:08,544 truncating revision to first 12 chars 2017-04-06 13:56:08,544 Setting DEBUG logging. 2017-04-06 13:56:08,545 attempt 1/10 2017-04-06 13:56:08,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc66dce2192b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 13:56:09,909 unpacking tar archive at: mozilla-beta-fc66dce2192b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.642125 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 13:56:10.213068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:10.213401) ========= script_repo_revision: fc66dce2192b788956c6b5c1bfaf090f1c067af1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:10.213782) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:10.214050) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 13:56:10.234543) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-06 13:56:10.234932) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:10 INFO - MultiFileLogger online at 20170406 13:56:10 in /builds/slave/test 13:56:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:56:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:56:10 INFO - {'append_to_log': False, 13:56:10 INFO - 'base_work_dir': '/builds/slave/test', 13:56:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:56:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:56:10 INFO - 'branch': 'Mozilla-Beta', 13:56:10 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:10 INFO - 'config_files': ('talos/mac_config.py',), 13:56:10 INFO - 'default_actions': ('clobber', 13:56:10 INFO - 'read-buildbot-config', 13:56:10 INFO - 'download-and-extract', 13:56:10 INFO - 'populate-webroot', 13:56:10 INFO - 'create-virtualenv', 13:56:10 INFO - 'install', 13:56:10 INFO - 'run-tests'), 13:56:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:10 INFO - 'download_minidump_stackwalk': True, 13:56:10 INFO - 'download_symbols': 'ondemand', 13:56:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:10 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:10 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:10 INFO - 'installer_path': 'installer.exe', 13:56:10 INFO - 'log_level': 'info', 13:56:10 INFO - 'log_name': 'talos', 13:56:10 INFO - 'log_to_console': True, 13:56:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:56:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:56:10 INFO - 'opt_config_files': (), 13:56:10 INFO - 'pip_index': False, 13:56:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:10 INFO - 'cmd': ('bash', 13:56:10 INFO - '-c', 13:56:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:10 INFO - 'enabled': True, 13:56:10 INFO - 'halt_on_failure': False, 13:56:10 INFO - 'name': 'check_screen_resolution'},), 13:56:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:10 INFO - 'cmd': ('bash', 13:56:10 INFO - '-c', 13:56:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:10 INFO - 'enabled': True, 13:56:10 INFO - 'halt_on_failure': False, 13:56:10 INFO - 'name': 'check_screen_resolution'},), 13:56:10 INFO - 'run_cmd_checks_enabled': True, 13:56:10 INFO - 'sps_profile': False, 13:56:10 INFO - 'sps_profile_interval': 0, 13:56:10 INFO - 'suite': 'dromaeojs-e10s', 13:56:10 INFO - 'system_bits': '32', 13:56:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:10 INFO - 'title': 't-yosemite-r7-0135', 13:56:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:10 INFO - 'use_talos_json': True, 13:56:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:56:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:10 INFO - 'work_dir': 'build'} 13:56:10 INFO - [mozharness: 2017-04-06 20:56:10.450424Z] Running clobber step. 13:56:10 INFO - Running pre-action listener: _resource_record_pre_action 13:56:10 INFO - Running main action method: clobber 13:56:10 INFO - rmtree: /builds/slave/test/build 13:56:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:12 INFO - Running post-action listener: _resource_record_post_action 13:56:12 INFO - [mozharness: 2017-04-06 20:56:12.936438Z] Finished clobber step (success) 13:56:12 INFO - [mozharness: 2017-04-06 20:56:12.936603Z] Running read-buildbot-config step. 13:56:12 INFO - Running pre-action listener: _resource_record_pre_action 13:56:12 INFO - Running main action method: read_buildbot_config 13:56:12 INFO - Using buildbot properties: 13:56:12 INFO - { 13:56:12 INFO - "project": "", 13:56:12 INFO - "product": "firefox", 13:56:12 INFO - "script_repo_revision": "production", 13:56:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:56:12 INFO - "repository": "", 13:56:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:56:12 INFO - "buildid": "20170406123529", 13:56:12 INFO - "pgo_build": "False", 13:56:12 INFO - "basedir": "/builds/slave/test", 13:56:12 INFO - "buildnumber": 25, 13:56:12 INFO - "slavename": "t-yosemite-r7-0135", 13:56:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:56:12 INFO - "platform": "yosemite_r7", 13:56:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:56:12 INFO - "branch": "mozilla-beta", 13:56:12 INFO - "repo_path": "releases/mozilla-beta", 13:56:12 INFO - "revision": "fc66dce2192b788956c6b5c1bfaf090f1c067af1", 13:56:12 INFO - "stage_platform": "macosx64", 13:56:12 INFO - "builduid": "86f796422adc4ef7a88f1e5be31eb89c", 13:56:12 INFO - "slavebuilddir": "test" 13:56:12 INFO - } 13:56:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 13:56:12 INFO - Running post-action listener: _resource_record_post_action 13:56:12 INFO - [mozharness: 2017-04-06 20:56:12.939941Z] Finished read-buildbot-config step (success) 13:56:12 INFO - [mozharness: 2017-04-06 20:56:12.940056Z] Running download-and-extract step. 13:56:12 INFO - Running pre-action listener: _resource_record_pre_action 13:56:12 INFO - Running main action method: download_and_extract 13:56:12 INFO - mkdir: /builds/slave/test/build/tests 13:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:12 INFO - trying https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 13:56:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 13:56:14 INFO - Downloaded 1165 bytes. 13:56:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:56:14 INFO - Using the following test package requirements: 13:56:14 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:56:14 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 13:56:14 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 13:56:14 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:56:14 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 13:56:14 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:56:14 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 13:56:14 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 13:56:14 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 13:56:14 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:56:14 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 13:56:14 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 13:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:56:14 INFO - Fetch https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:56:15 INFO - Expected file size: 16116435 13:56:15 INFO - Obtained file size: 16116435 13:56:22 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:56:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:56:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:56:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:56:22 INFO - Expected file size: 16116435 13:56:22 INFO - Obtained file size: 16116435 13:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 13:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 13:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 13:56:30 INFO - Expected file size: 14403663 13:56:30 INFO - Obtained file size: 14403663 13:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:31 INFO - trying https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:56:31 INFO - Downloading https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 13:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 13:56:33 INFO - Downloaded 58740687 bytes. 13:56:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:56:33 INFO - mkdir: /builds/slave/test/properties 13:56:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:56:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:56:33 INFO - Contents: 13:56:33 INFO - build_url:https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:56:33 INFO - Running post-action listener: _resource_record_post_action 13:56:33 INFO - Running post-action listener: set_extra_try_arguments 13:56:33 INFO - [mozharness: 2017-04-06 20:56:33.798001Z] Finished download-and-extract step (success) 13:56:33 INFO - [mozharness: 2017-04-06 20:56:33.798123Z] Running populate-webroot step. 13:56:33 INFO - Running pre-action listener: _resource_record_pre_action 13:56:33 INFO - Running main action method: populate_webroot 13:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:33 INFO - '--tppagecycles', 13:56:33 INFO - '7'], 13:56:33 INFO - 'tests': ['tsvgm']}}, 13:56:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:56:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['damp', 'tps']}, 13:56:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'tests': ['damp', 'tps']}, 13:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['dromaeo_dom']}, 13:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['basic_compositor_video']}, 13:56:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['a11yr', 13:56:33 INFO - 'ts_paint', 13:56:33 INFO - 'tpaint', 13:56:33 INFO - 'sessionrestore', 13:56:33 INFO - 'sessionrestore_no_auto_restore', 13:56:33 INFO - 'tabpaint']}, 13:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['tsvgx', 13:56:33 INFO - 'tsvgr_opacity', 13:56:33 INFO - 'tart', 13:56:33 INFO - 'tscrollx', 13:56:33 INFO - 'cart', 13:56:33 INFO - 'tsvg_static']}, 13:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:56:33 INFO - 'tsvgr_opacity', 13:56:33 INFO - 'tart', 13:56:33 INFO - 'tscrollx', 13:56:33 INFO - 'cart', 13:56:33 INFO - 'tsvg_static']}, 13:56:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'talos_options': ['--disable-e10s'], 13:56:33 INFO - 'tests': ['tp5o']}, 13:56:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:56:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'talos_options': ['--disable-e10s', 13:56:33 INFO - '--xperf_path', 13:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:33 INFO - 'tests': ['tp5n']}, 13:56:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:56:33 INFO - 'talos_options': ['--xperf_path', 13:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:33 INFO - 'tests': ['tp5n']}}, 13:56:33 INFO - 'talos.zip': {'path': '', 13:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:33 INFO - Running post-action listener: _resource_record_post_action 13:56:33 INFO - [mozharness: 2017-04-06 20:56:33.816552Z] Finished populate-webroot step (success) 13:56:33 INFO - [mozharness: 2017-04-06 20:56:33.816695Z] Running create-virtualenv step. 13:56:33 INFO - Running pre-action listener: _resource_record_pre_action 13:56:33 INFO - Running main action method: create_virtualenv 13:56:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:56:33 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 13:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:33 INFO - Using real prefix '/tools/python27' 13:56:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 13:56:37 INFO - Installing pip.................done. 13:56:37 INFO - Return code: 0 13:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:56:37 INFO - Reading from file tmpfile_stdout 13:56:37 INFO - Output received: 13:56:37 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) 13:56:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:56:37 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')]} 13:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:37 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')]} 13:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:37 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:37 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 13:56:37 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 13:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:37 INFO - 'HOME': '/Users/cltbld', 13:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:37 INFO - 'LOGNAME': 'cltbld', 13:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:37 INFO - 'MOZ_NO_REMOTE': '1', 13:56:37 INFO - 'NO_EM_RESTART': '1', 13:56:37 INFO - 'PAGER': '/bin/cat', 13:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:37 INFO - 'PWD': '/builds/slave/test', 13:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:37 INFO - 'SHELL': '/bin/bash', 13:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:37 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:37 INFO - 'USER': 'cltbld', 13:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:37 INFO - 'XPC_FLAGS': '0x0', 13:56:37 INFO - 'XPC_SERVICE_NAME': '0', 13:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:38 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 13:56:38 INFO - Cleaning up... 13:56:38 INFO - Return code: 0 13:56:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:56:38 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')]} 13:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 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')]} 13:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:38 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:38 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 13:56:38 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 13:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:38 INFO - 'HOME': '/Users/cltbld', 13:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:38 INFO - 'LOGNAME': 'cltbld', 13:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:38 INFO - 'MOZ_NO_REMOTE': '1', 13:56:38 INFO - 'NO_EM_RESTART': '1', 13:56:38 INFO - 'PAGER': '/bin/cat', 13:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:38 INFO - 'PWD': '/builds/slave/test', 13:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:38 INFO - 'SHELL': '/bin/bash', 13:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:38 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:38 INFO - 'USER': 'cltbld', 13:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:38 INFO - 'XPC_FLAGS': '0x0', 13:56:38 INFO - 'XPC_SERVICE_NAME': '0', 13:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:38 INFO - Downloading/unpacking psutil>=3.1.1 13:56:38 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 13:56:38 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 13:56:38 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 13:56:38 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 13:56:38 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 13:56:38 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 13:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:41 INFO - Installing collected packages: psutil 13:56:41 INFO - Running setup.py install for psutil 13:56:41 INFO - building 'psutil._psutil_osx' extension 13:56:41 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 13:56:42 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 13:56:42 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 13:56:42 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 13:56:42 INFO - building 'psutil._psutil_posix' extension 13:56:42 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 13:56:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:56:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:56:42 INFO - ^ 13:56:42 INFO - 1 warning generated. 13:56:42 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 13:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:42 INFO - Successfully installed psutil 13:56:42 INFO - Cleaning up... 13:56:43 INFO - Return code: 0 13:56:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:56:43 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')]} 13:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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')]} 13:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:43 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 13:56:43 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 13:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:43 INFO - 'HOME': '/Users/cltbld', 13:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:43 INFO - 'LOGNAME': 'cltbld', 13:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:43 INFO - 'MOZ_NO_REMOTE': '1', 13:56:43 INFO - 'NO_EM_RESTART': '1', 13:56:43 INFO - 'PAGER': '/bin/cat', 13:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:43 INFO - 'PWD': '/builds/slave/test', 13:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:43 INFO - 'SHELL': '/bin/bash', 13:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:43 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:43 INFO - 'USER': 'cltbld', 13:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:43 INFO - 'XPC_FLAGS': '0x0', 13:56:43 INFO - 'XPC_SERVICE_NAME': '0', 13:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:56:46 INFO - Installing collected packages: mozsystemmonitor 13:56:46 INFO - Running setup.py install for mozsystemmonitor 13:56:46 INFO - Successfully installed mozsystemmonitor 13:56:46 INFO - Cleaning up... 13:56:46 INFO - Return code: 0 13:56:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:56:46 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')]} 13:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:46 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')]} 13:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:46 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:46 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 13:56:46 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 13:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:46 INFO - 'HOME': '/Users/cltbld', 13:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:46 INFO - 'LOGNAME': 'cltbld', 13:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:46 INFO - 'MOZ_NO_REMOTE': '1', 13:56:46 INFO - 'NO_EM_RESTART': '1', 13:56:46 INFO - 'PAGER': '/bin/cat', 13:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:46 INFO - 'PWD': '/builds/slave/test', 13:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:46 INFO - 'SHELL': '/bin/bash', 13:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:46 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:46 INFO - 'USER': 'cltbld', 13:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:46 INFO - 'XPC_FLAGS': '0x0', 13:56:46 INFO - 'XPC_SERVICE_NAME': '0', 13:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:49 INFO - warning: no files found matching '*.txt' 13:56:49 INFO - no previously-included directories found matching 'build' 13:56:49 INFO - no previously-included directories found matching 'dist' 13:56:49 INFO - no previously-included directories found matching '.git*' 13:56:49 INFO - Installing collected packages: jsonschema, functools32 13:56:49 INFO - Running setup.py install for functools32 13:56:49 INFO - warning: no files found matching '*.txt' 13:56:49 INFO - no previously-included directories found matching 'build' 13:56:49 INFO - no previously-included directories found matching 'dist' 13:56:49 INFO - no previously-included directories found matching '.git*' 13:56:49 INFO - Successfully installed jsonschema functools32 13:56:49 INFO - Cleaning up... 13:56:50 INFO - Return code: 0 13:56:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:56:50 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')]} 13:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 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')]} 13:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:50 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 13:56:50 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 13:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:50 INFO - 'HOME': '/Users/cltbld', 13:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:50 INFO - 'LOGNAME': 'cltbld', 13:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:50 INFO - 'MOZ_NO_REMOTE': '1', 13:56:50 INFO - 'NO_EM_RESTART': '1', 13:56:50 INFO - 'PAGER': '/bin/cat', 13:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:50 INFO - 'PWD': '/builds/slave/test', 13:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:50 INFO - 'SHELL': '/bin/bash', 13:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:50 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:50 INFO - 'USER': 'cltbld', 13:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:50 INFO - 'XPC_FLAGS': '0x0', 13:56:50 INFO - 'XPC_SERVICE_NAME': '0', 13:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:56:50 INFO - Cleaning up... 13:56:50 INFO - Return code: 0 13:56:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:56:50 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')]} 13:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 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')]} 13:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:50 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:50 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 13:56:50 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 13:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:50 INFO - 'HOME': '/Users/cltbld', 13:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:50 INFO - 'LOGNAME': 'cltbld', 13:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:50 INFO - 'MOZ_NO_REMOTE': '1', 13:56:50 INFO - 'NO_EM_RESTART': '1', 13:56:50 INFO - 'PAGER': '/bin/cat', 13:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:50 INFO - 'PWD': '/builds/slave/test', 13:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:50 INFO - 'SHELL': '/bin/bash', 13:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:50 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:50 INFO - 'USER': 'cltbld', 13:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:50 INFO - 'XPC_FLAGS': '0x0', 13:56:50 INFO - 'XPC_SERVICE_NAME': '0', 13:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:50 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 13:56:50 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 13:56:50 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 13:56:50 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 13:56:50 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 13:56:50 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 13:56:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:56:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:56:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:54 INFO - Downloading docopt-0.6.1.tar.gz 13:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:56:54 INFO - Running setup.py install for blobuploader 13:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:56:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:56:54 INFO - Running setup.py install for requests 13:56:55 INFO - Running setup.py install for docopt 13:56:55 INFO - Successfully installed blobuploader requests docopt 13:56:55 INFO - Cleaning up... 13:56:55 INFO - Return code: 0 13:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:55 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')]} 13:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:55 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')]} 13:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:55 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:56:55 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 13:56:55 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 13:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:55 INFO - 'HOME': '/Users/cltbld', 13:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:55 INFO - 'LOGNAME': 'cltbld', 13:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:55 INFO - 'MOZ_NO_REMOTE': '1', 13:56:55 INFO - 'NO_EM_RESTART': '1', 13:56:55 INFO - 'PAGER': '/bin/cat', 13:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:55 INFO - 'PWD': '/builds/slave/test', 13:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:55 INFO - 'SHELL': '/bin/bash', 13:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:56:55 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:55 INFO - 'USER': 'cltbld', 13:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:55 INFO - 'XPC_FLAGS': '0x0', 13:56:55 INFO - 'XPC_SERVICE_NAME': '0', 13:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-KjaJM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_KB2_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4DRGlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-zi4_CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_2AXbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-etbYmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hvf5Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-o_g24M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-IDRgri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-7uqNWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-RBOA8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-a6dt0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-6eFVp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-UhAXGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-s5Hn4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-YYoT4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:57 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-RaYGm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:56:57 INFO - Running setup.py install for manifestparser 13:56:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:56:57 INFO - Running setup.py install for mozcrash 13:56:58 INFO - Running setup.py install for mozdebug 13:56:58 INFO - Running setup.py install for mozdevice 13:56:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Running setup.py install for mozfile 13:56:58 INFO - Running setup.py install for mozhttpd 13:56:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Running setup.py install for mozinfo 13:56:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Running setup.py install for mozInstall 13:56:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:56:58 INFO - Running setup.py install for mozleak 13:56:59 INFO - Running setup.py install for mozlog 13:56:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Running setup.py install for moznetwork 13:56:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Running setup.py install for mozprocess 13:56:59 INFO - Running setup.py install for mozprofile 13:56:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Running setup.py install for mozrunner 13:56:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:56:59 INFO - Running setup.py install for mozscreenshot 13:57:00 INFO - Running setup.py install for moztest 13:57:00 INFO - Running setup.py install for mozversion 13:57:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:00 INFO - Cleaning up... 13:57:00 INFO - Return code: 0 13:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:01 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:57:01 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 13:57:01 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 13:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:01 INFO - 'HOME': '/Users/cltbld', 13:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:01 INFO - 'LOGNAME': 'cltbld', 13:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:01 INFO - 'MOZ_NO_REMOTE': '1', 13:57:01 INFO - 'NO_EM_RESTART': '1', 13:57:01 INFO - 'PAGER': '/bin/cat', 13:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:01 INFO - 'PWD': '/builds/slave/test', 13:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:01 INFO - 'SHELL': '/bin/bash', 13:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:57:01 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:01 INFO - 'USER': 'cltbld', 13:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:01 INFO - 'XPC_FLAGS': '0x0', 13:57:01 INFO - 'XPC_SERVICE_NAME': '0', 13:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Vm8qnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:01 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)) 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-tEWtNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:01 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)) 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ewDaOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:01 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)) 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-JTjdr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:01 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)) 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-W74d8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:01 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)) 13:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Ht4r9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_da1cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-7y0lTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-eLjuVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-VjzQH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lNiLEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-uhcptm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Euy2ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-cnQSZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:02 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)) 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:02 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-H0ejvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:03 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)) 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:03 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-j84zgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:03 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)) 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:03 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-yExPEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:03 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)) 13:57:03 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)) 13:57:03 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)) 13:57:03 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)) 13:57:03 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)) 13:57:03 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)) 13:57:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:06 INFO - Downloading blessings-1.6.tar.gz 13:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:06 INFO - Installing collected packages: blessings 13:57:06 INFO - Running setup.py install for blessings 13:57:06 INFO - Successfully installed blessings 13:57:06 INFO - Cleaning up... 13:57:06 INFO - Return code: 0 13:57:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:06 INFO - Reading from file tmpfile_stdout 13:57:06 INFO - Current package versions: 13:57:06 INFO - blessings == 1.6 13:57:06 INFO - blobuploader == 1.2.4 13:57:06 INFO - docopt == 0.6.1 13:57:06 INFO - functools32 == 3.2.3-2 13:57:06 INFO - jsonschema == 2.5.1 13:57:06 INFO - manifestparser == 1.1 13:57:06 INFO - mozInstall == 1.12 13:57:06 INFO - mozcrash == 1.0 13:57:06 INFO - mozdebug == 0.1 13:57:06 INFO - mozdevice == 0.49 13:57:06 INFO - mozfile == 1.2 13:57:06 INFO - mozhttpd == 0.7 13:57:06 INFO - mozinfo == 0.9 13:57:06 INFO - mozleak == 0.1 13:57:06 INFO - mozlog == 3.4 13:57:06 INFO - moznetwork == 0.27 13:57:06 INFO - mozprocess == 0.24 13:57:06 INFO - mozprofile == 0.28 13:57:06 INFO - mozrunner == 6.13 13:57:06 INFO - mozscreenshot == 0.1 13:57:06 INFO - mozsystemmonitor == 0.3 13:57:06 INFO - moztest == 0.8 13:57:06 INFO - mozversion == 1.4 13:57:06 INFO - psutil == 3.1.1 13:57:06 INFO - requests == 1.2.3 13:57:06 INFO - wsgiref == 0.1.2 13:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:06 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')]} 13:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:06 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')]} 13:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:06 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:57:06 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 13:57:06 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 13:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:06 INFO - 'HOME': '/Users/cltbld', 13:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:06 INFO - 'LOGNAME': 'cltbld', 13:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:06 INFO - 'MOZ_NO_REMOTE': '1', 13:57:06 INFO - 'NO_EM_RESTART': '1', 13:57:06 INFO - 'PAGER': '/bin/cat', 13:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:06 INFO - 'PWD': '/builds/slave/test', 13:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:06 INFO - 'SHELL': '/bin/bash', 13:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:57:06 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:06 INFO - 'USER': 'cltbld', 13:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:06 INFO - 'XPC_FLAGS': '0x0', 13:57:06 INFO - 'XPC_SERVICE_NAME': '0', 13:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 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)) 13:57:07 INFO - Cleaning up... 13:57:07 INFO - Return code: 0 13:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:07 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 0x109ae4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ae7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe481c675d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, '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.PZB0D58YUD/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.3SshVhfHLX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:57:07 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 13:57:07 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 13:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:07 INFO - 'HOME': '/Users/cltbld', 13:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:07 INFO - 'LOGNAME': 'cltbld', 13:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:07 INFO - 'MOZ_NO_REMOTE': '1', 13:57:07 INFO - 'NO_EM_RESTART': '1', 13:57:07 INFO - 'PAGER': '/bin/cat', 13:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:07 INFO - 'PWD': '/builds/slave/test', 13:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:07 INFO - 'SHELL': '/bin/bash', 13:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:57:07 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:07 INFO - 'USER': 'cltbld', 13:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:07 INFO - 'XPC_FLAGS': '0x0', 13:57:07 INFO - 'XPC_SERVICE_NAME': '0', 13:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:07 INFO - Cleaning up... 13:57:07 INFO - Return code: 0 13:57:07 INFO - Running post-action listener: _resource_record_post_action 13:57:07 INFO - Running post-action listener: _start_resource_monitoring 13:57:07 INFO - Starting resource monitoring. 13:57:07 INFO - [mozharness: 2017-04-06 20:57:07.438736Z] Finished create-virtualenv step (success) 13:57:07 INFO - [mozharness: 2017-04-06 20:57:07.439732Z] Running install step. 13:57:07 INFO - Running pre-action listener: _resource_record_pre_action 13:57:07 INFO - Running main action method: install 13:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:07 INFO - Reading from file tmpfile_stdout 13:57:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:07 INFO - Reading from file tmpfile_stdout 13:57:07 INFO - Output received: 13:57:07 INFO - Usage: mozinstall [options] installer 13:57:07 INFO - Options: 13:57:07 INFO - -h, --help show this help message and exit 13:57:07 INFO - -d DEST, --destination=DEST 13:57:07 INFO - Directory to install application into. [default: 13:57:07 INFO - "/builds/slave/test"] 13:57:07 INFO - --app=APP Application being installed. [default: firefox] 13:57:07 INFO - mkdir: /builds/slave/test/build/application 13:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:57:22 INFO - Reading from file tmpfile_stdout 13:57:22 INFO - Output received: 13:57:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:57:22 INFO - Running post-action listener: _resource_record_post_action 13:57:22 INFO - [mozharness: 2017-04-06 20:57:22.686476Z] Finished install step (success) 13:57:22 INFO - [mozharness: 2017-04-06 20:57:22.686609Z] Running run-tests step. 13:57:22 INFO - Running pre-action listener: _resource_record_pre_action 13:57:22 INFO - Running main action method: run_tests 13:57:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:57:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:57:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:57:22 INFO - 2017-04-06 13:57:22.700 screenresolution[1631:7333] starting screenresolution argv=screenresolution get 13:57:22 INFO - 2017-04-06 13:57:22.703 screenresolution[1631:7333] Display 0: 1600x1200x32@60 13:57:22 INFO - 2017-04-06 13:57:22.709 screenresolution[1632:7335] starting screenresolution argv=screenresolution list 13:57:22 INFO - Available Modes on Display 0 13:57:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:57:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:57:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:57:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:57:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:57:22 INFO - Intel Iris: 13:57:22 INFO - Chipset Model: Intel Iris 13:57:22 INFO - Type: GPU 13:57:22 INFO - Bus: Built-In 13:57:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:57:22 INFO - Vendor: Intel (0x8086) 13:57:22 INFO - Device ID: 0x0a2e 13:57:22 INFO - Revision ID: 0x0009 13:57:22 INFO - Displays: 13:57:22 INFO - Display: 13:57:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:57:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:57:22 INFO - Display Serial Number: 1600x1200 60 13:57:22 INFO - Main Display: Yes 13:57:22 INFO - Mirror: Off 13:57:22 INFO - Online: Yes 13:57:22 INFO - Rotation: Supported 13:57:22 INFO - Return code: 0 13:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:57:22 INFO - Python 2.7.3 13:57:22 INFO - Return code: 0 13:57:22 INFO - grabbing minidump binary from tooltool 13:57:22 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')]} 13:57:22 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 0x1098c2d30>, '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 0x1097e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098b7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:57:22 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 13:57:22 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 13:57:22 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 13:57:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:23 INFO - Return code: 0 13:57:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:57:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:57:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:57:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:57:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 13:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 13:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PZB0D58YUD/Render', 13:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:23 INFO - 'HOME': '/Users/cltbld', 13:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:23 INFO - 'LOGNAME': 'cltbld', 13:57:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:57:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:23 INFO - 'MOZ_NO_REMOTE': '1', 13:57:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:57:23 INFO - 'NO_EM_RESTART': '1', 13:57:23 INFO - 'PAGER': '/bin/cat', 13:57:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:23 INFO - 'PWD': '/builds/slave/test', 13:57:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:23 INFO - 'SHELL': '/bin/bash', 13:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3SshVhfHLX/Listeners', 13:57:23 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:23 INFO - 'USER': 'cltbld', 13:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:23 INFO - 'XPC_FLAGS': '0x0', 13:57:23 INFO - 'XPC_SERVICE_NAME': '0', 13:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 13:57:23 INFO - mozversion application_buildid: 20170406123529 13:57:23 INFO - mozversion application_changeset: fc66dce2192b788956c6b5c1bfaf090f1c067af1 13:57:23 INFO - mozversion application_display_name: Firefox 13:57:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:23 INFO - mozversion application_name: Firefox 13:57:23 INFO - mozversion application_remotingname: firefox 13:57:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:23 INFO - mozversion application_vendor: Mozilla 13:57:23 INFO - mozversion application_version: 53.0 13:57:23 INFO - mozversion platform_buildid: 20170406123529 13:57:23 INFO - mozversion platform_changeset: fc66dce2192b788956c6b5c1bfaf090f1c067af1 13:57:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:57:23 INFO - mozversion platform_version: 53.0 13:57:23 INFO - using testdate: 1491512243 13:57:23 INFO - actual date: 1491512243 13:57:23 INFO - starting webserver on 'localhost:49240' 13:57:23 INFO - SUITE-START | Running 2 tests 13:57:23 INFO - TEST-START | dromaeo_css 13:57:23 INFO - operating with platform_type : mac_ 13:57:23 INFO - Initialising browser for dromaeo_css test... 13:57:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpXyaYOw/profile http://localhost:49240/getInfo.html) 13:57:26 INFO - PROCESS | 1642 | 2017-04-06 13:57:26.242 plugin-container[1645:7509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x934b, name = 'com.apple.tsm.portname' 13:57:26 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:26 INFO - PROCESS | 1642 | 2017-04-06 13:57:26.242 plugin-container[1645:7509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1b, name = 'com.apple.CFPasteboardClient' 13:57:26 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:26 INFO - PROCESS | 1642 | 2017-04-06 13:57:26.242 plugin-container[1645:7509] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:57:26 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 13:57:26 INFO - PROCESS | 1642 | colorDepth:24 13:57:26 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 13:57:26 INFO - PROCESS | 1642 | __metrics 13:57:26 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 13:57:27 INFO - TEST-INFO | 1642: exit 0 13:57:27 INFO - Browser initialized. 13:57:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:57:27 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpXyaYOw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:29 INFO - PROCESS | 1646 | 2017-04-06 13:57:29.386 plugin-container[1647:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 13:57:29 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:29 INFO - PROCESS | 1646 | 2017-04-06 13:57:29.387 plugin-container[1647:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 13:57:29 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:29 INFO - PROCESS | 1646 | 2017-04-06 13:57:29.387 plugin-container[1647:7637] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:57:39 INFO - PROCESS | 1646 | RSS: Main: 173387776 13:57:39 INFO - PROCESS | 1646 | 14:00:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:00:42 INFO - PROCESS | 1646 | RSS: Main: 190906368 14:00:42 INFO - PROCESS | 1646 | 14:03:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:03:45 INFO - PROCESS | 1646 | RSS: Main: 202924032 14:03:45 INFO - PROCESS | 1646 | 14:06:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:06:47 INFO - PROCESS | 1646 | RSS: Main: 204730368 14:06:47 INFO - PROCESS | 1646 | 14:09:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:09:50 INFO - PROCESS | 1646 | RSS: Main: 208211968 14:09:50 INFO - PROCESS | 1646 | 14:12:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:12:54 INFO - PROCESS | 1646 | RSS: Main: 209469440 14:12:54 INFO - PROCESS | 1646 | 14:15:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:15:57 INFO - PROCESS | 1646 | RSS: Main: 209932288 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | __start_tp_report 14:15:57 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:15:57 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:15:57 INFO - PROCESS | 1646 | |i|pagename|runs| 14:15:57 INFO - PROCESS | 1646 | |0;dojo.html;3475.2701932594155;3478.513008178855;3493.8253087345624;3523.154442933696;3532.6114127445976;5700.230468886699;5700.857478563038;5726.971365143168;5756.712164391779;5771.624844385117;5781.4507621775965;5864.354920958691;5883.646981181132;5889.057750759879;5945.762169513214;3729.627037296262;4124.845043387856;5230.633855630098;5258.316418865542;5295.443978382272;5225.425203227642;5237.607179461536;5333.653312534692;5354.491323324278;5374.758135883894;5056.393232812049;5104.953484535661;5158.993996170748;5278.841634750964;5286.3127793387;5136.486351364871;5194.142966410538;5236.162214045735;5241.659292146036;5272.499112584298;5116.155834287338;5122.154844450662;5127.154019586764;5162.948370516322;5189.662671926313;5538.335399752015;5624.437556244384;5689.175069614924;5691.857703557403;5772.480476757112;6209.72056257465;6213.254409470847;6249;6251.874962500725;6281.59169653971;6255.12428260044;6255.468285195764;6267.843303917393;6271.937280627181;6288.496920246369;5966.403359663999;6004.4595986361;6010.398960103998;6019.307779605401;6034.487068599218;6198.876022479525;6217.2699724930335;6234.906476402857;6237.532185086136;6283.905741413882;6198.6280823150755;6238.282597501346;6272.18461599989;6275.905861412082;6284.465820405317;6235.563510554218;6242.937570624326;6247.5939063960695;6248.75004999804;6256.468200202943;6116.579253789288;6173.382661733791;6175.536834737323;6175.938240617626;6292.653904035322;6176.382361763787;6231.875362492725;6232.750689972441;6250.562460627712;6257.7184026718905;5026.070177017264;5054.69671819692;5069.6451248413;5070.771815268322;5071;4398.516163222043;4442.178197033559;4515.571020753023;4527.411436513232;4550.47669518003;5264.578833693296;6046.606970546901;6106.72519736613;6147.231596050494;6151.8926593213655;4626.074785043005;4927.679700819435;5444.346678398539;5997.250343707036;6167.84580385494;5948.553858460633;6009.06859436788;6060.666663333471;6067.24159480065;6142.170806941095;5489.34127904646;5539.390667026624;5541.058020136506;5542.806001789999;5568.3318001839225;6481.805545833632;6485.092087107903;6504.284528701839;6533.248676402274;6555.6066636002;6117.248930028793;6230.252369715663;6236.719347629277;6244.000959846403;6258.3741625838875;6370.6814659267775;6418.4865210783955;6441.194850643669;6521.380468855451;6548.246951600627;6262.342454042442;6263.561550691408;6269.780557680459;6276.623402595859;6286.27707813589;6117.357677443804;6245.219347581552;6257.561970662192;6264.498840092872;6273.654948977667;5325.80169461868;6027.547933904887;6127.20346354971;6147.954847675996;6207.006878899354;6204.069389591597;6240.500759939285;6252.280987686474;6256.280527739368;6262.185915831095;5519.917201241904;5996.340402555628;6076.392360764065;6133.601315914451;6174.228221472316;6099.115628233792;6118.938810612015;6152.200213972334;6160.476359509492;6231.875362492634;4931.432885218246;4956.801727930842;5018.473060328759;5630.8029218977135;5896.351401345934 14:15:57 INFO - PROCESS | 1646 | |1;ext.html;468.3115819744976;506.5719467050341;516.4654582507105;533.8069414857794;545.9890802183959;32979;36960;40078.19843603126;42805.14389712204;44634;44202.33696494555;44678.32982505265;44713.77643111788;44730.776346118226;44847;9002.549872506348;9612.423254604728;9830.26273029522;9866.112049915506;9871.309008369417;9023.18791308782;11796.528138874435;11922.403879805976;12097.879021209807;12163.39183040849;12118.091143164298;12119.091068169879;12168.2699038058;12181.903628673417;12198.451069701885;11890.048796096291;11890.94054529726;11974.940125299361;11988.400579971054;11989.820152697717;11901.583444579484;11978.460969256404;12000.339981301026;12009;12012.279263244232;42181.57818421838;42202.57797422017;42363.36454953178;42412.363814542805;42475;4022.9195416091807;4065.4308396824467;4089.9795501022304;4118.238125946709;4173.895652608679;26284.474310513873;28368.290792730142;28855.42289154226;30116.698833011607;30629.081127565987;3275.983620081908;3347.6317605063423;3370.69663730263;3450.993694628463;3533.469979503069;415784;446911;488028.99999999645;491510;494873;61982;62276.37723622796;62492;62515;62670;62862;64474;64603.67698161573;64667.67666161639;64784;16894;17458.127093645267;17485;17527.29890804379;17577.20902559388;12469.438875250635;12707.872921270853;13371.130876492996;13394.062415630813;13582.252976086213;15586.844131558539;16048.598785030468;16090;16111.516654500383;16357.918210408872;7691.384689224848;7712.807179820549;7719.922800772033;7727.536347819148;7738.148803631596;760.7755712064954;773.072313224122;807.8142027333746;943.9710715320197;955.8136163448061;30216.09351719452;31067.223319417197;31141.8442907784;31394.529082063786;31765.20586985344;869.3219288954625;1014.9035841595037;1109.3399427340719;1148.311013391975;1235.765204611121;15935.920320398323;16219.594510137105;16335.26491307894;16359.427420040241;16628.3348666052;586675;688872;697013.029869705;699494;897811.5109424411;55918.440815592134;56084.71957640268;56235;56346;56512.58718531988;1438.6619144501035;1464.6191990082443;1484.0798704803092;1495.386891374553;1499.3702644889172;21982.560348793253;28720;29356;29706.851465742533;29852.70147298499;46299.768501157276;46837.76581117073;46838.76580617075;46849.828754281414;46891.531084688715;534057;535056;536862;537023;537960;19274.7108793371;21813.890930545247;25213;25894.482110358065;25998.610020849323;38958.61041389663;43091.7845410771;43945;44935.876603085184;45016.54983450124;30100.84949575238;30646.84676576603;31294.68705312918;31695;31764;30598.388032239676;30852.69147308588;31238.375232495677;31499;31724.206894827814;35754.463683044254;36358;36684.81657591802;36759.448608271436;36775;30040.549391758705;30599.011064280752;31441.8427907859;31557.684423156392;31826.681733182373;23238.3028509145;24364.26907192787;24598;24773.50452990894;24869 14:15:57 INFO - PROCESS | 1646 | |2;jquery.html;377.7638975640225;400.5353789604058;404.3429427180831;410.5709533537453;433.5729306632966;20622.278220262277;21284.680729789045;21476.24833130841;21893.67159492609;22017.449563760914;20734.170633174654;21238.619489733155;21309.57380852386;22506.77493225067;22956.88521557394;5932.733027013784;6103.908441373383;6214.036824292242;6214.409631085062;6235.469985051276;5261.210818377255;5859.296884373881;5997.850053748648;6061.12113743507;6107;5996.970015149918;6058.212432383784;6058.39416058395;6061.393860613925;6062.727177277033;5762.683052432115;5920.999999999978;5983.431574000463;5986.2517185351835;6018.15745795589;5266.447023062561;5294.020606187829;5297.364316282033;5308.416074231832;5312.495312945264;25330.860111295035;25926.611100833503;26443.206703798918;27224.59163112555;27438.17685469439;2432.5378178146098;2995;3020.969790302113;3042.1481985044225;3053.40458610571;10449.26855120142;10587.57649694019;10607.939206079407;10810.243282970117;10926.617568385069;1820.708686610136;1881.7741870975572;1951.414575627306;1974.555724961872;1980.1188471130354;108721;109084;127795;139685.3015734925;148619;11887.88112118885;11937.343446110548;12301.077419193418;12309.56916507918;12553.56062537825;16380.508584742476;16405.507834764976;16415.83584164167;16426.83573164277;16458;9100.681476148304;9298.581563829644;9318;9334.439933604006;9357.111074447917;9067.319951003701;9102.544872756336;9124.81750364989;9301.953490232505;9306.86039709405;4486.788567086868;4910.361652985089;4922.237053256751;4989.850304490871;5091.0581542414775;1666.4584010196734;1922.846172306212;2042.3566576528347;2042.4681488883336;2074.6058248932654;382.9597892221332;393.37060702875743;404.5873209326529;1041.677070120942;1054.9736256593494;11942.984846287989;11955.043596512258;11989.520419183134;12225.266484010988;12226.266424014588;432.7749570223466;436.947566292047;440.1461165339232;440.4516377110518;449.12869034073793;6111.786087487006;6119.938800612026;6187.876242475125;6312.621242725451;6315.147455093595;776219;776898;786461;814950;824410;128039;130460.3476982609;161542.19228904016;163138;163245.3675463254;460.53946053946055;468.9413823272091;469.32885973058853;470.1513767649357;470.9340692303012;10682.62610808618;10851.620193293196;10950.57642506501;11030.779384412428;11359.602413915472;47041.823954401414;57571.71214143903;63082;63269.36730632819;64487.67756161189;93250;94052.58921116326;95395.52302238444;97629.023709762;97702;10640.361578305326;13366.465341386236;13426.261555614145;13655.931720341334;13847.653808654864;13957.3719182635;14111.941604379917;14282.928585357007;14337.56987290383;14532.564023078901;11841.644750657493;11851;12024.038076953648;12116.697082573006;12196.51213951432;7847.293743563107;10438.739031524272;11110.611128610783;11304.43477826089;11895.821562676394;11692.649220523397;11854.585089521825;12151.75696486083;12181.756364872475;12267.57063502773;11360.772784544428;13354.799678004643;13378.264195469343;13688.863111368759;13738.900887928741;11910.166288359731;12068.396580171131;12115.030797536;12181;12189.634310970685 14:15:57 INFO - PROCESS | 1646 | |3;mootools.html;1335.879770820626;1394.6443656867505;1407.2682205253261;1416.475903915551;1425.8003879456876;7783.571903545303;8023.277904988565;8247.546384948826;8533.871991920118;8618.267447266982;8258.256756891878;8519.701810436636;8542.871856922151;8615.698450554231;8625.784355391119;2205.900734466953;2246.8202543796538;2252.6621006849023;2255.909763609454;2263.185253308816;2030.725852009982;2102.810747032767;2225.2434172381386;2268.886555672218;2272.1593010586107;2149.215536329244;2218.73375194976;2226.4545186429345;2226.866388016724;2231.520223152022;2220.2784095169054;2223.8776867272295;2244.1920908472935;2244.9775502244934;2256.6050941085327;2238;2238.485148415857;2255.481239314967;2262.4117729390314;2273.8521996070367;8537.871931921027;8580;8585.31317494599;8666.133386661284;8669.393142479967;5092.745362731848;5264.236685680593;5273.2617433559335;5281.023010742986;5288.762005709752;3493.179102910814;3507.473878918157;3518.8064656443885;3541.5750109986966;3622.8913132606062;1274.9298788566625;1275.0946827752307;1302;1324.2915040453408;1328.3491089366237;10979.725506862393;11034.006939375495;11045.613403530839;11060.778784424267;11071.72320691981;4575.656825738083;4652.9530855557905;4660.440747110369;4711.0342379812055;4746.264329029006;9661.420314781135;9694.175995040501;9699.660511882192;9704.369216000938;9747.3664211826;5188.558972487305;5283.471652834763;5290.994711004897;5302.125149350314;5306.124489459273;4684;4785.282207668808;4808.663393562417;4826.0347930414055;4834.226523756252;3456.343294773985;4002.519697636302;4046.2109888571445;4126.793660316972;4139.151473947833;1206.8913797758244;1239.2378687107364;1276.8276282701902;1299.740051989606;1306.6014865465934;639.8560323927172;675.4157653629575;689.5035574386434;860.5869182792295;892.3173772064376;5477.7261136943;5786.623869448473;5833.562482813721;5913.881722365614;6129;856.7515420528101;1033.6382266206767;1037.0821822686826;1042.8435734639713;1057.3814318623538;3912.921741565153;4080.959190408117;4081.8774836920084;4155.439015732837;4191.308434108399;9843.261755368232;9866.210703143732;9941.105300522988;10091.545880435398;10226.897731022595;9850.408975461496;10038.598456061822;10067.848982265272;10069.79860402788;10093.192544596415;6477.611343319321;7648.694052237959;7994.5602991836;7999.520028798291;8086.474379165453;5807.941920580909;5810.680412577349;5896.70516474166;5985.341612422543;6016.639001659914;8987.55062246872;9159.267258619428;9423.293253005915;9439.433633981984;9486.762830929281;9080.909190908007;9252;9368.203702685076;9457.29070319715;9470.57382417779;8016.9198308016175;8129.512229266263;8132.715354962548;8135.593220339078;8180.304674102768;7614.086309642878;7649.235076492307;7666.386689064973;7668.731594394169;7672.38620910337;6913.409915719312;7023.894641580278;7059.752908648173;7246.565206087652;7273.781786546412;6964.408025317702;7026.613536255555;7036.050133231948;7054.717811287696;7070.787876363512;6527.445167160845;6542.34576542342;6568.408843204134;6600.80197594073;6656.167979002625;4114.19773144234;4564.863054108382;4601.171789077865;4654.790534426027;5125.513076257749;4905.877353066202;5189.091908915849;5191.766370513412;5256.658317209369;5304.9469505306 14:15:57 INFO - PROCESS | 1646 | |4;prototype.html;365.16741828630717;371.7323527060517;379.9664911440883;380.224342341623;385.44688372185914;4800.9197930465625;5275.657082289648;5391.757370918308;5598.3841777404505;5657.219649396264;4906.9263961040615;4929.964707411448;5099.062356304599;5267.683938963655;5445.591580631449;3553.5658074219114;4013.739106958053;4251.829926802924;4270.722403043807;4278.144371125772;3677.3196958562617;4006.777932730516;4102.220578090169;4166.333386658135;4278.037441575636;3551.0412188709033;3972.2055588882195;4126.29852925002;4155.501339839208;4172.603602657758;4122.361034039729;4131.834726610932;4135.503739551273;4136.544980052192;4167.291560434734;3594.137407022322;3597.244578638489;3613.295407395559;3619.529461170031;3630.4735813306925;5063.265826455144;5267.947320526784;5295.258663787073;5345.4654534546235;5347.358317001946;4204.2432362174795;4738.2892566115015;4777.938752060755;4780;4781.402324709411;4542.318652202163;5714.457126572969;5748.252727145445;5807.067430947344;5821.446962538595;3318.286568387784;3454.7063499602564;3485.20511936353;3688.963110368889;3943.5859234780223;6052.818415447544;6109.853425485834;6114.838180745644;6116.938830611682;6120.479759220471;3353.312570923004;3509.6487852176583;3552.378333791576;3838.405047217686;3985.4619626350072;3385.3906296866307;3455.464403017486;3896.2402331545645;4029.9395509067385;4055.7160998729805;4081.551029386765;4140.068484591003;4756.476787553366;4760.000399915987;4799.760011999386;5832.571020100017;5861.384554621789;5894.351621321651;5903.557233207526;5903.822885313448;1061.532925512772;1175.482787573465;1272.2303006680825;1314.6319030671427;1327.197045787304;840.684743221292;860.2257967829004;877.7103555826562;898.5597057441937;912.9041450647719;5264.6314757966575;5296.735163241822;5309.787608495617;5337.866553336197;5366.812161574326;5458.263134476874;5691.345495268014;5745.9425405745405;5768.625039372511;5772.478787939353;5068.898622027539;5343.259718197278;5344.4922732340365;5346.994876921154;5587.519307383546;2498.5127900059315;2793.2877116335203;2997.610310659644;3014.050574069161;3028.3798167980467;5032.446430892599;5512.724363781795;5961.972929204091;6008.888355654218;6128.434316434285;4940.4640165213905;5141.280220769096;5687.7156142192725;5852.385499522574;5875.735591898375;4976.825811096594;5442.265294185234;5585.860353491195;5640.435956404327;6127.6936153193055;5017.974910125426;5264.789098507288;5656.569693094675;5747.339056008613;5810.912836307543;5191.8182863599595;5919.24128178601;5947.375525569926;5988.37122102173;5988.970055149871;5362.436944120811;6232.844178895564;6319.8104056878365;6325.936740632535;6331.5251356147555;3492.305798350363;3575.871112776321;3931.4667279760342;4017.598240176076;4018.4173294872667;4328.056921293425;5462.781488740565;5857.1300062967985;6020.51835853122;6064.332923378513;4300.903269666215;5488.368837583729;5577.386487486455;5846.41535846429;5870;4865.929495510982;5733.455321744427;5755.194272801895;5855.94144058554;5873.588848780544;5447.618666693294;5472.50747432733;5688.6916009317265;5760.827175184583;5813.82558523245;5853.414658534112;5853.94146058534;5868.063539032195;5872.647641141545;5886.146508756292;4220.599043090901;5205.843824685266;5550.833474995757;5746.333563266606;5764 14:15:57 INFO - PROCESS | 1646 | |5;yui.html;718.2243177368442;726.8873324634684;778.739122393998;863.568215892054;868.9739307820763;15163.848361516382;16491.010539367646;16500.58748531286;16519.999999999985;16532.75200871988;12595.181313214634;15115.470958516455;15147.848521514781;15196.696066078672;15203.087814731123;695.2630211975322;717.73802562065;869.5043825019757;872.1714371347214;873.9169778870997;852.4629483425433;874.5802015032788;882.563131250029;882.8543290357084;888.4979986307748;926.9119433653826;939.8872135343769;941.087145468894;941.4868896451451;943.8442656961593;909.3725329522641;939.1031564855547;939.4551160327028;939.7227817793768;940.191435365585;587.5064945445803;697.2330436519787;697.2400083908564;697.3375293471172;701.165612920628;15385.692286154213;15802.920985395114;16010.279537420844;16269.674606507804;16546.751798723028;14825.481108161162;15025.624359390993;15058.623534411618;15144.318505667272;15199.468018619295;10120;10609.363438193734;11636.418029517403;11930.761384772255;12425.37873106341;3381.526586277923;3561.893143205682;3789.4126410406157;3803.7527560708463;3868.226354729037;99537.5023124887;101731;101887;103003.45494817659;103886.48056759743;10157.39055656663;11587.478563464665;11669.708257293465;11672.241304315192;11713.707157320965;24129.276121716375;24281;24327.0269189234;24372.26883193507;24789;7865.292123708894;8139.104698483162;8237.670493180325;8262.091169971298;8310.584470776437;4403.405540252089;4465;4518.344839998182;4547.3179023146795;4568.497465278817;3648.890533284006;3758.8496460141837;3774.8490060397826;3940.842366305373;4142.79286035697;750.5871770526189;758.21146008152;761.1247065874178;777.7899967008989;781.5896654256447;564.6702016750494;566.6911533214408;573.6816067082809;580.2514755964843;598.9790357337472;10204;10460.69241344832;10930.457019472931;11144.60993865211;11253.831192532118;632.5319263744796;658.0885473618977;666.3003845961721;673.7581615035035;685.2873012067494;5015.699058056528;5250.868728281824;5278.291332579218;5288.762005709752;5321.255024296602;101767.49116254371;104593.47703261435;105857;106057;106696;93308;94946;95118.52440737752;96141;97380;80849.59575202086;81957.59021204975;82391;83889.74165387524;84536.15463845406;10063.345882517613;10115.49422528856;10167.44079075658;10190.745231369276;10207.54066067014;53400;54256.72871635616;54979.175312369545;55201.171982421096;55869.286650944494;64214.67892660507;64613;65209.36976575624;66065.66967165134;68407.31592684209;13751.243681597209;13856.792148117987;13984.510542130976;14486.348114335091;14743.483978060716;14288.499902503363;14403.567892963229;15066.472673456816;15626.765598516258;15737;12485.313307767796;14440.638984025483;14441.927790360982;14642.926785366431;14738.189399582698;13757.518486853312;14325.21211333345;14427.134371937298;14584.927075364556;14642.901782366152;11999.700007499883;13770.586882393543;14290.35693393779;14316.212608306643;14425;9302.581383837878;9562;9807.06832850878;9868.802623947624;10063.748406289902;9564.665236716959;10850.945745271223;11407.201495895208;11575.016123629586;11620.593279235187 14:15:57 INFO - PROCESS | 1646 | __end_tp_report 14:15:57 INFO - PROCESS | 1646 | __start_cc_report 14:15:57 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,366 14:15:57 INFO - PROCESS | 1646 | __end_cc_report 14:15:57 INFO - PROCESS | 1646 | __startTimestamp1491513357073__endTimestamp 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:15:57 INFO - PROCESS | 1646 | Number of tests: 6 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5752.44 Median:6060.67 stddev:680.73 (11.2%) stddev-sans-first:658.96 14:15:57 INFO - PROCESS | 1646 | Values: 3475.3 3478.5 3493.8 3523.2 3532.6 5700.2 5700.9 5727.0 5756.7 5771.6 5781.5 5864.4 5883.6 5889.1 5945.8 3729.6 4124.8 5230.6 5258.3 5295.4 5225.4 5237.6 5333.7 5354.5 5374.8 5056.4 5105.0 5159.0 5278.8 5286.3 5136.5 5194.1 5236.2 5241.7 5272.5 5116.2 5122.2 5127.2 5162.9 5189.7 5538.3 5624.4 5689.2 5691.9 5772.5 6209.7 6213.3 6249.0 6251.9 6281.6 6255.1 6255.5 6267.8 6271.9 6288.5 5966.4 6004.5 6010.4 6019.3 6034.5 6198.9 6217.3 6234.9 6237.5 6283.9 6198.6 6238.3 6272.2 6275.9 6284.5 6235.6 6242.9 6247.6 6248.8 6256.5 6116.6 6173.4 6175.5 6175.9 6292.7 6176.4 6231.9 6232.8 6250.6 6257.7 5026.1 5054.7 5069.6 5070.8 5071.0 4398.5 4442.2 4515.6 4527.4 4550.5 5264.6 6046.6 6106.7 6147.2 6151.9 4626.1 4927.7 5444.3 5997.3 6167.8 5948.6 6009.1 6060.7 6067.2 6142.2 5489.3 5539.4 5541.1 5542.8 5568.3 6481.8 6485.1 6504.3 6533.2 6555.6 6117.2 6230.3 6236.7 6244.0 6258.4 6370.7 6418.5 6441.2 6521.4 6548.2 6262.3 6263.6 6269.8 6276.6 6286.3 6117.4 6245.2 6257.6 6264.5 6273.7 5325.8 6027.5 6127.2 6148.0 6207.0 6204.1 6240.5 6252.3 6256.3 6262.2 5519.9 5996.3 6076.4 6133.6 6174.2 6099.1 6118.9 6152.2 6160.5 6231.9 4931.4 4956.8 5018.5 5630.8 5896.4 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:70046.38 Median:3359.16 stddev:156840.60 (4669.0%) stddev-sans-first:157193.58 14:15:57 INFO - PROCESS | 1646 | Values: 468.3 506.6 516.5 533.8 546.0 32979.0 36960.0 40078.2 42805.1 44634.0 44202.3 44678.3 44713.8 44730.8 44847.0 9002.5 9612.4 9830.3 9866.1 9871.3 9023.2 11796.5 11922.4 12097.9 12163.4 12118.1 12119.1 12168.3 12181.9 12198.5 11890.0 11890.9 11974.9 11988.4 11989.8 11901.6 11978.5 12000.3 12009.0 12012.3 42181.6 42202.6 42363.4 42412.4 42475.0 4022.9 4065.4 4090.0 4118.2 4173.9 26284.5 28368.3 28855.4 30116.7 30629.1 3276.0 3347.6 3370.7 3451.0 3533.5 415784.0 446911.0 488029.0 491510.0 494873.0 61982.0 62276.4 62492.0 62515.0 62670.0 62862.0 64474.0 64603.7 64667.7 64784.0 16894.0 17458.1 17485.0 17527.3 17577.2 12469.4 12707.9 13371.1 13394.1 13582.3 15586.8 16048.6 16090.0 16111.5 16357.9 7691.4 7712.8 7719.9 7727.5 7738.1 760.8 773.1 807.8 944.0 955.8 30216.1 31067.2 31141.8 31394.5 31765.2 869.3 1014.9 1109.3 1148.3 1235.8 15935.9 16219.6 16335.3 16359.4 16628.3 586675.0 688872.0 697013.0 699494.0 897811.5 55918.4 56084.7 56235.0 56346.0 56512.6 1438.7 1464.6 1484.1 1495.4 1499.4 21982.6 28720.0 29356.0 29706.9 29852.7 46299.8 46837.8 46838.8 46849.8 46891.5 534057.0 535056.0 536862.0 537023.0 537960.0 19274.7 21813.9 25213.0 25894.5 25998.6 38958.6 43091.8 43945.0 44935.9 45016.5 30100.8 30646.8 31294.7 31695.0 31764.0 30598.4 30852.7 31238.4 31499.0 31724.2 35754.5 36358.0 36684.8 36759.4 36775.0 30040.5 30599.0 31441.8 31557.7 31826.7 23238.3 24364.3 24598.0 24773.5 24869.0 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:42031.25 Median:12694.71 stddev:132191.87 (1041.3%) stddev-sans-first:132525.70 14:15:57 INFO - PROCESS | 1646 | Values: 377.8 400.5 404.3 410.6 433.6 20622.3 21284.7 21476.2 21893.7 22017.4 20734.2 21238.6 21309.6 22506.8 22956.9 5932.7 6103.9 6214.0 6214.4 6235.5 5261.2 5859.3 5997.9 6061.1 6107.0 5997.0 6058.2 6058.4 6061.4 6062.7 5762.7 5921.0 5983.4 5986.3 6018.2 5266.4 5294.0 5297.4 5308.4 5312.5 25330.9 25926.6 26443.2 27224.6 27438.2 2432.5 2995.0 3021.0 3042.1 3053.4 10449.3 10587.6 10607.9 10810.2 10926.6 1820.7 1881.8 1951.4 1974.6 1980.1 108721.0 109084.0 127795.0 139685.3 148619.0 11887.9 11937.3 12301.1 12309.6 12553.6 16380.5 16405.5 16415.8 16426.8 16458.0 9100.7 9298.6 9318.0 9334.4 9357.1 9067.3 9102.5 9124.8 9302.0 9306.9 4486.8 4910.4 4922.2 4989.9 5091.1 1666.5 1922.8 2042.4 2042.5 2074.6 383.0 393.4 404.6 1041.7 1055.0 11943.0 11955.0 11989.5 12225.3 12226.3 432.8 436.9 440.1 440.5 449.1 6111.8 6119.9 6187.9 6312.6 6315.1 776219.0 776898.0 786461.0 814950.0 824410.0 128039.0 130460.3 161542.2 163138.0 163245.4 460.5 468.9 469.3 470.2 470.9 10682.6 10851.6 10950.6 11030.8 11359.6 47041.8 57571.7 63082.0 63269.4 64487.7 93250.0 94052.6 95395.5 97629.0 97702.0 10640.4 13366.5 13426.3 13655.9 13847.7 13957.4 14111.9 14282.9 14337.6 14532.6 11841.6 11851.0 12024.0 12116.7 12196.5 7847.3 10438.7 11110.6 11304.4 11895.8 11692.6 11854.6 12151.8 12181.8 12267.6 11360.8 13354.8 13378.3 13688.9 13738.9 11910.2 12068.4 12115.0 12181.0 12189.6 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5521.63 Median:5260.45 stddev:3021.52 (57.4%) stddev-sans-first:3013.62 14:15:57 INFO - PROCESS | 1646 | Values: 1335.9 1394.6 1407.3 1416.5 1425.8 7783.6 8023.3 8247.5 8533.9 8618.3 8258.3 8519.7 8542.9 8615.7 8625.8 2205.9 2246.8 2252.7 2255.9 2263.2 2030.7 2102.8 2225.2 2268.9 2272.2 2149.2 2218.7 2226.5 2226.9 2231.5 2220.3 2223.9 2244.2 2245.0 2256.6 2238.0 2238.5 2255.5 2262.4 2273.9 8537.9 8580.0 8585.3 8666.1 8669.4 5092.7 5264.2 5273.3 5281.0 5288.8 3493.2 3507.5 3518.8 3541.6 3622.9 1274.9 1275.1 1302.0 1324.3 1328.3 10979.7 11034.0 11045.6 11060.8 11071.7 4575.7 4653.0 4660.4 4711.0 4746.3 9661.4 9694.2 9699.7 9704.4 9747.4 5188.6 5283.5 5291.0 5302.1 5306.1 4684.0 4785.3 4808.7 4826.0 4834.2 3456.3 4002.5 4046.2 4126.8 4139.2 1206.9 1239.2 1276.8 1299.7 1306.6 639.9 675.4 689.5 860.6 892.3 5477.7 5786.6 5833.6 5913.9 6129.0 856.8 1033.6 1037.1 1042.8 1057.4 3912.9 4081.0 4081.9 4155.4 4191.3 9843.3 9866.2 9941.1 10091.5 10226.9 9850.4 10038.6 10067.8 10069.8 10093.2 6477.6 7648.7 7994.6 7999.5 8086.5 5807.9 5810.7 5896.7 5985.3 6016.6 8987.6 9159.3 9423.3 9439.4 9486.8 9080.9 9252.0 9368.2 9457.3 9470.6 8016.9 8129.5 8132.7 8135.6 8180.3 7614.1 7649.2 7666.4 7668.7 7672.4 6913.4 7023.9 7059.8 7246.6 7273.8 6964.4 7026.6 7036.1 7054.7 7070.8 6527.4 6542.3 6568.4 6600.8 6656.2 4114.2 4564.9 4601.2 4654.8 5125.5 4905.9 5189.1 5191.8 5256.7 5304.9 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4620.86 Median:5267.82 stddev:1458.27 (27.7%) stddev-sans-first:1426.95 14:15:57 INFO - PROCESS | 1646 | Values: 365.2 371.7 380.0 380.2 385.4 4800.9 5275.7 5391.8 5598.4 5657.2 4906.9 4930.0 5099.1 5267.7 5445.6 3553.6 4013.7 4251.8 4270.7 4278.1 3677.3 4006.8 4102.2 4166.3 4278.0 3551.0 3972.2 4126.3 4155.5 4172.6 4122.4 4131.8 4135.5 4136.5 4167.3 3594.1 3597.2 3613.3 3619.5 3630.5 5063.3 5267.9 5295.3 5345.5 5347.4 4204.2 4738.3 4777.9 4780.0 4781.4 4542.3 5714.5 5748.3 5807.1 5821.4 3318.3 3454.7 3485.2 3689.0 3943.6 6052.8 6109.9 6114.8 6116.9 6120.5 3353.3 3509.6 3552.4 3838.4 3985.5 3385.4 3455.5 3896.2 4029.9 4055.7 4081.6 4140.1 4756.5 4760.0 4799.8 5832.6 5861.4 5894.4 5903.6 5903.8 1061.5 1175.5 1272.2 1314.6 1327.2 840.7 860.2 877.7 898.6 912.9 5264.6 5296.7 5309.8 5337.9 5366.8 5458.3 5691.3 5745.9 5768.6 5772.5 5068.9 5343.3 5344.5 5347.0 5587.5 2498.5 2793.3 2997.6 3014.1 3028.4 5032.4 5512.7 5962.0 6008.9 6128.4 4940.5 5141.3 5687.7 5852.4 5875.7 4976.8 5442.3 5585.9 5640.4 6127.7 5018.0 5264.8 5656.6 5747.3 5810.9 5191.8 5919.2 5947.4 5988.4 5989.0 5362.4 6232.8 6319.8 6325.9 6331.5 3492.3 3575.9 3931.5 4017.6 4018.4 4328.1 5462.8 5857.1 6020.5 6064.3 4300.9 5488.4 5577.4 5846.4 5870.0 4865.9 5733.5 5755.2 5855.9 5873.6 5447.6 5472.5 5688.7 5760.8 5813.8 5853.4 5853.9 5868.1 5872.6 5886.1 4220.6 5205.8 5550.8 5746.3 5764.0 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:21115.45 Median:3835.99 stddev:29929.32 (780.2%) stddev-sans-first:29974.10 14:15:57 INFO - PROCESS | 1646 | Values: 718.2 726.9 778.7 863.6 869.0 15163.8 16491.0 16500.6 16520.0 16532.8 12595.2 15115.5 15147.8 15196.7 15203.1 695.3 717.7 869.5 872.2 873.9 852.5 874.6 882.6 882.9 888.5 926.9 939.9 941.1 941.5 943.8 909.4 939.1 939.5 939.7 940.2 587.5 697.2 697.2 697.3 701.2 15385.7 15802.9 16010.3 16269.7 16546.8 14825.5 15025.6 15058.6 15144.3 15199.5 10120.0 10609.4 11636.4 11930.8 12425.4 3381.5 3561.9 3789.4 3803.8 3868.2 99537.5 101731.0 101887.0 103003.5 103886.5 10157.4 11587.5 11669.7 11672.2 11713.7 24129.3 24281.0 24327.0 24372.3 24789.0 7865.3 8139.1 8237.7 8262.1 8310.6 4403.4 4465.0 4518.3 4547.3 4568.5 3648.9 3758.8 3774.8 3940.8 4142.8 750.6 758.2 761.1 777.8 781.6 564.7 566.7 573.7 580.3 599.0 10204.0 10460.7 10930.5 11144.6 11253.8 632.5 658.1 666.3 673.8 685.3 5015.7 5250.9 5278.3 5288.8 5321.3 101767.5 104593.5 105857.0 106057.0 106696.0 93308.0 94946.0 95118.5 96141.0 97380.0 80849.6 81957.6 82391.0 83889.7 84536.2 10063.3 10115.5 10167.4 10190.7 10207.5 53400.0 54256.7 54979.2 55201.2 55869.3 64214.7 64613.0 65209.4 66065.7 68407.3 13751.2 13856.8 13984.5 14486.3 14743.5 14288.5 14403.6 15066.5 15626.8 15737.0 12485.3 14440.6 14441.9 14642.9 14738.2 13757.5 14325.2 14427.1 14584.9 14642.9 11999.7 13770.6 14290.4 14316.2 14425.0 9302.6 9562.0 9807.1 9868.8 10063.7 9564.7 10850.9 11407.2 11575.0 11620.6 14:15:57 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:15:57 INFO - PROCESS | 1646 | 14:15:57 INFO - TEST-INFO | 1646: exit 0 14:15:57 INFO - TEST-OK | dromaeo_css | took 1114332ms 14:15:57 INFO - TEST-START | kraken 14:15:57 INFO - operating with platform_type : mac_ 14:15:57 INFO - Initialising browser for kraken test... 14:15:57 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpTddzIl/profile http://localhost:49240/getInfo.html) 14:16:00 INFO - PROCESS | 1657 | 2017-04-06 14:16:00.242 plugin-container[1659:9831] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:16:00 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:00 INFO - PROCESS | 1657 | 2017-04-06 14:16:00.243 plugin-container[1659:9831] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8547, name = 'com.apple.CFPasteboardClient' 14:16:00 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:00 INFO - PROCESS | 1657 | 2017-04-06 14:16:00.243 plugin-container[1659:9831] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:16:00 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:16:00 INFO - PROCESS | 1657 | colorDepth:24 14:16:00 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:16:00 INFO - PROCESS | 1657 | __metrics 14:16:00 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 14:16:01 INFO - TEST-INFO | 1657: exit 0 14:16:01 INFO - Browser initialized. 14:16:01 INFO - Running cycle 1/1 for kraken test... 14:16:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpTddzIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:03 INFO - PROCESS | 1660 | 2017-04-06 14:16:03.410 plugin-container[1661:9959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 14:16:03 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:03 INFO - PROCESS | 1660 | 2017-04-06 14:16:03.410 plugin-container[1661:9959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 14:16:03 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:03 INFO - PROCESS | 1660 | 2017-04-06 14:16:03.410 plugin-container[1661:9959] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:16:13 INFO - PROCESS | 1660 | RSS: Main: 173621248 14:16:13 INFO - PROCESS | 1660 | 14:16:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:16:17 INFO - PROCESS | 1660 | RSS: Main: 187613184 14:16:17 INFO - PROCESS | 1660 | 14:16:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:16:20 INFO - PROCESS | 1660 | RSS: Main: 196038656 14:16:20 INFO - PROCESS | 1660 | 14:16:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:16:24 INFO - PROCESS | 1660 | RSS: Main: 196382720 14:16:24 INFO - PROCESS | 1660 | 14:16:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:16:27 INFO - PROCESS | 1660 | RSS: Main: 198234112 14:16:27 INFO - PROCESS | 1660 | 14:16:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:29 INFO - PROCESS | 1660 | RSS: Main: 198057984 14:16:29 INFO - PROCESS | 1660 | 14:16:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:33 INFO - PROCESS | 1660 | RSS: Main: 203702272 14:16:33 INFO - PROCESS | 1660 | 14:16:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:36 INFO - PROCESS | 1660 | RSS: Main: 202686464 14:16:36 INFO - PROCESS | 1660 | 14:16:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:16:40 INFO - PROCESS | 1660 | RSS: Main: 202670080 14:16:40 INFO - PROCESS | 1660 | 14:16:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:16:42 INFO - PROCESS | 1660 | RSS: Main: 201728000 14:16:42 INFO - PROCESS | 1660 | 14:16:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:45 INFO - PROCESS | 1660 | RSS: Main: 202305536 14:16:45 INFO - PROCESS | 1660 | 14:16:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:47 INFO - PROCESS | 1660 | RSS: Main: 201736192 14:16:47 INFO - PROCESS | 1660 | 14:16:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:51 INFO - PROCESS | 1660 | RSS: Main: 202272768 14:16:51 INFO - PROCESS | 1660 | 14:16:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:55 INFO - PROCESS | 1660 | RSS: Main: 202174464 14:16:55 INFO - PROCESS | 1660 | 14:16:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:16:57 INFO - PROCESS | 1660 | RSS: Main: 204156928 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | __start_tp_report 14:16:57 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 14:16:57 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 14:16:57 INFO - PROCESS | 1660 | |i|pagename|runs| 14:16:57 INFO - PROCESS | 1660 | |0;ai-astar;106;118;119;118;117;117;127;103;173;176 14:16:57 INFO - PROCESS | 1660 | |1;audio-beat-detection;142;109;108;143;110;125;141;97;161;97 14:16:57 INFO - PROCESS | 1660 | |2;audio-dft;196;197;228;204;268;280;227;198;223;276 14:16:57 INFO - PROCESS | 1660 | |3;audio-fft;82;60;59;84;60;62;62;59;73;61 14:16:57 INFO - PROCESS | 1660 | |4;audio-oscillator;84;71;83;75;57;76;104;100;58;91 14:16:57 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;84;88;101;91;119;87;137;90;92;89 14:16:57 INFO - PROCESS | 1660 | |6;imaging-darkroom;98;99;97;97;98;97;91;140;152;126 14:16:57 INFO - PROCESS | 1660 | |7;imaging-desaturate;98;96;93;135;143;92;93;90;95;94 14:16:57 INFO - PROCESS | 1660 | |8;json-parse-financial;59;58;57;61;60;61;60;62;61;61 14:16:57 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;67;68;70;76;75;68;70;71;70;69 14:16:57 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;86;84;82;85;87;83;85;90;89;83 14:16:57 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;141;137;143;147;130;149;143;154;181;135 14:16:57 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;168;167;165;163;167;166;166;170;164;226 14:16:57 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;62;64;64;66;68;78;85;86;84;85 14:16:57 INFO - PROCESS | 1660 | __end_tp_report 14:16:57 INFO - PROCESS | 1660 | __start_cc_report 14:16:57 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,933 14:16:57 INFO - PROCESS | 1660 | __end_cc_report 14:16:57 INFO - PROCESS | 1660 | __startTimestamp1491513417031__endTimestamp 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | ------- Summary: start ------- 14:16:57 INFO - PROCESS | 1660 | Number of tests: 14 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:127.40 Median:118.50 stddev:25.73 (21.7%) stddev-sans-first:26.10 14:16:57 INFO - PROCESS | 1660 | Values: 106.0 118.0 119.0 118.0 117.0 117.0 127.0 103.0 173.0 176.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:142.50 stddev:22.30 (15.6%) stddev-sans-first:22.60 14:16:57 INFO - PROCESS | 1660 | Values: 142.0 109.0 108.0 143.0 110.0 125.0 141.0 97.0 161.0 97.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:229.70 Median:227.50 stddev:33.44 (14.7%) stddev-sans-first:33.17 14:16:57 INFO - PROCESS | 1660 | Values: 196.0 197.0 228.0 204.0 268.0 280.0 227.0 198.0 223.0 276.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:66.20 Median:62.00 stddev:9.75 (15.7%) stddev-sans-first:8.50 14:16:57 INFO - PROCESS | 1660 | Values: 82.0 60.0 59.0 84.0 60.0 62.0 62.0 59.0 73.0 61.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:75.50 stddev:15.84 (21.0%) stddev-sans-first:16.73 14:16:57 INFO - PROCESS | 1660 | Values: 84.0 71.0 83.0 75.0 57.0 76.0 104.0 100.0 58.0 91.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:88.50 stddev:17.05 (19.3%) stddev-sans-first:17.34 14:16:57 INFO - PROCESS | 1660 | Values: 84.0 88.0 101.0 91.0 119.0 87.0 137.0 90.0 92.0 89.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:97.00 stddev:21.59 (22.3%) stddev-sans-first:22.49 14:16:57 INFO - PROCESS | 1660 | Values: 98.0 99.0 97.0 97.0 98.0 97.0 91.0 140.0 152.0 126.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:93.50 stddev:19.24 (20.6%) stddev-sans-first:20.33 14:16:57 INFO - PROCESS | 1660 | Values: 98.0 96.0 93.0 135.0 143.0 92.0 93.0 90.0 95.0 94.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:61.00 stddev:1.56 (2.6%) stddev-sans-first:1.62 14:16:57 INFO - PROCESS | 1660 | Values: 59.0 58.0 57.0 61.0 60.0 61.0 60.0 62.0 61.0 61.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:2.95 (4.2%) stddev-sans-first:2.86 14:16:57 INFO - PROCESS | 1660 | Values: 67.0 68.0 70.0 76.0 75.0 68.0 70.0 71.0 70.0 69.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.63 (3.1%) stddev-sans-first:2.78 14:16:57 INFO - PROCESS | 1660 | Values: 86.0 84.0 82.0 85.0 87.0 83.0 85.0 90.0 89.0 83.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:145.00 stddev:14.14 (9.8%) stddev-sans-first:14.88 14:16:57 INFO - PROCESS | 1660 | Values: 141.0 137.0 143.0 147.0 130.0 149.0 143.0 154.0 181.0 135.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:167.00 stddev:19.01 (11.4%) stddev-sans-first:20.10 14:16:57 INFO - PROCESS | 1660 | Values: 168.0 167.0 165.0 163.0 167.0 166.0 166.0 170.0 164.0 226.0 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:81.00 stddev:10.25 (12.7%) stddev-sans-first:9.88 14:16:57 INFO - PROCESS | 1660 | Values: 62.0 64.0 64.0 66.0 68.0 78.0 85.0 86.0 84.0 85.0 14:16:57 INFO - PROCESS | 1660 | -------- Summary: end -------- 14:16:57 INFO - PROCESS | 1660 | 14:16:57 INFO - TEST-INFO | 1660: exit 0 14:16:58 INFO - TEST-OK | kraken | took 60408ms 14:16:58 INFO - SUITE-END | took 1174s 14:16:58 INFO - Completed test suite (00:19:34) 14:16:58 INFO - javascript benchmark 14:16:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7342.101101552611, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.2701932594155, 3478.513008178855, 3493.8253087345624, 3523.154442933696, 3532.6114127445976, 5700.230468886699, 5700.857478563038, 5726.971365143168, 5756.712164391779, 5771.624844385117, 5781.4507621775965, 5864.354920958691, 5883.646981181132, 5889.057750759879, 5945.762169513214, 3729.627037296262, 4124.845043387856, 5230.633855630098, 5258.316418865542, 5295.443978382272, 5225.425203227642, 5237.607179461536, 5333.653312534692, 5354.491323324278, 5374.758135883894, 5056.393232812049, 5104.953484535661, 5158.993996170748, 5278.841634750964, 5286.3127793387, 5136.486351364871, 5194.142966410538, 5236.162214045735, 5241.659292146036, 5272.499112584298, 5116.155834287338, 5122.154844450662, 5127.154019586764, 5162.948370516322, 5189.662671926313, 5538.335399752015, 5624.437556244384, 5689.175069614924, 5691.857703557403, 5772.480476757112, 6209.72056257465, 6213.254409470847, 6249.0, 6251.874962500725, 6281.59169653971, 6255.12428260044, 6255.468285195764, 6267.843303917393, 6271.937280627181, 6288.496920246369, 5966.403359663999, 6004.4595986361, 6010.398960103998, 6019.307779605401, 6034.487068599218, 6198.876022479525, 6217.2699724930335, 6234.906476402857, 6237.532185086136, 6283.905741413882, 6198.6280823150755, 6238.282597501346, 6272.18461599989, 6275.905861412082, 6284.465820405317, 6235.563510554218, 6242.937570624326, 6247.5939063960695, 6248.75004999804, 6256.468200202943, 6116.579253789288, 6173.382661733791, 6175.536834737323, 6175.938240617626, 6292.653904035322, 6176.382361763787, 6231.875362492725, 6232.750689972441, 6250.562460627712, 6257.7184026718905, 5026.070177017264, 5054.69671819692, 5069.6451248413, 5070.771815268322, 5071.0, 4398.516163222043, 4442.178197033559, 4515.571020753023, 4527.411436513232, 4550.47669518003, 5264.578833693296, 6046.606970546901, 6106.72519736613, 6147.231596050494, 6151.8926593213655, 4626.074785043005, 4927.679700819435, 5444.346678398539, 5997.250343707036, 6167.84580385494, 5948.553858460633, 6009.06859436788, 6060.666663333471, 6067.24159480065, 6142.170806941095, 5489.34127904646, 5539.390667026624, 5541.058020136506, 5542.806001789999, 5568.3318001839225, 6481.805545833632, 6485.092087107903, 6504.284528701839, 6533.248676402274, 6555.6066636002, 6117.248930028793, 6230.252369715663, 6236.719347629277, 6244.000959846403, 6258.3741625838875, 6370.6814659267775, 6418.4865210783955, 6441.194850643669, 6521.380468855451, 6548.246951600627, 6262.342454042442, 6263.561550691408, 6269.780557680459, 6276.623402595859, 6286.27707813589, 6117.357677443804, 6245.219347581552, 6257.561970662192, 6264.498840092872, 6273.654948977667, 5325.80169461868, 6027.547933904887, 6127.20346354971, 6147.954847675996, 6207.006878899354, 6204.069389591597, 6240.500759939285, 6252.280987686474, 6256.280527739368, 6262.185915831095, 5519.917201241904, 5996.340402555628, 6076.392360764065, 6133.601315914451, 6174.228221472316, 6099.115628233792, 6118.938810612015, 6152.200213972334, 6160.476359509492, 6231.875362492634, 4931.432885218246, 4956.801727930842, 5018.473060328759, 5630.8029218977135, 5896.351401345934], "value": 5710.106218253622, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.3115819744976, 506.5719467050341, 516.4654582507105, 533.8069414857794, 545.9890802183959, 32979.0, 36960.0, 40078.19843603126, 42805.14389712204, 44634.0, 44202.33696494555, 44678.32982505265, 44713.77643111788, 44730.776346118226, 44847.0, 9002.549872506348, 9612.423254604728, 9830.26273029522, 9866.112049915506, 9871.309008369417, 9023.18791308782, 11796.528138874435, 11922.403879805976, 12097.879021209807, 12163.39183040849, 12118.091143164298, 12119.091068169879, 12168.2699038058, 12181.903628673417, 12198.451069701885, 11890.048796096291, 11890.94054529726, 11974.940125299361, 11988.400579971054, 11989.820152697717, 11901.583444579484, 11978.460969256404, 12000.339981301026, 12009.0, 12012.279263244232, 42181.57818421838, 42202.57797422017, 42363.36454953178, 42412.363814542805, 42475.0, 4022.9195416091807, 4065.4308396824467, 4089.9795501022304, 4118.238125946709, 4173.895652608679, 26284.474310513873, 28368.290792730142, 28855.42289154226, 30116.698833011607, 30629.081127565987, 3275.983620081908, 3347.6317605063423, 3370.69663730263, 3450.993694628463, 3533.469979503069, 415784.0, 446911.0, 488028.99999999645, 491510.0, 494873.0, 61982.0, 62276.37723622796, 62492.0, 62515.0, 62670.0, 62862.0, 64474.0, 64603.67698161573, 64667.67666161639, 64784.0, 16894.0, 17458.127093645267, 17485.0, 17527.29890804379, 17577.20902559388, 12469.438875250635, 12707.872921270853, 13371.130876492996, 13394.062415630813, 13582.252976086213, 15586.844131558539, 16048.598785030468, 16090.0, 16111.516654500383, 16357.918210408872, 7691.384689224848, 7712.807179820549, 7719.922800772033, 7727.536347819148, 7738.148803631596, 760.7755712064954, 773.072313224122, 807.8142027333746, 943.9710715320197, 955.8136163448061, 30216.09351719452, 31067.223319417197, 31141.8442907784, 31394.529082063786, 31765.20586985344, 869.3219288954625, 1014.9035841595037, 1109.3399427340719, 1148.311013391975, 1235.765204611121, 15935.920320398323, 16219.594510137105, 16335.26491307894, 16359.427420040241, 16628.3348666052, 586675.0, 688872.0, 697013.029869705, 699494.0, 897811.5109424411, 55918.440815592134, 56084.71957640268, 56235.0, 56346.0, 56512.58718531988, 1438.6619144501035, 1464.6191990082443, 1484.0798704803092, 1495.386891374553, 1499.3702644889172, 21982.560348793253, 28720.0, 29356.0, 29706.851465742533, 29852.70147298499, 46299.768501157276, 46837.76581117073, 46838.76580617075, 46849.828754281414, 46891.531084688715, 534057.0, 535056.0, 536862.0, 537023.0, 537960.0, 19274.7108793371, 21813.890930545247, 25213.0, 25894.482110358065, 25998.610020849323, 38958.61041389663, 43091.7845410771, 43945.0, 44935.876603085184, 45016.54983450124, 30100.84949575238, 30646.84676576603, 31294.68705312918, 31695.0, 31764.0, 30598.388032239676, 30852.69147308588, 31238.375232495677, 31499.0, 31724.206894827814, 35754.463683044254, 36358.0, 36684.81657591802, 36759.448608271436, 36775.0, 30040.549391758705, 30599.011064280752, 31441.8427907859, 31557.684423156392, 31826.681733182373, 23238.3028509145, 24364.26907192787, 24598.0, 24773.50452990894, 24869.0], "value": 20098.662851038418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7638975640225, 400.5353789604058, 404.3429427180831, 410.5709533537453, 433.5729306632966, 20622.278220262277, 21284.680729789045, 21476.24833130841, 21893.67159492609, 22017.449563760914, 20734.170633174654, 21238.619489733155, 21309.57380852386, 22506.77493225067, 22956.88521557394, 5932.733027013784, 6103.908441373383, 6214.036824292242, 6214.409631085062, 6235.469985051276, 5261.210818377255, 5859.296884373881, 5997.850053748648, 6061.12113743507, 6107.0, 5996.970015149918, 6058.212432383784, 6058.39416058395, 6061.393860613925, 6062.727177277033, 5762.683052432115, 5920.999999999978, 5983.431574000463, 5986.2517185351835, 6018.15745795589, 5266.447023062561, 5294.020606187829, 5297.364316282033, 5308.416074231832, 5312.495312945264, 25330.860111295035, 25926.611100833503, 26443.206703798918, 27224.59163112555, 27438.17685469439, 2432.5378178146098, 2995.0, 3020.969790302113, 3042.1481985044225, 3053.40458610571, 10449.26855120142, 10587.57649694019, 10607.939206079407, 10810.243282970117, 10926.617568385069, 1820.708686610136, 1881.7741870975572, 1951.414575627306, 1974.555724961872, 1980.1188471130354, 108721.0, 109084.0, 127795.0, 139685.3015734925, 148619.0, 11887.88112118885, 11937.343446110548, 12301.077419193418, 12309.56916507918, 12553.56062537825, 16380.508584742476, 16405.507834764976, 16415.83584164167, 16426.83573164277, 16458.0, 9100.681476148304, 9298.581563829644, 9318.0, 9334.439933604006, 9357.111074447917, 9067.319951003701, 9102.544872756336, 9124.81750364989, 9301.953490232505, 9306.86039709405, 4486.788567086868, 4910.361652985089, 4922.237053256751, 4989.850304490871, 5091.0581542414775, 1666.4584010196734, 1922.846172306212, 2042.3566576528347, 2042.4681488883336, 2074.6058248932654, 382.9597892221332, 393.37060702875743, 404.5873209326529, 1041.677070120942, 1054.9736256593494, 11942.984846287989, 11955.043596512258, 11989.520419183134, 12225.266484010988, 12226.266424014588, 432.7749570223466, 436.947566292047, 440.1461165339232, 440.4516377110518, 449.12869034073793, 6111.786087487006, 6119.938800612026, 6187.876242475125, 6312.621242725451, 6315.147455093595, 776219.0, 776898.0, 786461.0, 814950.0, 824410.0, 128039.0, 130460.3476982609, 161542.19228904016, 163138.0, 163245.3675463254, 460.53946053946055, 468.9413823272091, 469.32885973058853, 470.1513767649357, 470.9340692303012, 10682.62610808618, 10851.620193293196, 10950.57642506501, 11030.779384412428, 11359.602413915472, 47041.823954401414, 57571.71214143903, 63082.0, 63269.36730632819, 64487.67756161189, 93250.0, 94052.58921116326, 95395.52302238444, 97629.023709762, 97702.0, 10640.361578305326, 13366.465341386236, 13426.261555614145, 13655.931720341334, 13847.653808654864, 13957.3719182635, 14111.941604379917, 14282.928585357007, 14337.56987290383, 14532.564023078901, 11841.644750657493, 11851.0, 12024.038076953648, 12116.697082573006, 12196.51213951432, 7847.293743563107, 10438.739031524272, 11110.611128610783, 11304.43477826089, 11895.821562676394, 11692.649220523397, 11854.585089521825, 12151.75696486083, 12181.756364872475, 12267.57063502773, 11360.772784544428, 13354.799678004643, 13378.264195469343, 13688.863111368759, 13738.900887928741, 11910.166288359731, 12068.396580171131, 12115.030797536, 12181.0, 12189.634310970685], "value": 9469.841556758218, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.879770820626, 1394.6443656867505, 1407.2682205253261, 1416.475903915551, 1425.8003879456876, 7783.571903545303, 8023.277904988565, 8247.546384948826, 8533.871991920118, 8618.267447266982, 8258.256756891878, 8519.701810436636, 8542.871856922151, 8615.698450554231, 8625.784355391119, 2205.900734466953, 2246.8202543796538, 2252.6621006849023, 2255.909763609454, 2263.185253308816, 2030.725852009982, 2102.810747032767, 2225.2434172381386, 2268.886555672218, 2272.1593010586107, 2149.215536329244, 2218.73375194976, 2226.4545186429345, 2226.866388016724, 2231.520223152022, 2220.2784095169054, 2223.8776867272295, 2244.1920908472935, 2244.9775502244934, 2256.6050941085327, 2238.0, 2238.485148415857, 2255.481239314967, 2262.4117729390314, 2273.8521996070367, 8537.871931921027, 8580.0, 8585.31317494599, 8666.133386661284, 8669.393142479967, 5092.745362731848, 5264.236685680593, 5273.2617433559335, 5281.023010742986, 5288.762005709752, 3493.179102910814, 3507.473878918157, 3518.8064656443885, 3541.5750109986966, 3622.8913132606062, 1274.9298788566625, 1275.0946827752307, 1302.0, 1324.2915040453408, 1328.3491089366237, 10979.725506862393, 11034.006939375495, 11045.613403530839, 11060.778784424267, 11071.72320691981, 4575.656825738083, 4652.9530855557905, 4660.440747110369, 4711.0342379812055, 4746.264329029006, 9661.420314781135, 9694.175995040501, 9699.660511882192, 9704.369216000938, 9747.3664211826, 5188.558972487305, 5283.471652834763, 5290.994711004897, 5302.125149350314, 5306.124489459273, 4684.0, 4785.282207668808, 4808.663393562417, 4826.0347930414055, 4834.226523756252, 3456.343294773985, 4002.519697636302, 4046.2109888571445, 4126.793660316972, 4139.151473947833, 1206.8913797758244, 1239.2378687107364, 1276.8276282701902, 1299.740051989606, 1306.6014865465934, 639.8560323927172, 675.4157653629575, 689.5035574386434, 860.5869182792295, 892.3173772064376, 5477.7261136943, 5786.623869448473, 5833.562482813721, 5913.881722365614, 6129.0, 856.7515420528101, 1033.6382266206767, 1037.0821822686826, 1042.8435734639713, 1057.3814318623538, 3912.921741565153, 4080.959190408117, 4081.8774836920084, 4155.439015732837, 4191.308434108399, 9843.261755368232, 9866.210703143732, 9941.105300522988, 10091.545880435398, 10226.897731022595, 9850.408975461496, 10038.598456061822, 10067.848982265272, 10069.79860402788, 10093.192544596415, 6477.611343319321, 7648.694052237959, 7994.5602991836, 7999.520028798291, 8086.474379165453, 5807.941920580909, 5810.680412577349, 5896.70516474166, 5985.341612422543, 6016.639001659914, 8987.55062246872, 9159.267258619428, 9423.293253005915, 9439.433633981984, 9486.762830929281, 9080.909190908007, 9252.0, 9368.203702685076, 9457.29070319715, 9470.57382417779, 8016.9198308016175, 8129.512229266263, 8132.715354962548, 8135.593220339078, 8180.304674102768, 7614.086309642878, 7649.235076492307, 7666.386689064973, 7668.731594394169, 7672.38620910337, 6913.409915719312, 7023.894641580278, 7059.752908648173, 7246.565206087652, 7273.781786546412, 6964.408025317702, 7026.613536255555, 7036.050133231948, 7054.717811287696, 7070.787876363512, 6527.445167160845, 6542.34576542342, 6568.408843204134, 6600.80197594073, 6656.167979002625, 4114.19773144234, 4564.863054108382, 4601.171789077865, 4654.790534426027, 5125.513076257749, 4905.877353066202, 5189.091908915849, 5191.766370513412, 5256.658317209369, 5304.9469505306], "value": 4461.831750864113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.16741828630717, 371.7323527060517, 379.9664911440883, 380.224342341623, 385.44688372185914, 4800.9197930465625, 5275.657082289648, 5391.757370918308, 5598.3841777404505, 5657.219649396264, 4906.9263961040615, 4929.964707411448, 5099.062356304599, 5267.683938963655, 5445.591580631449, 3553.5658074219114, 4013.739106958053, 4251.829926802924, 4270.722403043807, 4278.144371125772, 3677.3196958562617, 4006.777932730516, 4102.220578090169, 4166.333386658135, 4278.037441575636, 3551.0412188709033, 3972.2055588882195, 4126.29852925002, 4155.501339839208, 4172.603602657758, 4122.361034039729, 4131.834726610932, 4135.503739551273, 4136.544980052192, 4167.291560434734, 3594.137407022322, 3597.244578638489, 3613.295407395559, 3619.529461170031, 3630.4735813306925, 5063.265826455144, 5267.947320526784, 5295.258663787073, 5345.4654534546235, 5347.358317001946, 4204.2432362174795, 4738.2892566115015, 4777.938752060755, 4780.0, 4781.402324709411, 4542.318652202163, 5714.457126572969, 5748.252727145445, 5807.067430947344, 5821.446962538595, 3318.286568387784, 3454.7063499602564, 3485.20511936353, 3688.963110368889, 3943.5859234780223, 6052.818415447544, 6109.853425485834, 6114.838180745644, 6116.938830611682, 6120.479759220471, 3353.312570923004, 3509.6487852176583, 3552.378333791576, 3838.405047217686, 3985.4619626350072, 3385.3906296866307, 3455.464403017486, 3896.2402331545645, 4029.9395509067385, 4055.7160998729805, 4081.551029386765, 4140.068484591003, 4756.476787553366, 4760.000399915987, 4799.760011999386, 5832.571020100017, 5861.384554621789, 5894.351621321651, 5903.557233207526, 5903.822885313448, 1061.532925512772, 1175.482787573465, 1272.2303006680825, 1314.6319030671427, 1327.197045787304, 840.684743221292, 860.2257967829004, 877.7103555826562, 898.5597057441937, 912.9041450647719, 5264.6314757966575, 5296.735163241822, 5309.787608495617, 5337.866553336197, 5366.812161574326, 5458.263134476874, 5691.345495268014, 5745.9425405745405, 5768.625039372511, 5772.478787939353, 5068.898622027539, 5343.259718197278, 5344.4922732340365, 5346.994876921154, 5587.519307383546, 2498.5127900059315, 2793.2877116335203, 2997.610310659644, 3014.050574069161, 3028.3798167980467, 5032.446430892599, 5512.724363781795, 5961.972929204091, 6008.888355654218, 6128.434316434285, 4940.4640165213905, 5141.280220769096, 5687.7156142192725, 5852.385499522574, 5875.735591898375, 4976.825811096594, 5442.265294185234, 5585.860353491195, 5640.435956404327, 6127.6936153193055, 5017.974910125426, 5264.789098507288, 5656.569693094675, 5747.339056008613, 5810.912836307543, 5191.8182863599595, 5919.24128178601, 5947.375525569926, 5988.37122102173, 5988.970055149871, 5362.436944120811, 6232.844178895564, 6319.8104056878365, 6325.936740632535, 6331.5251356147555, 3492.305798350363, 3575.871112776321, 3931.4667279760342, 4017.598240176076, 4018.4173294872667, 4328.056921293425, 5462.781488740565, 5857.1300062967985, 6020.51835853122, 6064.332923378513, 4300.903269666215, 5488.368837583729, 5577.386487486455, 5846.41535846429, 5870.0, 4865.929495510982, 5733.455321744427, 5755.194272801895, 5855.94144058554, 5873.588848780544, 5447.618666693294, 5472.50747432733, 5688.6916009317265, 5760.827175184583, 5813.82558523245, 5853.414658534112, 5853.94146058534, 5868.063539032195, 5872.647641141545, 5886.146508756292, 4220.599043090901, 5205.843824685266, 5550.833474995757, 5746.333563266606, 5764.0], "value": 4169.717261655079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2243177368442, 726.8873324634684, 778.739122393998, 863.568215892054, 868.9739307820763, 15163.848361516382, 16491.010539367646, 16500.58748531286, 16519.999999999985, 16532.75200871988, 12595.181313214634, 15115.470958516455, 15147.848521514781, 15196.696066078672, 15203.087814731123, 695.2630211975322, 717.73802562065, 869.5043825019757, 872.1714371347214, 873.9169778870997, 852.4629483425433, 874.5802015032788, 882.563131250029, 882.8543290357084, 888.4979986307748, 926.9119433653826, 939.8872135343769, 941.087145468894, 941.4868896451451, 943.8442656961593, 909.3725329522641, 939.1031564855547, 939.4551160327028, 939.7227817793768, 940.191435365585, 587.5064945445803, 697.2330436519787, 697.2400083908564, 697.3375293471172, 701.165612920628, 15385.692286154213, 15802.920985395114, 16010.279537420844, 16269.674606507804, 16546.751798723028, 14825.481108161162, 15025.624359390993, 15058.623534411618, 15144.318505667272, 15199.468018619295, 10120.0, 10609.363438193734, 11636.418029517403, 11930.761384772255, 12425.37873106341, 3381.526586277923, 3561.893143205682, 3789.4126410406157, 3803.7527560708463, 3868.226354729037, 99537.5023124887, 101731.0, 101887.0, 103003.45494817659, 103886.48056759743, 10157.39055656663, 11587.478563464665, 11669.708257293465, 11672.241304315192, 11713.707157320965, 24129.276121716375, 24281.0, 24327.0269189234, 24372.26883193507, 24789.0, 7865.292123708894, 8139.104698483162, 8237.670493180325, 8262.091169971298, 8310.584470776437, 4403.405540252089, 4465.0, 4518.344839998182, 4547.3179023146795, 4568.497465278817, 3648.890533284006, 3758.8496460141837, 3774.8490060397826, 3940.842366305373, 4142.79286035697, 750.5871770526189, 758.21146008152, 761.1247065874178, 777.7899967008989, 781.5896654256447, 564.6702016750494, 566.6911533214408, 573.6816067082809, 580.2514755964843, 598.9790357337472, 10204.0, 10460.69241344832, 10930.457019472931, 11144.60993865211, 11253.831192532118, 632.5319263744796, 658.0885473618977, 666.3003845961721, 673.7581615035035, 685.2873012067494, 5015.699058056528, 5250.868728281824, 5278.291332579218, 5288.762005709752, 5321.255024296602, 101767.49116254371, 104593.47703261435, 105857.0, 106057.0, 106696.0, 93308.0, 94946.0, 95118.52440737752, 96141.0, 97380.0, 80849.59575202086, 81957.59021204975, 82391.0, 83889.74165387524, 84536.15463845406, 10063.345882517613, 10115.49422528856, 10167.44079075658, 10190.745231369276, 10207.54066067014, 53400.0, 54256.72871635616, 54979.175312369545, 55201.171982421096, 55869.286650944494, 64214.67892660507, 64613.0, 65209.36976575624, 66065.66967165134, 68407.31592684209, 13751.243681597209, 13856.792148117987, 13984.510542130976, 14486.348114335091, 14743.483978060716, 14288.499902503363, 14403.567892963229, 15066.472673456816, 15626.765598516258, 15737.0, 12485.313307767796, 14440.638984025483, 14441.927790360982, 14642.926785366431, 14738.189399582698, 13757.518486853312, 14325.21211333345, 14427.134371937298, 14584.927075364556, 14642.901782366152, 11999.700007499883, 13770.586882393543, 14290.35693393779, 14316.212608306643, 14425.0, 9302.581383837878, 9562.0, 9807.06832850878, 9868.802623947624, 10063.748406289902, 9564.665236716959, 10850.945745271223, 11407.201495895208, 11575.016123629586, 11620.593279235187], "value": 7746.439640214118, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 119.0, 118.0, 117.0, 117.0, 127.0, 103.0, 173.0, 176.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 143.0, 110.0, 125.0, 141.0, 97.0, 161.0, 97.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 228.0, 204.0, 268.0, 280.0, 227.0, 198.0, 223.0, 276.0], "value": 229.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 84.0, 60.0, 62.0, 62.0, 59.0, 73.0, 61.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 83.0, 75.0, 57.0, 76.0, 104.0, 100.0, 58.0, 91.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 101.0, 91.0, 119.0, 87.0, 137.0, 90.0, 92.0, 89.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 97.0, 97.0, 98.0, 97.0, 91.0, 140.0, 152.0, 126.0], "value": 109.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 93.0, 135.0, 143.0, 92.0, 93.0, 90.0, 95.0, 94.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 61.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 76.0, 75.0, 68.0, 70.0, 71.0, 70.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 85.0, 87.0, 83.0, 85.0, 90.0, 89.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 143.0, 147.0, 130.0, 149.0, 143.0, 154.0, 181.0, 135.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 165.0, 163.0, 167.0, 166.0, 166.0, 170.0, 164.0, 226.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 66.0, 68.0, 78.0, 85.0, 86.0, 84.0, 85.0], "value": 74.2, "unit": "score"}]}]} 14:16:58 INFO - Return code: 0 14:16:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:58 ERROR - # TBPL SUCCESS # 14:16:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:58 INFO - 2017-04-06 14:16:58.360 screenresolution[1665:10340] starting screenresolution argv=screenresolution get 14:16:58 INFO - 2017-04-06 14:16:58.362 screenresolution[1665:10340] Display 0: 1600x1200x32@60 14:16:58 INFO - 2017-04-06 14:16:58.369 screenresolution[1666:10343] starting screenresolution argv=screenresolution list 14:16:58 INFO - Available Modes on Display 0 14:16:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:58 INFO - Intel Iris: 14:16:58 INFO - Chipset Model: Intel Iris 14:16:58 INFO - Type: GPU 14:16:58 INFO - Bus: Built-In 14:16:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:58 INFO - Vendor: Intel (0x8086) 14:16:58 INFO - Device ID: 0x0a2e 14:16:58 INFO - Revision ID: 0x0009 14:16:58 INFO - Displays: 14:16:58 INFO - Display: 14:16:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:58 INFO - Display Serial Number: 1600x1200 60 14:16:58 INFO - Main Display: Yes 14:16:58 INFO - Mirror: Off 14:16:58 INFO - Online: Yes 14:16:58 INFO - Rotation: Supported 14:16:58 INFO - Return code: 0 14:16:58 INFO - Running post-action listener: _resource_record_post_action 14:16:58 INFO - [mozharness: 2017-04-06 21:16:58.621329Z] Finished run-tests step (success) 14:16:58 INFO - Running post-run listener: _resource_record_post_run 14:16:58 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 40634368; Write bytes: 421521408; Read time: 390; Write time: 1371 14:16:58 INFO - TinderboxPrint: CPU usage
54.3% 14:16:58 INFO - TinderboxPrint: I/O read bytes / time
40,634,368 / 390 14:16:58 INFO - TinderboxPrint: I/O write bytes / time
421,521,408 / 1,371 14:16:58 INFO - TinderboxPrint: CPU idle
2,177.3 (45.7%) 14:16:58 INFO - TinderboxPrint: CPU system
958.9 (20.1%) 14:16:58 INFO - TinderboxPrint: CPU user
1,625.3 (34.1%) 14:16:58 INFO - TinderboxPrint: Swap in / out
162,668,544 / 0 14:16:58 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119443968; Write bytes: 112754688; Read time: 10865; Write time: 208 14:16:58 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38520832; Write bytes: 297605120; Read time: 366; Write time: 1126 14:16:59 INFO - Running post-run listener: _upload_blobber_files 14:16:59 INFO - Blob upload gear active. 14:16:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:59 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 14:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:00 INFO - (blobuploader) - INFO - Done attempting. 14:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:01 INFO - (blobuploader) - INFO - Done attempting. 14:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:03 INFO - (blobuploader) - INFO - Done attempting. 14:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:06 INFO - (blobuploader) - INFO - Done attempting. 14:17:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:17:06 INFO - Return code: 0 14:17:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:17:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:17:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/549a88aeaca16e3480909804938a8f7f4be5f77f80bb41cc5d3eed417d38c9c5e8994019e1e9200df67a03ca5164d41fbc51d231d6290d496d2f845e8cedf14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ce0ff62a758e86ca9d1f869031c3857300b7ef33791a7b51214132d4dbb4af67f257ec16bc240146a9cc86765d26d505f92ac4453c58e43efaaf80a753b1ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a26a15a4889f5f222632c87f3af2c8e72190529a1fde37c8ecaa881be56dd5cb7c8a2bc4fda8146438fc19e9e0e27bb32f1458ba2183704aa12c516dab71fed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d565940f3a20a1d03f13fc544379f268da2e65d8a787a9a58feaf26a08fcf3e27c51d7de896c4fbdf491bec1da163d668476c28b676364835c0dd1b8269f8587"} 14:17:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:17:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:17:06 INFO - Contents: 14:17:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/549a88aeaca16e3480909804938a8f7f4be5f77f80bb41cc5d3eed417d38c9c5e8994019e1e9200df67a03ca5164d41fbc51d231d6290d496d2f845e8cedf14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ce0ff62a758e86ca9d1f869031c3857300b7ef33791a7b51214132d4dbb4af67f257ec16bc240146a9cc86765d26d505f92ac4453c58e43efaaf80a753b1ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a26a15a4889f5f222632c87f3af2c8e72190529a1fde37c8ecaa881be56dd5cb7c8a2bc4fda8146438fc19e9e0e27bb32f1458ba2183704aa12c516dab71fed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d565940f3a20a1d03f13fc544379f268da2e65d8a787a9a58feaf26a08fcf3e27c51d7de896c4fbdf491bec1da163d668476c28b676364835c0dd1b8269f8587"} 14:17:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:17:06 INFO - Copying logs to upload dir... 14:17:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:17:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.060263 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-06 14:17:06.332280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 14:17:06.335733) ========= 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.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/549a88aeaca16e3480909804938a8f7f4be5f77f80bb41cc5d3eed417d38c9c5e8994019e1e9200df67a03ca5164d41fbc51d231d6290d496d2f845e8cedf14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ce0ff62a758e86ca9d1f869031c3857300b7ef33791a7b51214132d4dbb4af67f257ec16bc240146a9cc86765d26d505f92ac4453c58e43efaaf80a753b1ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a26a15a4889f5f222632c87f3af2c8e72190529a1fde37c8ecaa881be56dd5cb7c8a2bc4fda8146438fc19e9e0e27bb32f1458ba2183704aa12c516dab71fed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d565940f3a20a1d03f13fc544379f268da2e65d8a787a9a58feaf26a08fcf3e27c51d7de896c4fbdf491bec1da163d668476c28b676364835c0dd1b8269f8587"} build_url:https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010975 build_url: 'https://queue.taskcluster.net/v1/task/HmQhVZ9eT66PMXZdXs-SwA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/549a88aeaca16e3480909804938a8f7f4be5f77f80bb41cc5d3eed417d38c9c5e8994019e1e9200df67a03ca5164d41fbc51d231d6290d496d2f845e8cedf14c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ce0ff62a758e86ca9d1f869031c3857300b7ef33791a7b51214132d4dbb4af67f257ec16bc240146a9cc86765d26d505f92ac4453c58e43efaaf80a753b1ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a26a15a4889f5f222632c87f3af2c8e72190529a1fde37c8ecaa881be56dd5cb7c8a2bc4fda8146438fc19e9e0e27bb32f1458ba2183704aa12c516dab71fed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d565940f3a20a1d03f13fc544379f268da2e65d8a787a9a58feaf26a08fcf3e27c51d7de896c4fbdf491bec1da163d668476c28b676364835c0dd1b8269f8587"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 14:17:06.370080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 14:17:06.370450) ========= 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.PZB0D58YUD/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.3SshVhfHLX/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005158 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 14:17:06.419475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 14:17:06.419809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 14:17:06.420250) ========= ========= Total master_lag: 0.36 =========