builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0206 starttime: 1491757752.48 results: success (0) buildid: 20170409084721 builduid: 77655f9115b6400984a450a9ff2b53bc revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:12.481052) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:12.481530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:12.484646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:12.510884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:12.511464) ========= 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.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-09 10:09:12-- 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% 86.0M=0s 2017-04-09 10:09:13 (86.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.596947 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:13.135758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:13.136114) ========= 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.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.020632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:13.184737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 10:09:13.185079) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-09 10:09:13,272 truncating revision to first 12 chars 2017-04-09 10:09:13,273 Setting DEBUG logging. 2017-04-09 10:09:13,273 attempt 1/10 2017-04-09 10:09:13,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6dd79ff61be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 10:09:13,980 unpacking tar archive at: mozilla-central-c6dd79ff61be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 10:09:14.185926) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:14.186201) ========= script_repo_revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:14.186565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:14.186851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 10:09:14.208058) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-09 10:09:14.208688) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:09:14 INFO - MultiFileLogger online at 20170409 10:09:14 in /builds/slave/test 10:09:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:09:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:14 INFO - {'append_to_log': False, 10:09:14 INFO - 'base_work_dir': '/builds/slave/test', 10:09:14 INFO - 'blob_upload_branch': 'Firefox', 10:09:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:14 INFO - 'branch': 'Firefox', 10:09:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:14 INFO - 'config_files': ('talos/mac_config.py',), 10:09:14 INFO - 'default_actions': ('clobber', 10:09:14 INFO - 'read-buildbot-config', 10:09:14 INFO - 'download-and-extract', 10:09:14 INFO - 'populate-webroot', 10:09:14 INFO - 'create-virtualenv', 10:09:14 INFO - 'install', 10:09:14 INFO - 'run-tests'), 10:09:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:14 INFO - 'download_minidump_stackwalk': True, 10:09:14 INFO - 'download_symbols': 'ondemand', 10:09:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:14 INFO - 'gecko_profile': False, 10:09:14 INFO - 'gecko_profile_interval': 0, 10:09:14 INFO - 'installer_path': 'installer.exe', 10:09:14 INFO - 'log_level': 'info', 10:09:14 INFO - 'log_name': 'talos', 10:09:14 INFO - 'log_to_console': True, 10:09:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:09:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:09:14 INFO - 'opt_config_files': (), 10:09:14 INFO - 'pip_index': False, 10:09:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:14 INFO - 'cmd': ('bash', 10:09:14 INFO - '-c', 10:09:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:14 INFO - 'enabled': True, 10:09:14 INFO - 'halt_on_failure': False, 10:09:14 INFO - 'name': 'check_screen_resolution'},), 10:09:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:14 INFO - 'cmd': ('bash', 10:09:14 INFO - '-c', 10:09:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:14 INFO - 'enabled': True, 10:09:14 INFO - 'halt_on_failure': False, 10:09:14 INFO - 'name': 'check_screen_resolution'},), 10:09:14 INFO - 'run_cmd_checks_enabled': True, 10:09:14 INFO - 'suite': 'dromaeojs-e10s', 10:09:14 INFO - 'system_bits': '32', 10:09:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:14 INFO - 'title': 't-yosemite-r7-0206', 10:09:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:14 INFO - 'use_talos_json': True, 10:09:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:14 INFO - 'work_dir': 'build'} 10:09:14 INFO - [mozharness: 2017-04-09 17:09:14.416090Z] Running clobber step. 10:09:14 INFO - Running pre-action listener: _resource_record_pre_action 10:09:14 INFO - Running main action method: clobber 10:09:14 INFO - rmtree: /builds/slave/test/build 10:09:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:16 INFO - Running post-action listener: _resource_record_post_action 10:09:16 INFO - [mozharness: 2017-04-09 17:09:16.136905Z] Finished clobber step (success) 10:09:16 INFO - [mozharness: 2017-04-09 17:09:16.137033Z] Running read-buildbot-config step. 10:09:16 INFO - Running pre-action listener: _resource_record_pre_action 10:09:16 INFO - Running main action method: read_buildbot_config 10:09:16 INFO - Using buildbot properties: 10:09:16 INFO - { 10:09:16 INFO - "project": "", 10:09:16 INFO - "product": "firefox", 10:09:16 INFO - "script_repo_revision": "production", 10:09:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:09:16 INFO - "repository": "", 10:09:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:09:16 INFO - "buildid": "20170409084721", 10:09:16 INFO - "pgo_build": "False", 10:09:16 INFO - "basedir": "/builds/slave/test", 10:09:16 INFO - "buildnumber": 140, 10:09:16 INFO - "slavename": "t-yosemite-r7-0206", 10:09:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:09:16 INFO - "platform": "yosemite_r7", 10:09:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:09:16 INFO - "branch": "mozilla-central", 10:09:16 INFO - "repo_path": "mozilla-central", 10:09:16 INFO - "revision": "c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba", 10:09:16 INFO - "stage_platform": "macosx64", 10:09:16 INFO - "builduid": "77655f9115b6400984a450a9ff2b53bc", 10:09:16 INFO - "slavebuilddir": "test" 10:09:16 INFO - } 10:09:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:09:16 INFO - Running post-action listener: _resource_record_post_action 10:09:16 INFO - [mozharness: 2017-04-09 17:09:16.140332Z] Finished read-buildbot-config step (success) 10:09:16 INFO - [mozharness: 2017-04-09 17:09:16.140468Z] Running download-and-extract step. 10:09:16 INFO - Running pre-action listener: _resource_record_pre_action 10:09:16 INFO - Running main action method: download_and_extract 10:09:16 INFO - mkdir: /builds/slave/test/build/tests 10:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:16 INFO - trying https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:09:16 INFO - Downloading https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:09:17 INFO - Downloaded 1325 bytes. 10:09:17 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:09:17 INFO - Using the following test package requirements: 10:09:17 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:09:17 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:09:17 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:09:17 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:09:17 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'jsshell-mac.zip'], 10:09:17 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:09:17 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:09:17 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:09:17 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:09:17 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:09:17 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:09:17 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:09:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:09:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:09:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:09:17 INFO - Fetch https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:09:19 INFO - Expected file size: 52525884 10:09:19 INFO - Obtained file size: 52525884 10:09:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:09:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:09:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:09:35 INFO - Fetch https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:09:36 INFO - Expected file size: 52525884 10:09:36 INFO - Obtained file size: 52525884 10:09:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:09:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:09:52 INFO - Fetch https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:09:53 INFO - Expected file size: 14404129 10:09:53 INFO - Obtained file size: 14404129 10:09:54 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')]} 10:09:54 INFO - trying https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:09:54 INFO - Downloading https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:09:56 INFO - Downloaded 70923669 bytes. 10:09:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:09:56 INFO - mkdir: /builds/slave/test/properties 10:09:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:56 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:56 INFO - Contents: 10:09:56 INFO - build_url:https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:09:56 INFO - Running post-action listener: _resource_record_post_action 10:09:56 INFO - Running post-action listener: set_extra_try_arguments 10:09:56 INFO - [mozharness: 2017-04-09 17:09:56.750231Z] Finished download-and-extract step (success) 10:09:56 INFO - [mozharness: 2017-04-09 17:09:56.750352Z] Running populate-webroot step. 10:09:56 INFO - Running pre-action listener: _resource_record_pre_action 10:09:56 INFO - Running main action method: populate_webroot 10:09:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:56 INFO - '--tppagecycles', 10:09:56 INFO - '7'], 10:09:56 INFO - 'tests': ['tsvgm']}}, 10:09:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['damp', 'tps']}, 10:09:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'tests': ['damp', 'tps']}, 10:09:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['dromaeo_dom']}, 10:09:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['basic_compositor_video']}, 10:09:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['a11yr', 10:09:56 INFO - 'ts_paint', 10:09:56 INFO - 'tpaint', 10:09:56 INFO - 'sessionrestore', 10:09:56 INFO - 'sessionrestore_no_auto_restore', 10:09:56 INFO - 'tabpaint']}, 10:09:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['tsvgx', 10:09:56 INFO - 'tsvgr_opacity', 10:09:56 INFO - 'tart', 10:09:56 INFO - 'tscrollx', 10:09:56 INFO - 'cart', 10:09:56 INFO - 'tsvg_static']}, 10:09:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:56 INFO - 'tsvgr_opacity', 10:09:56 INFO - 'tart', 10:09:56 INFO - 'tscrollx', 10:09:56 INFO - 'cart', 10:09:56 INFO - 'tsvg_static']}, 10:09:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'talos_options': ['--disable-e10s'], 10:09:56 INFO - 'tests': ['tp5o']}, 10:09:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:09:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'talos_options': ['--disable-e10s', 10:09:56 INFO - '--xperf_path', 10:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:56 INFO - 'tests': ['tp5n']}, 10:09:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:09:56 INFO - 'talos_options': ['--xperf_path', 10:09:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:56 INFO - 'tests': ['tp5n']}}, 10:09:56 INFO - 'talos.zip': {'path': '', 10:09:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:56 INFO - Running post-action listener: _resource_record_post_action 10:09:56 INFO - [mozharness: 2017-04-09 17:09:56.768841Z] Finished populate-webroot step (success) 10:09:56 INFO - [mozharness: 2017-04-09 17:09:56.768986Z] Running create-virtualenv step. 10:09:56 INFO - Running pre-action listener: _resource_record_pre_action 10:09:56 INFO - Running main action method: create_virtualenv 10:09:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:56 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 10:09:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:56 INFO - Using real prefix '/tools/python27' 10:09:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:00 INFO - Installing pip.................done. 10:10:00 INFO - Return code: 0 10:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:10:00 INFO - Reading from file tmpfile_stdout 10:10:00 INFO - Output received: 10:10:00 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) 10:10:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:00 INFO - 'HOME': '/Users/cltbld', 10:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:00 INFO - 'LOGNAME': 'cltbld', 10:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:00 INFO - 'MOZ_NO_REMOTE': '1', 10:10:00 INFO - 'NO_EM_RESTART': '1', 10:10:00 INFO - 'PAGER': '/bin/cat', 10:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:00 INFO - 'PWD': '/builds/slave/test', 10:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:00 INFO - 'SHELL': '/bin/bash', 10:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:00 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:00 INFO - 'USER': 'cltbld', 10:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:00 INFO - 'XPC_FLAGS': '0x0', 10:10:00 INFO - 'XPC_SERVICE_NAME': '0', 10:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:00 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 10:10:00 INFO - Cleaning up... 10:10:01 INFO - Return code: 0 10:10:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10:01 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')]} 10:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:01 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')]} 10:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:01 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:01 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 10:10:01 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 10:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:01 INFO - 'HOME': '/Users/cltbld', 10:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:01 INFO - 'LOGNAME': 'cltbld', 10:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:01 INFO - 'MOZ_NO_REMOTE': '1', 10:10:01 INFO - 'NO_EM_RESTART': '1', 10:10:01 INFO - 'PAGER': '/bin/cat', 10:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:01 INFO - 'PWD': '/builds/slave/test', 10:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:01 INFO - 'SHELL': '/bin/bash', 10:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:01 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:01 INFO - 'USER': 'cltbld', 10:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:01 INFO - 'XPC_FLAGS': '0x0', 10:10:01 INFO - 'XPC_SERVICE_NAME': '0', 10:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:01 INFO - Downloading/unpacking psutil>=3.1.1 10:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:05 INFO - Installing collected packages: psutil 10:10:05 INFO - Running setup.py install for psutil 10:10:05 INFO - building 'psutil._psutil_osx' extension 10:10:05 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 10:10:05 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 10:10:05 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 10:10:05 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 10:10:05 INFO - building 'psutil._psutil_posix' extension 10:10:05 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 10:10:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:05 INFO - ^ 10:10:05 INFO - 1 warning generated. 10:10:05 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 10:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:05 INFO - Successfully installed psutil 10:10:05 INFO - Cleaning up... 10:10:06 INFO - Return code: 0 10:10:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:06 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 10:10:06 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 10:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:06 INFO - 'HOME': '/Users/cltbld', 10:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:06 INFO - 'LOGNAME': 'cltbld', 10:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:06 INFO - 'MOZ_NO_REMOTE': '1', 10:10:06 INFO - 'NO_EM_RESTART': '1', 10:10:06 INFO - 'PAGER': '/bin/cat', 10:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:06 INFO - 'PWD': '/builds/slave/test', 10:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:06 INFO - 'SHELL': '/bin/bash', 10:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:06 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:06 INFO - 'USER': 'cltbld', 10:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:06 INFO - 'XPC_FLAGS': '0x0', 10:10:06 INFO - 'XPC_SERVICE_NAME': '0', 10:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:09 INFO - Installing collected packages: mozsystemmonitor 10:10:09 INFO - Running setup.py install for mozsystemmonitor 10:10:09 INFO - Successfully installed mozsystemmonitor 10:10:09 INFO - Cleaning up... 10:10:09 INFO - Return code: 0 10:10:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:09 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:09 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 10:10:09 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 10:10:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:09 INFO - 'HOME': '/Users/cltbld', 10:10:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:09 INFO - 'LOGNAME': 'cltbld', 10:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:09 INFO - 'MOZ_NO_REMOTE': '1', 10:10:09 INFO - 'NO_EM_RESTART': '1', 10:10:09 INFO - 'PAGER': '/bin/cat', 10:10:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:09 INFO - 'PWD': '/builds/slave/test', 10:10:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:09 INFO - 'SHELL': '/bin/bash', 10:10:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:09 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:09 INFO - 'USER': 'cltbld', 10:10:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:09 INFO - 'XPC_FLAGS': '0x0', 10:10:09 INFO - 'XPC_SERVICE_NAME': '0', 10:10:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:09 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 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 10:10:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:12 INFO - warning: no files found matching '*.txt' 10:10:12 INFO - no previously-included directories found matching 'build' 10:10:12 INFO - no previously-included directories found matching 'dist' 10:10:12 INFO - no previously-included directories found matching '.git*' 10:10:12 INFO - Installing collected packages: jsonschema, functools32 10:10:12 INFO - Running setup.py install for functools32 10:10:12 INFO - warning: no files found matching '*.txt' 10:10:12 INFO - no previously-included directories found matching 'build' 10:10:12 INFO - no previously-included directories found matching 'dist' 10:10:12 INFO - no previously-included directories found matching '.git*' 10:10:12 INFO - Successfully installed jsonschema functools32 10:10:12 INFO - Cleaning up... 10:10:12 INFO - Return code: 0 10:10:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:12 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:12 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 10:10:12 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 10:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:12 INFO - 'HOME': '/Users/cltbld', 10:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:12 INFO - 'LOGNAME': 'cltbld', 10:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:12 INFO - 'MOZ_NO_REMOTE': '1', 10:10:12 INFO - 'NO_EM_RESTART': '1', 10:10:12 INFO - 'PAGER': '/bin/cat', 10:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:12 INFO - 'PWD': '/builds/slave/test', 10:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:12 INFO - 'SHELL': '/bin/bash', 10:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:12 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:12 INFO - 'USER': 'cltbld', 10:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:12 INFO - 'XPC_FLAGS': '0x0', 10:10:12 INFO - 'XPC_SERVICE_NAME': '0', 10:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:13 INFO - Cleaning up... 10:10:13 INFO - Return code: 0 10:10:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:13 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:13 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 10:10:13 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 10:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:13 INFO - 'HOME': '/Users/cltbld', 10:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:13 INFO - 'LOGNAME': 'cltbld', 10:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:13 INFO - 'MOZ_NO_REMOTE': '1', 10:10:13 INFO - 'NO_EM_RESTART': '1', 10:10:13 INFO - 'PAGER': '/bin/cat', 10:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:13 INFO - 'PWD': '/builds/slave/test', 10:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:13 INFO - 'SHELL': '/bin/bash', 10:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:13 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:13 INFO - 'USER': 'cltbld', 10:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:13 INFO - 'XPC_FLAGS': '0x0', 10:10:13 INFO - 'XPC_SERVICE_NAME': '0', 10:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:13 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 10:10:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:17 INFO - Downloading docopt-0.6.1.tar.gz 10:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:17 INFO - Running setup.py install for blobuploader 10:10:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:17 INFO - Running setup.py install for requests 10:10:18 INFO - Running setup.py install for docopt 10:10:18 INFO - Successfully installed blobuploader requests docopt 10:10:18 INFO - Cleaning up... 10:10:18 INFO - Return code: 0 10:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:18 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')]} 10:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:18 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')]} 10:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:18 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:18 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 10:10:18 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 10:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:18 INFO - 'HOME': '/Users/cltbld', 10:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:18 INFO - 'LOGNAME': 'cltbld', 10:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:18 INFO - 'MOZ_NO_REMOTE': '1', 10:10:18 INFO - 'NO_EM_RESTART': '1', 10:10:18 INFO - 'PAGER': '/bin/cat', 10:10:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:18 INFO - 'PWD': '/builds/slave/test', 10:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:18 INFO - 'SHELL': '/bin/bash', 10:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:18 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:18 INFO - 'USER': 'cltbld', 10:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:18 INFO - 'XPC_FLAGS': '0x0', 10:10:18 INFO - 'XPC_SERVICE_NAME': '0', 10:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:18 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-eVIytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:18 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-QIS7Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:18 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-m_ZEE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:18 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-tcn2Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:18 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Jf2hbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-jdr_OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-KWA7mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-AXvgNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-jsWop5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-nWN5BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-788spT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-2iuDwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-BZYoYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:19 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-bLeOlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:20 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-9DNlws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:20 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-TJKFmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:20 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-7UVvX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:20 INFO - Running setup.py install for manifestparser 10:10:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:20 INFO - Running setup.py install for mozcrash 10:10:20 INFO - Running setup.py install for mozdebug 10:10:20 INFO - Running setup.py install for mozdevice 10:10:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:20 INFO - Running setup.py install for mozfile 10:10:21 INFO - Running setup.py install for mozhttpd 10:10:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Running setup.py install for mozinfo 10:10:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Running setup.py install for mozInstall 10:10:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Running setup.py install for mozleak 10:10:21 INFO - Running setup.py install for mozlog 10:10:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:21 INFO - Running setup.py install for moznetwork 10:10:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Running setup.py install for mozprocess 10:10:22 INFO - Running setup.py install for mozprofile 10:10:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Running setup.py install for mozrunner 10:10:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Running setup.py install for mozscreenshot 10:10:22 INFO - Running setup.py install for moztest 10:10:22 INFO - Running setup.py install for mozversion 10:10:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:22 INFO - Cleaning up... 10:10:22 INFO - Return code: 0 10:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:22 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:22 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 10:10:22 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 10:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:22 INFO - 'HOME': '/Users/cltbld', 10:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:22 INFO - 'LOGNAME': 'cltbld', 10:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:22 INFO - 'MOZ_NO_REMOTE': '1', 10:10:22 INFO - 'NO_EM_RESTART': '1', 10:10:22 INFO - 'PAGER': '/bin/cat', 10:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:22 INFO - 'PWD': '/builds/slave/test', 10:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:22 INFO - 'SHELL': '/bin/bash', 10:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:22 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:22 INFO - 'USER': 'cltbld', 10:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:22 INFO - 'XPC_FLAGS': '0x0', 10:10:22 INFO - 'XPC_SERVICE_NAME': '0', 10:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-QnIdHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-0Q44ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-az2YWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-AY9a99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-BNUrR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Qgv7LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Yz5_Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:23 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)) 10:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:23 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-PpuZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-wrUUiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-X9B4YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-8ewDix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-PX3rur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-vDvCwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-zsJ4R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-M87Mbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-5CrKfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:24 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)) 10:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:24 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-yvseAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:25 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)) 10:10:25 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)) 10:10:25 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)) 10:10:25 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)) 10:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:10:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:27 INFO - Downloading blessings-1.6.tar.gz 10:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:27 INFO - Installing collected packages: blessings 10:10:27 INFO - Running setup.py install for blessings 10:10:27 INFO - Successfully installed blessings 10:10:27 INFO - Cleaning up... 10:10:28 INFO - Return code: 0 10:10:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:28 INFO - Reading from file tmpfile_stdout 10:10:28 INFO - Current package versions: 10:10:28 INFO - blessings == 1.6 10:10:28 INFO - blobuploader == 1.2.4 10:10:28 INFO - docopt == 0.6.1 10:10:28 INFO - functools32 == 3.2.3-2 10:10:28 INFO - jsonschema == 2.5.1 10:10:28 INFO - manifestparser == 1.1 10:10:28 INFO - mozInstall == 1.12 10:10:28 INFO - mozcrash == 1.0 10:10:28 INFO - mozdebug == 0.1 10:10:28 INFO - mozdevice == 0.50 10:10:28 INFO - mozfile == 1.2 10:10:28 INFO - mozhttpd == 0.7 10:10:28 INFO - mozinfo == 0.9 10:10:28 INFO - mozleak == 0.1 10:10:28 INFO - mozlog == 3.4 10:10:28 INFO - moznetwork == 0.27 10:10:28 INFO - mozprocess == 0.25 10:10:28 INFO - mozprofile == 0.28 10:10:28 INFO - mozrunner == 6.13 10:10:28 INFO - mozscreenshot == 0.1 10:10:28 INFO - mozsystemmonitor == 0.3 10:10:28 INFO - moztest == 0.8 10:10:28 INFO - mozversion == 1.4 10:10:28 INFO - psutil == 3.1.1 10:10:28 INFO - requests == 1.2.3 10:10:28 INFO - wsgiref == 0.1.2 10:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:28 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:28 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 10:10:28 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 10:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:28 INFO - 'HOME': '/Users/cltbld', 10:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:28 INFO - 'LOGNAME': 'cltbld', 10:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:28 INFO - 'MOZ_NO_REMOTE': '1', 10:10:28 INFO - 'NO_EM_RESTART': '1', 10:10:28 INFO - 'PAGER': '/bin/cat', 10:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:28 INFO - 'PWD': '/builds/slave/test', 10:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:28 INFO - 'SHELL': '/bin/bash', 10:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:28 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:28 INFO - 'USER': 'cltbld', 10:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:28 INFO - 'XPC_FLAGS': '0x0', 10:10:28 INFO - 'XPC_SERVICE_NAME': '0', 10:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 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)) 10:10:28 INFO - Cleaning up... 10:10:28 INFO - Return code: 0 10:10:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:28 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 0x10682bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10682e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e86e7b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, '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.mIF2QylG6A/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.5qBzPKGp2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 10:10:28 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 10:10:28 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 10:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:28 INFO - 'HOME': '/Users/cltbld', 10:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:28 INFO - 'LOGNAME': 'cltbld', 10:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:28 INFO - 'MOZ_NO_REMOTE': '1', 10:10:28 INFO - 'NO_EM_RESTART': '1', 10:10:28 INFO - 'PAGER': '/bin/cat', 10:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:28 INFO - 'PWD': '/builds/slave/test', 10:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:28 INFO - 'SHELL': '/bin/bash', 10:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:28 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:28 INFO - 'USER': 'cltbld', 10:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:28 INFO - 'XPC_FLAGS': '0x0', 10:10:28 INFO - 'XPC_SERVICE_NAME': '0', 10:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:28 INFO - Cleaning up... 10:10:28 INFO - Return code: 0 10:10:28 INFO - Running post-action listener: _resource_record_post_action 10:10:28 INFO - Running post-action listener: _start_resource_monitoring 10:10:28 INFO - Starting resource monitoring. 10:10:28 INFO - [mozharness: 2017-04-09 17:10:28.930464Z] Finished create-virtualenv step (success) 10:10:28 INFO - [mozharness: 2017-04-09 17:10:28.931269Z] Running install step. 10:10:28 INFO - Running pre-action listener: _resource_record_pre_action 10:10:28 INFO - Running main action method: install 10:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:29 INFO - Reading from file tmpfile_stdout 10:10:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:29 INFO - Reading from file tmpfile_stdout 10:10:29 INFO - Output received: 10:10:29 INFO - Usage: mozinstall [options] installer 10:10:29 INFO - Options: 10:10:29 INFO - -h, --help show this help message and exit 10:10:29 INFO - -d DEST, --destination=DEST 10:10:29 INFO - Directory to install application into. [default: 10:10:29 INFO - "/builds/slave/test"] 10:10:29 INFO - --app=APP Application being installed. [default: firefox] 10:10:29 INFO - mkdir: /builds/slave/test/build/application 10:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:10:49 INFO - Reading from file tmpfile_stdout 10:10:49 INFO - Output received: 10:10:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:10:49 INFO - Running post-action listener: _resource_record_post_action 10:10:49 INFO - [mozharness: 2017-04-09 17:10:49.019761Z] Finished install step (success) 10:10:49 INFO - [mozharness: 2017-04-09 17:10:49.019903Z] Running run-tests step. 10:10:49 INFO - Running pre-action listener: _resource_record_pre_action 10:10:49 INFO - Running main action method: run_tests 10:10:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:10:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:10:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:10:49 INFO - 2017-04-09 10:10:49.035 screenresolution[1925:20643] starting screenresolution argv=screenresolution get 10:10:49 INFO - 2017-04-09 10:10:49.037 screenresolution[1925:20643] Display 0: 1600x1200x32@60 10:10:49 INFO - 2017-04-09 10:10:49.043 screenresolution[1926:20645] starting screenresolution argv=screenresolution list 10:10:49 INFO - Available Modes on Display 0 10:10:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:10:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:10:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:10:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:10:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:10:49 INFO - Intel Iris: 10:10:49 INFO - Chipset Model: Intel Iris 10:10:49 INFO - Type: GPU 10:10:49 INFO - Bus: Built-In 10:10:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:10:49 INFO - Vendor: Intel (0x8086) 10:10:49 INFO - Device ID: 0x0a2e 10:10:49 INFO - Revision ID: 0x0009 10:10:49 INFO - Displays: 10:10:49 INFO - Display: 10:10:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:10:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:10:49 INFO - Display Serial Number: 1600x1200 60 10:10:49 INFO - Main Display: Yes 10:10:49 INFO - Mirror: Off 10:10:49 INFO - Online: Yes 10:10:49 INFO - Rotation: Supported 10:10:49 INFO - Return code: 0 10:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:49 INFO - Python 2.7.3 10:10:49 INFO - Return code: 0 10:10:49 INFO - grabbing minidump binary from tooltool 10:10:49 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')]} 10:10:49 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 0x106609d30>, '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 0x106530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1065febe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:49 INFO - Return code: 0 10:10:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:10:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:49 INFO - ENV: RUST_BACKTRACE is now 1 10:10:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:10:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 10:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --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 10:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mIF2QylG6A/Render', 10:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:49 INFO - 'HOME': '/Users/cltbld', 10:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:49 INFO - 'LOGNAME': 'cltbld', 10:10:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:49 INFO - 'MOZ_NO_REMOTE': '1', 10:10:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:49 INFO - 'NO_EM_RESTART': '1', 10:10:49 INFO - 'PAGER': '/bin/cat', 10:10:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:49 INFO - 'PWD': '/builds/slave/test', 10:10:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:49 INFO - 'RUST_BACKTRACE': '1', 10:10:49 INFO - 'SHELL': '/bin/bash', 10:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5qBzPKGp2v/Listeners', 10:10:49 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 10:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:49 INFO - 'USER': 'cltbld', 10:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:49 INFO - 'XPC_FLAGS': '0x0', 10:10:49 INFO - 'XPC_SERVICE_NAME': '0', 10:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 10:10:49 INFO - mozversion application_buildid: 20170409084721 10:10:49 INFO - mozversion application_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 10:10:49 INFO - mozversion application_display_name: Nightly 10:10:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:49 INFO - mozversion application_name: Firefox 10:10:49 INFO - mozversion application_remotingname: firefox 10:10:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:10:49 INFO - mozversion application_vendor: Mozilla 10:10:49 INFO - mozversion application_version: 55.0a1 10:10:49 INFO - mozversion platform_buildid: 20170409084721 10:10:49 INFO - mozversion platform_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 10:10:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:10:49 INFO - mozversion platform_version: 55.0a1 10:10:49 INFO - using testdate: 1491757849 10:10:49 INFO - actual date: 1491757849 10:10:49 INFO - starting webserver on 'localhost:52938' 10:10:49 INFO - SUITE-START | Running 2 tests 10:10:49 INFO - TEST-START | dromaeo_css 10:10:49 INFO - operating with platform_type : mac_ 10:10:49 INFO - Initialising browser for dromaeo_css test... 10:10:49 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmp7HaIrF/profile http://localhost:52938/getInfo.html) 10:10:52 INFO - PID 1936 | 2017-04-09 10:10:52.520 plugin-container[1938:20816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 10:10:52 INFO - PID 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:10:52 INFO - PID 1936 | 2017-04-09 10:10:52.523 plugin-container[1938:20816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1b, name = 'com.apple.CFPasteboardClient' 10:10:52 INFO - PID 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:10:52 INFO - PID 1936 | 2017-04-09 10:10:52.523 plugin-container[1938:20816] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:10:52 INFO - PID 1936 | __metrics Screen width/height:1600/1200 10:10:52 INFO - PID 1936 | colorDepth:24 10:10:52 INFO - PID 1936 | Browser inner width/height: 1024/689 10:10:52 INFO - PID 1936 | __metrics 10:10:52 ERROR - PID 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 10:10:53 INFO - TEST-INFO | 1936: exit 0 10:10:53 INFO - Browser initialized. 10:10:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:53 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmp7HaIrF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:56 INFO - PID 1939 | 2017-04-09 10:10:56.460 plugin-container[1940:20942] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:10:56 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:10:56 INFO - PID 1939 | 2017-04-09 10:10:56.461 plugin-container[1940:20942] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471f, name = 'com.apple.CFPasteboardClient' 10:10:56 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:10:56 INFO - PID 1939 | 2017-04-09 10:10:56.461 plugin-container[1940:20942] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:11:06 INFO - PID 1939 | RSS: Main: 233758720 10:11:06 INFO - PID 1939 | 10:14:10 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52938/tests/dromaeo/cssquery-ext.html) 10:14:11 INFO - PID 1939 | RSS: Main: 254017536 10:14:11 INFO - PID 1939 | 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | A coding exception was thrown and uncaught in a Task. 10:15:54 INFO - PID 1939 | 10:15:54 ERROR - PID 1939 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:15:54 INFO - PID 1939 | Full stack: 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | A coding exception was thrown and uncaught in a Task. 10:15:54 INFO - PID 1939 | 10:15:54 ERROR - PID 1939 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:15:54 INFO - PID 1939 | Full stack: 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | A coding exception was thrown and uncaught in a Task. 10:15:54 INFO - PID 1939 | 10:15:54 ERROR - PID 1939 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:15:54 INFO - PID 1939 | Full stack: 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | ************************* 10:15:54 INFO - PID 1939 | A coding exception was thrown and uncaught in a Task. 10:15:54 INFO - PID 1939 | 10:15:54 ERROR - PID 1939 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:15:54 INFO - PID 1939 | Full stack: 10:15:54 INFO - PID 1939 | ************************* 10:17:13 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-ext.html (next: http://localhost:52938/tests/dromaeo/cssquery-jquery.html) 10:17:14 INFO - PID 1939 | RSS: Main: 259805184 10:17:14 INFO - PID 1939 | 10:20:15 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52938/tests/dromaeo/cssquery-mootools.html) 10:20:16 INFO - PID 1939 | RSS: Main: 272314368 10:20:16 INFO - PID 1939 | 10:23:18 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52938/tests/dromaeo/cssquery-prototype.html) 10:23:19 INFO - PID 1939 | RSS: Main: 265531392 10:23:19 INFO - PID 1939 | 10:26:22 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52938/tests/dromaeo/cssquery-yui.html) 10:26:22 INFO - PID 1939 | RSS: Main: 275841024 10:26:22 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-yui.html (next: http://localhost:52938/tests/dromaeo/cssquery-dojo.html) 10:29:24 INFO - PID 1939 | RSS: Main: 270127104 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | __start_tp_report 10:29:24 INFO - PID 1939 | _x_x_mozilla_page_load 10:29:24 INFO - PID 1939 | _x_x_mozilla_page_load_details 10:29:24 INFO - PID 1939 | |i|pagename|runs| 10:29:24 INFO - PID 1939 | |0;dojo.html;2918.3287843795924;3547.379208638489;3578.4274516077435;3578.7852728836274;3598.265318358047;6052.878942421149;6168.907466388002;6180.3201647818705;6180.845478863031;6218.284897236819;6064.696765161746;6101.974255744801;6106.297775755789;6132.1721567588365;6216.471599914002;5089.898202035957;5391.056565101092;5436.782528698857;5484.287042684446;5487.890242195153;5357.357117145929;5459.890802183954;5495.972520137394;5503.367112782042;5509.614326997112;5481.972590137064;5482.369527504348;5491.505764481196;5497.367802702681;5572.5263352614875;4335.826566937319;5281.996420680059;5352.5182733553775;5363.490468405495;5400.243965844785;4368.759718215497;5370.9731451342495;5383.219433182206;5386.434424385461;5433.565314774809;5213.426523082458;5672.971635141839;6045.153678485016;6169.784057557964;6226.315105338409;5334.199870019489;6342.619442833445;6399.008153736178;6531.4448271896945;6575.967120164369;6647.734090636369;6663.666816659196;6665.466762658975;6670.598584509573;6675.399214070757;6236.906446403307;6271.43557079865;6316.557840951089;6317.4946004319545;6325;6585.967070164618;6643;6762.966185169141;6851.45188384928;6896.2069362023;6269.7492100316385;6389.393007664265;6457.2574153971955;6458.741650333934;6489.5781774184525;6442.871142577123;6485.319041500669;6555.115059467006;6640.501962352843;6648.13574235356;6370.490360771128;6537.901931470937;6565.080888675589;6573.5398522103;6585.2426970898005;6361.173047503795;6532.248791389051;6582.605043697394;6582.703778329987;6611.272759996396;5240.292560504359;5247.606429517801;5257.553107985864;5258.842234732964;5287.20691896211;4660;4721.7403042832975;4740.502247264057;4752.073345697625;4785.976070119627;6159.907601385983;6319.115323854664;6346.048092786119;6365;6383.808485745435;6413.551051426449;6508.9023664645065;6611.173603299588;6630.204375474974;6707.731690732414;6159.599626024294;6289.685515724195;6331.398517140864;6343.460805831556;6371.681415929185;5819.476247137778;5849.327327357409;5854.356020837705;5862.765489380377;5895.793647222413;6522.315156908646;6720.6639668016405;6779.457643388419;6841.589504629738;6844.4182244509775;6529.183852018497;6560;6586.506012049212;6639.900401493885;6691.230508491586;6792.626405547742;6807.863842723217;6821.488388370992;6838.487113466411;6852.931470685428;6541.149650545399;6559;6595.307492713388;6596.2744098148205;6608.867822643424;5830.2420685310635;6398.328175541687;6494.512911531559;6620.702068406837;6638.20341559016;6416.069669897745;6432.9678351607945;6447.355264473703;6449.064885591657;6469.611823290617;6269.811905642838;6339.461145802474;6389.009703495965;6443.7744678936015;6447.677616119269;5111.361079865017;5259.8422047338645;6331.683415829098;6345.524085693683;6361.554691171574;5366.221897824872;6296.811095667137;6420.935790642034;6488.513361498001;6504.869902602016;6224.37756224374;6283.2774230962195;6308.369163083655;6337.8732425352155;6372.968135159294 10:29:24 INFO - PID 1939 | |1;ext.html;627.3600927054405;782.6869252299082;826.7685048186506;1291.5608693044362;1296.0668318810465;37950.24099518008;38569.61430385695;38660.420093698616;38686.03284917879;38822.029449263784;33307.500387494205;36878.52485900567;38137.85586432411;38441.80779096101;38587.421188682194;8168.673253069885;8280.461769984962;8525.74422767318;8749.737507874774;8804.20762131408;8622.611982460772;8722.171393717586;8728.389012769108;8737.08260632634;8741.082186370435;7285.708571657127;7382.48322617417;8611.655533778641;8683.478991260514;8716.607752651114;8588.895720548444;8671.089535598767;8697.304215662733;8718.607662655164;8784.51685157316;8565.357598180099;8627.482351058894;8635.956820215859;8636.481811091355;8644.65421383144;37695;37711.86864394045;37912;38008.61991380106;38020;3036.4079004594114;3646.908827279313;3655.5796083450214;3694.039549717066;3699.6115407882053;30564.694353056406;30740.692593074007;30744.38511229763;30827.7668893244;30912.845435772902;3144.827034513101;3177.9046628601177;3185.0604071798643;3195.4887218045;3196.360727854438;233563;239437.2253248608;258369.9999999981;277506;278164;47033.76483117563;47119.822004449474;47131.5286847134;47199.292010619865;47241.5275847244;48134.518654813;48364.27453588199;48941.51058489441;48976.510234897905;49142.52572422833;11731.35477548743;14147.717045659028;14211.715765684836;14226.644333891736;14231.430742770173;11649.41752912351;11656.18406711522;11664.533418663159;11669.649910502698;11709.941450292694;13150.276734779487;13229.933850330879;13272.270025148517;13292;13448.93275533616;5759.568032397587;5835.854103647443;5839.394166604217;5850.210221620112;5873.3245676746865;903.6069309850236;984.4437892590663;996.5515518016921;1036.6268143468346;1071.5124618298655;23884.164054258017;24040.797960101925;24059.037638494265;24076.759232407803;24128.276151715476;975.5512464266375;1119.9496022679;1133.3879704959395;1145.4673576786668;1166.7199872030822;11443.828342574869;12252.693682658004;12487.562935297221;12580.056495762672;12589.181703189264;381391;383597;383988;385443.0727846343;386474;54762.72618636881;55000.72499637476;55031;55050.17424738632;55356.44643553594;1483.4140514496714;1510.1014896136562;1549.8372670869621;1552.1152942822482;1571.701376738416;23486.412839679146;23632.05471781178;23638;23679.52640947206;23688.644670329613;30732;37695;37770.86687399382;37857;38064.048398790255;233912;234200;234260;235338;235661;30197.547036794906;31886.36227275488;33066.66933330636;33744.83127584346;36061.45907811332;43899.56100438955;44860;44890.55109448994;44948.55051449574;45163.54836451593;27139.72860271372;29400.55899161557;30030.549541756453;30883.536746948364;30981.225469362544;29896;30709.69290307068;30816;30859;31153.53269700911;36034.63965360313;36395.818020909726;36428.63571364358;36443.817780910926;37040.25919481649;31018.68981310158;31262;31855;31909.20226994344;31913.521297180097;22704.091836326363;23888.761112389348;24147.517049658556;24496.897639606617;24996.62505062389 10:29:24 INFO - PID 1939 | |2;jquery.html;414.2047269243055;429.60905575925915;439.46604875076787;458.9334546490759;459.9701019433739;17642.735358969625;20337.59324813503;22324.43728938975;22603.321900342973;22919.42701432465;22104;22744.86275686213;22908.312750617508;22914.770852291473;23184.768152318473;5988;6016.548758843082;6264.060390941349;6276.121343011982;6278.560500764948;5905.793297234576;6115.938840611581;6150.354212807658;6154.046122850965;6171.0434882593045;5022.522860328281;6031.758729650831;6106.511479081662;6112.358202388752;6117.724702388403;5956.285245770492;6064.818055458343;6115.633062016271;6129.448349648553;6149.846253843645;5351;5419.187121931703;5437.646552974044;5558.805441809517;5616.634918730269;27710.475923824182;27850.860745696344;27868;27926.02258920928;27999.30001749952;2168.0785666092006;2247.449374903143;2253.2226381898217;2253.3690566641367;2257.593633146033;17426;17513;17561;17981.01104439255;18133;2141.389703934371;2166.8483206175574;2187.595294870454;2189.2337681811396;2194.890255487235;160444.19777901037;160888;163185.18407408005;164546;166154.1692291543;10176.575279460882;12163.331016794162;12251.081168912368;12446.25322480654;12571.93714031424;11623.709407264885;12871.742565148645;15973.920130399274;16180.330245509595;16182;6879.484038697117;7972.684507056387;8257.710980115788;8577.485350878967;8995;6774.932250677529;8358.958205208935;8394.370422218235;8510.829783404297;8530.914690853013;7680.155182929873;7776.494527855672;7809.726659566888;7828.804279892935;7831.373490120776;1979.8714732602277;2159.7732238115086;2167.6315026445227;2170.7395112586273;2370.6088495398412;889.7775556110972;913.3104506097986;936.7143021378408;991.5389343955095;992.4025407896376;20233.08951097204;20464.181432742524;20526;20682.17271309131;20730.689039664416;997.5760301871676;1001.2728044123974;1004.4977511244377;1021.8160731068479;1037.6368271105205;10094.495275236355;10622.521986510472;10676.89323106759;10679.626213082505;10686.625968091079;615001.9249903722;681953.7218511304;711621;738355.1575694825;739056;128657;156631.21684391506;156640;156752.86494270278;160152.1992390054;1165.2650202370178;1180.887815657511;1205.6322821539338;1206.9396530173456;1211.6243964371074;14355.779758720626;21132.577348452636;22563.88718056465;22746;22873.771262287166;45318.54681453143;47303.763481182374;63444.365556343844;64529.35470645234;64602.676986614766;80435;81339;82370;85174;85528;8847.071057538866;8884.156005179497;8901.51041692713;9054.868141482315;9207.079292070739;14274.571762847132;14324.283785810876;14431;14560.980731349127;14618.049826761226;11743.354115523729;11884.524619015143;12077.818832717692;12138.635840924786;12191.878081219429;9172.724818255463;11341.943290283496;11380.94309528447;11519;11780.410979451164;11676.241044332091;12081.516739330329;12106.699727051831;12374.257544547356;12507.249565025764;8835.293176545732;8975.955120224357;8978.910210897808;9099.818003640023;9111.681091161778;11821.645350639494;11912.76174476523;11925.10561707858;12136;12271.141020128505 10:29:24 INFO - PID 1939 | |3;mootools.html;1327.6614463311855;1403.796449514821;1405.0445696926092;1421.3959067396354;1438.935247913844;9718.757031074227;12038.518459261619;12044.337561434118;12070.456829442684;12390.504379824819;12052.939735301334;12204.877951220507;12231.327276999762;12255.203411778228;12309.876901230986;2559.2706078767555;2559.9104031358906;2563.2310306907852;2567.7817385522158;2569.6530968319225;2470.3700556358103;2474.6782918220697;2493.925182244536;2505.8245922785413;2508.3102146909655;2445.596476581362;2516.2828593850754;2517.2699917024133;2524.3815265259946;2525.7726804587583;2284.0407029047756;2307.8730669813153;2330.359151233416;2448.0574978633176;2534.9493010139877;2320.756320586348;2357.976420235793;2428.2229686500327;2468.8642124683133;2543.1480454047914;11826.408679565988;11905.583304584385;11955.342456164908;12030.398480076048;12044.337561434118;6625.138731964814;6822;6866.519343645947;6871.4502839772695;6924.792256232321;4022.6781857451333;4335.1763164998865;4341.175176716414;4410;4411.889702757457;1232.975340493185;1240.3054289597765;1269.6698858296818;1282.448547124736;1290.9483620655162;14928.32822522989;15474.922625386913;16502.33990640373;16641.750373744402;16656.83343166565;5470.425605311465;5603.411641777636;5837;5839.240898683229;5846.356900740915;11426.97157255851;12456.81314780279;12481.500739970299;12500.312482813351;12563.623091307276;6093.573449858556;6604.1084453599115;6663.666816659244;6675.065490831287;6690.364415380531;6014.488768454643;6233.376662333821;6237.282712488122;6269.279032911182;6269.874602508015;3792.488014118059;4041.312976793952;4136.01803006661;4254.914996675828;4446.4886538047895;1296.708240645866;1301.264785396248;1302.160106731153;1316.2760481735008;1317.8220940172953;761.162721006888;762.9547519897776;780.2782426255691;780.5979920341028;781.1290411191594;6482.837929051717;6833.077534532775;6842.418394436529;7045;7049.718011279491;823.3989187892872;897.2507955856802;929.1544694328129;937.9577918993662;937.962481500746;3778;4052.615001574846;4094.61101195386;4107.97946010274;4206.305959516645;14842.628934276514;15407.691846163014;15437.614059648598;15476.845231547766;15505.069695818287;15176.924115379352;15190.772138417933;15358.539243822703;15412.998155119882;15433.074015559103;11040.447977601249;11057.944710276397;11156.274842135235;11190.66428007161;11220.607278745369;5349.598780091586;5856.472917437451;6661.966690166518;6827.931720682928;6837.1111755471475;12515.499380024698;12882.742345153232;12914.547990820276;12976.870231297566;13007.609771706864;13136.60590182296;13219.867801322249;13286.80069798973;13474.393652285475;13493.257870817199;8732.432391894507;8799.12008799115;8806.735797926072;8818;8843.646254149762;10711.571537138427;10773.622923197963;10849.132069434268;10855.565777368816;10872.456377181268;8653.221210091122;8816.86774698393;8868.15752503511;8908.73273801787;8993.370464067713;8609.966803983312;8621.65513379483;8680.739577812676;8726.083761204982;8846.380753347205;6161.44546990773;8069.798255043671;8100.513969161869;8222.136675648972;8265.83468330618;5620.847726216034;5640.774369025193;5845.970770146122;5990.371011043778;6190.7523699051535;5388.46115388458;5971.373005834324;6015.2781666200335;6137.110119032626;6286.057091436322 10:29:24 INFO - PID 1939 | |4;prototype.html;391.8824352694191;407.96736261099113;408.0472097651983;411.15097324025885;411.62336462137125;4601.332806743028;6071.60534565253;6078.9392106078985;6091.969540152299;6120;5335.439778823226;5876.412358764122;5922.5489755010085;5953.136795164699;5968.552358573113;3764.5482542094987;4580.702254353473;4620.491745907947;4625.5836974672275;4625.907481850361;3770.7549009314307;4636.420447444069;4637.46669133049;4662.300654901758;4679.485256621769;3846.788426636534;3870.2453021660785;4405.933910991338;4412.580804823553;4436.733795972236;4375.343698445226;4404.603585677304;4406.5593440656;4411.1618792429335;4414.3378493225955;3221.4040402525607;3312.403767321881;3762.3039737648623;3783.2622638585485;3817.2365526894455;4211.368294755781;4918.04098200851;5724.685142317171;5778.5377169826315;5852.209951656514;4968.850934471971;5267.47325267474;5291.444398338158;5315.548178404841;5338.332708411449;6393.976963685835;6402.8719425611225;6411.691790955252;6439.903401448982;6442.355764423567;4097.405876147972;4276.508201556799;4320.675949303783;4337.375887587996;4353.434053573015;6536.9673151634415;6666.500012499082;6719.899201511932;6740.797776066677;6755.898661520081;4316.956830431655;4332.371806088099;4356.259435895905;4357.694961352739;4402.449693788277;3328.400887840212;4120.443740095108;4438.778061096932;4445.444319460067;4461.925204779793;4987.4015118185325;5158.252053452228;5223.869403264873;5249.973750131225;5255.290535777621;6383.776567820104;6394.552381333262;6446.580972236789;6467.741290348334;6469.708863101172;1412.258564253775;1486.7769834524909;1512.568917858405;1517.6888737808722;1532.3986434176313;939.1021509108366;941.463365881441;995.8456439251928;1012.7518757904213;1018.0888105146001;5836.795712150054;6130.049842274455;6136.355682653347;6164.4760195383;6197.6055387538345;6571.704273307617;6604.3395660434535;6606.4415553269055;6634.13756211699;6651.66741662915;4802.495737947535;5110.029094472038;5402.487843152874;5865.9441300566305;6107;2529.519391315644;2755.9448811023667;3430.2281986552825;3477.3914564951538;3486.3550243205086;5469.781208751685;5638.859028524238;6474.384933431316;6720.219141927393;6847.760328388483;5054.519820617035;5668.922904648103;5678.5741069419955;6783.796486105326;6798.566723804546;6468.2561505427475;6766.8646627068165;6876.793696189123;6878.209005964378;6908.92911598703;5755.395683453177;6484.902726459012;6522;6552.541322107407;6639.767608133692;6116.14373987651;6485.254195767548;6510.7721229756735;6527.445167160845;6538.411542961157;5053.761828352077;5670.914936276042;6166.660833654192;6767.898481522682;6818.522703410714;4183.811728472165;4350.58669426404;4351.260285751493;4356.891077723082;4365.628921541577;5770.278715160605;6302.243730752156;6606.174228221473;6633.2371777246235;6635.535512514078;5442.938626967703;6093.725782339894;6486.318936511787;6487.967560162169;6510.902336465051;5577.9442205577425;6284.245890492987;6432.163818703539;6450.677466126581;6464.612123272619;5442.809501667422;5459.590530710292;6258.937410625836;6307.653079080695;6375.776847810304;6433;6440.645764482811;6468.5472016958365;6497.512686548623;6533.509986751108;6020.578559500793;6195.2875419325555;6256.843578910563;6268;6336.651484168415 10:29:24 INFO - PID 1939 | |5;yui.html;829.4318391901544;837.6188834080493;847.809242920343;870.0646804684965;872.1104473437092;13763.65590860229;14416.062955907859;16408.26162822673;16434.42479513216;16801.991880487163;15680.76478852818;17267.91366043168;17294.56763580908;17662;17761.7335739964;992.5037481259352;1016.5730393234822;1018.2973748113815;1019.383273119763;1025;1002.3033991375996;1022.9539670714836;1028.1209565821227;1031.7111208861531;1033.6227277043863;1069.6577095329499;1076.1552181537495;1076.5263284154985;1082.821334479814;1085.3433672628064;1053.2416660004785;1071.6410002649122;1073.8926107389277;1074.623881641427;1078.8489611454443;796.7530065679658;797.0594698256056;797.9920200798034;801.4069588504465;803.935685145187;14171;14209.218492982882;16389.672206555922;17034.933711931848;17048.573785655335;14117.78823317651;15744.055356678637;16593.585160370967;16810.159492025472;16947.57631059221;11220.382878941655;13532.32338383077;13751.243681597509;13962.092463989808;13985.090969086978;3448.827558622059;3452.033430639425;3456.7061799747053;3480.617132115465;3480.6519348065244;81274.59362703208;101716;102731.97268027299;102756.48621756918;102929.48535257275;11926.403679815974;12049.457774400173;12117.69705757363;12172.57395991136;12274;20169.39491815248;20183.69724454105;20223.59552808965;20392.796072039386;20400.591988160155;8966.058563850833;9193.448393096436;9217.861732074025;9231.215346695471;9242.81514369709;4157.501099868035;4230.450041494648;4934.18585933317;4950.628702847301;4954.281629163823;3425.3149370126075;4170.457840480779;4319.697621166488;4323.48118225815;4332.393464914914;894.0924961164424;923.1368670293298;925.7639301978087;929.4376901974208;930.1721467893581;655.1744801549986;655.7442597387023;666.5667316244383;671.8891382921763;691.1257259566652;10845.295055821347;11920.701982450335;12002.979746721452;12059.095567832448;12108.21296615717;663.3797399431451;665.9134312539339;667.2626747444101;679.3851564334285;693.9271376505495;5386.730663466811;5407.918881216706;5422.457754224625;5512.5589952804485;5541.418151094158;97854;98175;99192.50403747935;100041;100314.4984275074;69574.65212673905;86691;90816;91985;92562;59496;60613.69693151506;71241.03938172938;72263.27736722566;79587;12097.818532722193;12680.556180533637;12690.746185076063;12722.491100355883;12736.23582585048;35785;39203.235854386054;39264.41103383509;40093.79953100332;40100.598994009684;36417.90447811966;45104;45514.54485455103;45723.62829114999;46182;13653.726925461633;15607.297671605033;15819.446319378767;16852.241649126063;16899.408520701716;17899.37352192667;18040.097995100456;18478.81521184771;18483.72274415858;18532.351367702067;16781.496555103367;17169.74245386345;17222;17287;17383.47849564515;16131.919340403692;16254.51236462908;16807.579810504834;16840.915795420944;17352.219150138022;16106.27521761547;16146.919265403598;16468.42360517376;16766.497005089866;16934.237959292106;11625.825612615987;11704.356260405759;12243.32661703615;12332.19840710351;12350.44423000949;12446.688832779253;13001.414936328078;13042.673933151747;13073.542426015043;13188.604341869759 10:29:24 INFO - PID 1939 | __end_tp_report 10:29:24 INFO - PID 1939 | __start_cc_report 10:29:24 INFO - PID 1939 | _x_x_mozilla_cycle_collect,424 10:29:24 INFO - PID 1939 | __end_cc_report 10:29:24 INFO - PID 1939 | __startTimestamp1491758964700__endTimestamp 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | ------- Summary: start ------- 10:29:24 INFO - PID 1939 | Number of tests: 6 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#0] dojo.html Cycles:165 Average:6049.99 Median:6337.87 stddev:735.65 (11.6%) stddev-sans-first:695.68 10:29:24 INFO - PID 1939 | Values: 2918.3 3547.4 3578.4 3578.8 3598.3 6052.9 6168.9 6180.3 6180.8 6218.3 6064.7 6102.0 6106.3 6132.2 6216.5 5089.9 5391.1 5436.8 5484.3 5487.9 5357.4 5459.9 5496.0 5503.4 5509.6 5482.0 5482.4 5491.5 5497.4 5572.5 4335.8 5282.0 5352.5 5363.5 5400.2 4368.8 5371.0 5383.2 5386.4 5433.6 5213.4 5673.0 6045.2 6169.8 6226.3 5334.2 6342.6 6399.0 6531.4 6576.0 6647.7 6663.7 6665.5 6670.6 6675.4 6236.9 6271.4 6316.6 6317.5 6325.0 6586.0 6643.0 6763.0 6851.5 6896.2 6269.7 6389.4 6457.3 6458.7 6489.6 6442.9 6485.3 6555.1 6640.5 6648.1 6370.5 6537.9 6565.1 6573.5 6585.2 6361.2 6532.2 6582.6 6582.7 6611.3 5240.3 5247.6 5257.6 5258.8 5287.2 4660.0 4721.7 4740.5 4752.1 4786.0 6159.9 6319.1 6346.0 6365.0 6383.8 6413.6 6508.9 6611.2 6630.2 6707.7 6159.6 6289.7 6331.4 6343.5 6371.7 5819.5 5849.3 5854.4 5862.8 5895.8 6522.3 6720.7 6779.5 6841.6 6844.4 6529.2 6560.0 6586.5 6639.9 6691.2 6792.6 6807.9 6821.5 6838.5 6852.9 6541.1 6559.0 6595.3 6596.3 6608.9 5830.2 6398.3 6494.5 6620.7 6638.2 6416.1 6433.0 6447.4 6449.1 6469.6 6269.8 6339.5 6389.0 6443.8 6447.7 5111.4 5259.8 6331.7 6345.5 6361.6 5366.2 6296.8 6420.9 6488.5 6504.9 6224.4 6283.3 6308.4 6337.9 6373.0 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#1] ext.html Cycles:180 Average:44346.21 Median:36048.05 stddev:78875.15 (218.8%) stddev-sans-first:79028.11 10:29:24 INFO - PID 1939 | Values: 627.4 782.7 826.8 1291.6 1296.1 37950.2 38569.6 38660.4 38686.0 38822.0 33307.5 36878.5 38137.9 38441.8 38587.4 8168.7 8280.5 8525.7 8749.7 8804.2 8622.6 8722.2 8728.4 8737.1 8741.1 7285.7 7382.5 8611.7 8683.5 8716.6 8588.9 8671.1 8697.3 8718.6 8784.5 8565.4 8627.5 8636.0 8636.5 8644.7 37695.0 37711.9 37912.0 38008.6 38020.0 3036.4 3646.9 3655.6 3694.0 3699.6 30564.7 30740.7 30744.4 30827.8 30912.8 3144.8 3177.9 3185.1 3195.5 3196.4 233563.0 239437.2 258370.0 277506.0 278164.0 47033.8 47119.8 47131.5 47199.3 47241.5 48134.5 48364.3 48941.5 48976.5 49142.5 11731.4 14147.7 14211.7 14226.6 14231.4 11649.4 11656.2 11664.5 11669.6 11709.9 13150.3 13229.9 13272.3 13292.0 13448.9 5759.6 5835.9 5839.4 5850.2 5873.3 903.6 984.4 996.6 1036.6 1071.5 23884.2 24040.8 24059.0 24076.8 24128.3 975.6 1119.9 1133.4 1145.5 1166.7 11443.8 12252.7 12487.6 12580.1 12589.2 381391.0 383597.0 383988.0 385443.1 386474.0 54762.7 55000.7 55031.0 55050.2 55356.4 1483.4 1510.1 1549.8 1552.1 1571.7 23486.4 23632.1 23638.0 23679.5 23688.6 30732.0 37695.0 37770.9 37857.0 38064.0 233912.0 234200.0 234260.0 235338.0 235661.0 30197.5 31886.4 33066.7 33744.8 36061.5 43899.6 44860.0 44890.6 44948.6 45163.5 27139.7 29400.6 30030.5 30883.5 30981.2 29896.0 30709.7 30816.0 30859.0 31153.5 36034.6 36395.8 36428.6 36443.8 37040.3 31018.7 31262.0 31855.0 31909.2 31913.5 22704.1 23888.8 24147.5 24496.9 24996.6 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#2] jquery.html Cycles:180 Average:40649.73 Median:22745.43 stddev:117398.86 (516.1%) stddev-sans-first:117689.32 10:29:24 INFO - PID 1939 | Values: 414.2 429.6 439.5 458.9 460.0 17642.7 20337.6 22324.4 22603.3 22919.4 22104.0 22744.9 22908.3 22914.8 23184.8 5988.0 6016.5 6264.1 6276.1 6278.6 5905.8 6115.9 6150.4 6154.0 6171.0 5022.5 6031.8 6106.5 6112.4 6117.7 5956.3 6064.8 6115.6 6129.4 6149.8 5351.0 5419.2 5437.6 5558.8 5616.6 27710.5 27850.9 27868.0 27926.0 27999.3 2168.1 2247.4 2253.2 2253.4 2257.6 17426.0 17513.0 17561.0 17981.0 18133.0 2141.4 2166.8 2187.6 2189.2 2194.9 160444.2 160888.0 163185.2 164546.0 166154.2 10176.6 12163.3 12251.1 12446.3 12571.9 11623.7 12871.7 15973.9 16180.3 16182.0 6879.5 7972.7 8257.7 8577.5 8995.0 6774.9 8359.0 8394.4 8510.8 8530.9 7680.2 7776.5 7809.7 7828.8 7831.4 1979.9 2159.8 2167.6 2170.7 2370.6 889.8 913.3 936.7 991.5 992.4 20233.1 20464.2 20526.0 20682.2 20730.7 997.6 1001.3 1004.5 1021.8 1037.6 10094.5 10622.5 10676.9 10679.6 10686.6 615001.9 681953.7 711621.0 738355.2 739056.0 128657.0 156631.2 156640.0 156752.9 160152.2 1165.3 1180.9 1205.6 1206.9 1211.6 14355.8 21132.6 22563.9 22746.0 22873.8 45318.5 47303.8 63444.4 64529.4 64602.7 80435.0 81339.0 82370.0 85174.0 85528.0 8847.1 8884.2 8901.5 9054.9 9207.1 14274.6 14324.3 14431.0 14561.0 14618.0 11743.4 11884.5 12077.8 12138.6 12191.9 9172.7 11341.9 11380.9 11519.0 11780.4 11676.2 12081.5 12106.7 12374.3 12507.2 8835.3 8976.0 8978.9 9099.8 9111.7 11821.6 11912.8 11925.1 12136.0 12271.1 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#3] mootools.html Cycles:180 Average:7160.91 Median:2561.57 stddev:4560.55 (178.0%) stddev-sans-first:4552.28 10:29:24 INFO - PID 1939 | Values: 1327.7 1403.8 1405.0 1421.4 1438.9 9718.8 12038.5 12044.3 12070.5 12390.5 12052.9 12204.9 12231.3 12255.2 12309.9 2559.3 2559.9 2563.2 2567.8 2569.7 2470.4 2474.7 2493.9 2505.8 2508.3 2445.6 2516.3 2517.3 2524.4 2525.8 2284.0 2307.9 2330.4 2448.1 2534.9 2320.8 2358.0 2428.2 2468.9 2543.1 11826.4 11905.6 11955.3 12030.4 12044.3 6625.1 6822.0 6866.5 6871.5 6924.8 4022.7 4335.2 4341.2 4410.0 4411.9 1233.0 1240.3 1269.7 1282.4 1290.9 14928.3 15474.9 16502.3 16641.8 16656.8 5470.4 5603.4 5837.0 5839.2 5846.4 11427.0 12456.8 12481.5 12500.3 12563.6 6093.6 6604.1 6663.7 6675.1 6690.4 6014.5 6233.4 6237.3 6269.3 6269.9 3792.5 4041.3 4136.0 4254.9 4446.5 1296.7 1301.3 1302.2 1316.3 1317.8 761.2 763.0 780.3 780.6 781.1 6482.8 6833.1 6842.4 7045.0 7049.7 823.4 897.3 929.2 938.0 938.0 3778.0 4052.6 4094.6 4108.0 4206.3 14842.6 15407.7 15437.6 15476.8 15505.1 15176.9 15190.8 15358.5 15413.0 15433.1 11040.4 11057.9 11156.3 11190.7 11220.6 5349.6 5856.5 6662.0 6827.9 6837.1 12515.5 12882.7 12914.5 12976.9 13007.6 13136.6 13219.9 13286.8 13474.4 13493.3 8732.4 8799.1 8806.7 8818.0 8843.6 10711.6 10773.6 10849.1 10855.6 10872.5 8653.2 8816.9 8868.2 8908.7 8993.4 8610.0 8621.7 8680.7 8726.1 8846.4 6161.4 8069.8 8100.5 8222.1 8265.8 5620.8 5640.8 5846.0 5990.4 6190.8 5388.5 5971.4 6015.3 6137.1 6286.1 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#4] prototype.html Cycles:180 Average:5129.41 Median:5740.04 stddev:1626.81 (28.3%) stddev-sans-first:1592.03 10:29:24 INFO - PID 1939 | Values: 391.9 408.0 408.0 411.2 411.6 4601.3 6071.6 6078.9 6092.0 6120.0 5335.4 5876.4 5922.5 5953.1 5968.6 3764.5 4580.7 4620.5 4625.6 4625.9 3770.8 4636.4 4637.5 4662.3 4679.5 3846.8 3870.2 4405.9 4412.6 4436.7 4375.3 4404.6 4406.6 4411.2 4414.3 3221.4 3312.4 3762.3 3783.3 3817.2 4211.4 4918.0 5724.7 5778.5 5852.2 4968.9 5267.5 5291.4 5315.5 5338.3 6394.0 6402.9 6411.7 6439.9 6442.4 4097.4 4276.5 4320.7 4337.4 4353.4 6537.0 6666.5 6719.9 6740.8 6755.9 4317.0 4332.4 4356.3 4357.7 4402.4 3328.4 4120.4 4438.8 4445.4 4461.9 4987.4 5158.3 5223.9 5250.0 5255.3 6383.8 6394.6 6446.6 6467.7 6469.7 1412.3 1486.8 1512.6 1517.7 1532.4 939.1 941.5 995.8 1012.8 1018.1 5836.8 6130.0 6136.4 6164.5 6197.6 6571.7 6604.3 6606.4 6634.1 6651.7 4802.5 5110.0 5402.5 5865.9 6107.0 2529.5 2755.9 3430.2 3477.4 3486.4 5469.8 5638.9 6474.4 6720.2 6847.8 5054.5 5668.9 5678.6 6783.8 6798.6 6468.3 6766.9 6876.8 6878.2 6908.9 5755.4 6484.9 6522.0 6552.5 6639.8 6116.1 6485.3 6510.8 6527.4 6538.4 5053.8 5670.9 6166.7 6767.9 6818.5 4183.8 4350.6 4351.3 4356.9 4365.6 5770.3 6302.2 6606.2 6633.2 6635.5 5442.9 6093.7 6486.3 6488.0 6510.9 5577.9 6284.2 6432.2 6450.7 6464.6 5442.8 5459.6 6258.9 6307.7 6375.8 6433.0 6440.6 6468.5 6497.5 6533.5 6020.6 6195.3 6256.8 6268.0 6336.7 10:29:24 INFO - PID 1939 | 10:29:24 INFO - PID 1939 | [#5] yui.html Cycles:180 Average:19831.43 Median:17323.39 stddev:26496.77 (153.0%) stddev-sans-first:26532.68 10:29:24 INFO - PID 1939 | Values: 829.4 837.6 847.8 870.1 872.1 13763.7 14416.1 16408.3 16434.4 16802.0 15680.8 17267.9 17294.6 17662.0 17761.7 992.5 1016.6 1018.3 1019.4 1025.0 1002.3 1023.0 1028.1 1031.7 1033.6 1069.7 1076.2 1076.5 1082.8 1085.3 1053.2 1071.6 1073.9 1074.6 1078.8 796.8 797.1 798.0 801.4 803.9 14171.0 14209.2 16389.7 17034.9 17048.6 14117.8 15744.1 16593.6 16810.2 16947.6 11220.4 13532.3 13751.2 13962.1 13985.1 3448.8 3452.0 3456.7 3480.6 3480.7 81274.6 101716.0 102732.0 102756.5 102929.5 11926.4 12049.5 12117.7 12172.6 12274.0 20169.4 20183.7 20223.6 20392.8 20400.6 8966.1 9193.4 9217.9 9231.2 9242.8 4157.5 4230.5 4934.2 4950.6 4954.3 3425.3 4170.5 4319.7 4323.5 4332.4 894.1 923.1 925.8 929.4 930.2 655.2 655.7 666.6 671.9 691.1 10845.3 11920.7 12003.0 12059.1 12108.2 663.4 665.9 667.3 679.4 693.9 5386.7 5407.9 5422.5 5512.6 5541.4 97854.0 98175.0 99192.5 100041.0 100314.5 69574.7 86691.0 90816.0 91985.0 92562.0 59496.0 60613.7 71241.0 72263.3 79587.0 12097.8 12680.6 12690.7 12722.5 12736.2 35785.0 39203.2 39264.4 40093.8 40100.6 36417.9 45104.0 45514.5 45723.6 46182.0 13653.7 15607.3 15819.4 16852.2 16899.4 17899.4 18040.1 18478.8 18483.7 18532.4 16781.5 17169.7 17222.0 17287.0 17383.5 16131.9 16254.5 16807.6 16840.9 17352.2 16106.3 16146.9 16468.4 16766.5 16934.2 11625.8 11704.4 12243.3 12332.2 12350.4 12446.7 13001.4 13042.7 13073.5 13188.6 10:29:24 INFO - PID 1939 | -------- Summary: end -------- 10:29:24 INFO - PID 1939 | 10:29:25 INFO - TEST-INFO | 1939: exit 0 10:29:25 INFO - TEST-OK | dromaeo_css | took 1115750ms 10:29:25 INFO - TEST-START | kraken 10:29:25 INFO - operating with platform_type : mac_ 10:29:25 INFO - Initialising browser for kraken test... 10:29:25 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpP9R4M7/profile http://localhost:52938/getInfo.html) 10:29:28 INFO - PID 1945 | 2017-04-09 10:29:28.382 plugin-container[1946:23271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 10:29:28 INFO - PID 1945 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:28 INFO - PID 1945 | 2017-04-09 10:29:28.385 plugin-container[1946:23271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 10:29:28 INFO - PID 1945 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:28 INFO - PID 1945 | 2017-04-09 10:29:28.385 plugin-container[1946:23271] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:29:28 INFO - PID 1945 | __metrics Screen width/height:1600/1200 10:29:28 INFO - PID 1945 | colorDepth:24 10:29:28 INFO - PID 1945 | Browser inner width/height: 1024/689 10:29:28 INFO - PID 1945 | __metrics 10:29:28 ERROR - PID 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 10:29:29 INFO - TEST-INFO | 1945: exit 0 10:29:29 INFO - Browser initialized. 10:29:29 INFO - Running cycle 1/1 for kraken test... 10:29:29 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpP9R4M7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:32 INFO - PID 1947 | 2017-04-09 10:29:32.242 plugin-container[1948:23394] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882f, name = 'com.apple.tsm.portname' 10:29:32 INFO - PID 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:32 INFO - PID 1947 | 2017-04-09 10:29:32.242 plugin-container[1948:23394] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 10:29:32 INFO - PID 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:29:32 INFO - PID 1947 | 2017-04-09 10:29:32.242 plugin-container[1948:23394] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:29:42 INFO - PID 1947 | RSS: Main: 234749952 10:29:42 INFO - PID 1947 | 10:29:45 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:46 INFO - PID 1947 | RSS: Main: 248762368 10:29:46 INFO - PID 1947 | 10:29:48 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-dft) 10:29:49 INFO - PID 1947 | RSS: Main: 257622016 10:29:49 INFO - PID 1947 | 10:29:53 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-fft) 10:29:53 INFO - PID 1947 | RSS: Main: 259833856 10:29:53 INFO - PID 1947 | 10:29:56 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator) 10:29:56 INFO - PID 1947 | RSS: Main: 262303744 10:29:56 INFO - PID 1947 | 10:29:58 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:59 INFO - PID 1947 | RSS: Main: 262422528 10:29:59 INFO - PID 1947 | 10:30:02 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:03 INFO - PID 1947 | RSS: Main: 268251136 10:30:03 INFO - PID 1947 | 10:30:06 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:07 INFO - PID 1947 | RSS: Main: 268308480 10:30:07 INFO - PID 1947 | 10:30:10 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial) 10:30:11 INFO - PID 1947 | RSS: Main: 265363456 10:30:11 INFO - PID 1947 | 10:30:12 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:13 INFO - PID 1947 | RSS: Main: 266702848 10:30:13 INFO - PID 1947 | 10:30:15 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:15 INFO - PID 1947 | RSS: Main: 267128832 10:30:15 INFO - PID 1947 | 10:30:18 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:19 INFO - PID 1947 | RSS: Main: 267304960 10:30:19 INFO - PID 1947 | 10:30:22 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:22 INFO - PID 1947 | RSS: Main: 267853824 10:30:22 INFO - PID 1947 | 10:30:26 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:26 INFO - PID 1947 | RSS: Main: 265662464 10:30:26 INFO - PID 1947 | 10:30:28 INFO - PID 1947 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52938/tests/kraken/driver.html?testName=ai-astar) 10:30:29 INFO - PID 1947 | RSS: Main: 268910592 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | __start_tp_report 10:30:29 INFO - PID 1947 | _x_x_mozilla_page_load 10:30:29 INFO - PID 1947 | _x_x_mozilla_page_load_details 10:30:29 INFO - PID 1947 | |i|pagename|runs| 10:30:29 INFO - PID 1947 | |0;ai-astar;153;183;123;124;121;121;129;179;120;171 10:30:29 INFO - PID 1947 | |1;audio-beat-detection;152;122;107;156;156;118;119;118;173;124 10:30:29 INFO - PID 1947 | |2;audio-dft;220;224;225;238;221;196;296;277;261;287 10:30:29 INFO - PID 1947 | |3;audio-fft;84;63;75;87;88;92;89;95;99;62 10:30:29 INFO - PID 1947 | |4;audio-oscillator;93;71;89;86;112;111;85;72;76;127 10:30:29 INFO - PID 1947 | |5;imaging-gaussian-blur;134;93;91;91;94;90;92;91;93;94 10:30:29 INFO - PID 1947 | |6;imaging-darkroom;100;101;155;100;107;102;102;158;101;101 10:30:29 INFO - PID 1947 | |7;imaging-desaturate;145;101;101;118;156;125;146;136;114;162 10:30:29 INFO - PID 1947 | |8;json-parse-financial;53;54;52;54;56;57;48;49;72;75 10:30:29 INFO - PID 1947 | |9;json-stringify-tinderbox;60;60;65;76;69;71;84;76;60;62 10:30:29 INFO - PID 1947 | |10;stanford-crypto-aes;93;106;83;103;85;100;114;103;86;116 10:30:29 INFO - PID 1947 | |11;stanford-crypto-ccm;148;147;153;162;142;143;139;167;230;187 10:30:29 INFO - PID 1947 | |12;stanford-crypto-pbkdf2;196;199;198;197;198;197;201;197;244;259 10:30:29 INFO - PID 1947 | |13;stanford-crypto-sha256-iterative;70;65;102;111;100;106;101;74;72;72 10:30:29 INFO - PID 1947 | __end_tp_report 10:30:29 INFO - PID 1947 | __start_cc_report 10:30:29 INFO - PID 1947 | _x_x_mozilla_cycle_collect,998 10:30:29 INFO - PID 1947 | __end_cc_report 10:30:29 INFO - PID 1947 | __startTimestamp1491759029094__endTimestamp 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | ------- Summary: start ------- 10:30:29 INFO - PID 1947 | Number of tests: 14 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#0] ai-astar Cycles:10 Average:142.40 Median:141.00 stddev:26.31 (18.7%) stddev-sans-first:27.63 10:30:29 INFO - PID 1947 | Values: 153.0 183.0 123.0 124.0 121.0 121.0 129.0 179.0 120.0 171.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:138.00 stddev:22.41 (16.2%) stddev-sans-first:22.86 10:30:29 INFO - PID 1947 | Values: 152.0 122.0 107.0 156.0 156.0 118.0 119.0 118.0 173.0 124.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#2] audio-dft Cycles:10 Average:244.50 Median:249.50 stddev:33.56 (13.4%) stddev-sans-first:34.40 10:30:29 INFO - PID 1947 | Values: 220.0 224.0 225.0 238.0 221.0 196.0 296.0 277.0 261.0 287.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#3] audio-fft Cycles:10 Average:83.40 Median:88.50 stddev:12.75 (14.4%) stddev-sans-first:13.52 10:30:29 INFO - PID 1947 | Values: 84.0 63.0 75.0 87.0 88.0 92.0 89.0 95.0 99.0 62.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:80.50 stddev:18.79 (23.3%) stddev-sans-first:19.93 10:30:29 INFO - PID 1947 | Values: 93.0 71.0 89.0 86.0 112.0 111.0 85.0 72.0 76.0 127.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:92.50 stddev:13.32 (14.4%) stddev-sans-first:1.45 10:30:29 INFO - PID 1947 | Values: 134.0 93.0 91.0 91.0 94.0 90.0 92.0 91.0 93.0 94.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:102.00 stddev:23.18 (22.7%) stddev-sans-first:24.13 10:30:29 INFO - PID 1947 | Values: 100.0 101.0 155.0 100.0 107.0 102.0 102.0 158.0 101.0 101.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#7] imaging-desaturate Cycles:10 Average:130.40 Median:140.50 stddev:21.91 (15.6%) stddev-sans-first:22.60 10:30:29 INFO - PID 1947 | Values: 145.0 101.0 101.0 118.0 156.0 125.0 146.0 136.0 114.0 162.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.00 stddev:9.15 (16.6%) stddev-sans-first:9.59 10:30:29 INFO - PID 1947 | Values: 53.0 54.0 52.0 54.0 56.0 57.0 48.0 49.0 72.0 75.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:70.00 stddev:8.37 (12.0%) stddev-sans-first:8.32 10:30:29 INFO - PID 1947 | Values: 60.0 60.0 65.0 76.0 69.0 71.0 84.0 76.0 60.0 62.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#10] stanford-crypto-aes Cycles:10 Average:98.90 Median:99.50 stddev:11.80 (11.9%) stddev-sans-first:12.32 10:30:29 INFO - PID 1947 | Values: 93.0 106.0 83.0 103.0 85.0 100.0 114.0 103.0 86.0 116.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:157.50 stddev:28.02 (17.8%) stddev-sans-first:29.27 10:30:29 INFO - PID 1947 | Values: 148.0 147.0 153.0 162.0 142.0 143.0 139.0 167.0 230.0 187.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.60 Median:198.50 stddev:22.93 (11.5%) stddev-sans-first:23.86 10:30:29 INFO - PID 1947 | Values: 196.0 199.0 198.0 197.0 198.0 197.0 201.0 197.0 244.0 259.0 10:30:29 INFO - PID 1947 | 10:30:29 INFO - PID 1947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.30 Median:67.50 stddev:18.01 (26.7%) stddev-sans-first:17.98 10:30:29 INFO - PID 1947 | Values: 70.0 65.0 102.0 111.0 100.0 106.0 101.0 74.0 72.0 72.0 10:30:29 INFO - PID 1947 | -------- Summary: end -------- 10:30:29 INFO - PID 1947 | 10:30:30 INFO - TEST-INFO | 1947: exit 0 10:30:30 INFO - TEST-OK | kraken | took 64821ms 10:30:30 INFO - SUITE-END | took 1180s 10:30:30 INFO - Completed test suite (00:19:40) 10:30:30 INFO - javascript benchmark 10:30:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7802.813033136966, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.3287843795924, 3547.379208638489, 3578.4274516077435, 3578.7852728836274, 3598.265318358047, 6052.878942421149, 6168.907466388002, 6180.3201647818705, 6180.845478863031, 6218.284897236819, 6064.696765161746, 6101.974255744801, 6106.297775755789, 6132.1721567588365, 6216.471599914002, 5089.898202035957, 5391.056565101092, 5436.782528698857, 5484.287042684446, 5487.890242195153, 5357.357117145929, 5459.890802183954, 5495.972520137394, 5503.367112782042, 5509.614326997112, 5481.972590137064, 5482.369527504348, 5491.505764481196, 5497.367802702681, 5572.5263352614875, 4335.826566937319, 5281.996420680059, 5352.5182733553775, 5363.490468405495, 5400.243965844785, 4368.759718215497, 5370.9731451342495, 5383.219433182206, 5386.434424385461, 5433.565314774809, 5213.426523082458, 5672.971635141839, 6045.153678485016, 6169.784057557964, 6226.315105338409, 5334.199870019489, 6342.619442833445, 6399.008153736178, 6531.4448271896945, 6575.967120164369, 6647.734090636369, 6663.666816659196, 6665.466762658975, 6670.598584509573, 6675.399214070757, 6236.906446403307, 6271.43557079865, 6316.557840951089, 6317.4946004319545, 6325.0, 6585.967070164618, 6643.0, 6762.966185169141, 6851.45188384928, 6896.2069362023, 6269.7492100316385, 6389.393007664265, 6457.2574153971955, 6458.741650333934, 6489.5781774184525, 6442.871142577123, 6485.319041500669, 6555.115059467006, 6640.501962352843, 6648.13574235356, 6370.490360771128, 6537.901931470937, 6565.080888675589, 6573.5398522103, 6585.2426970898005, 6361.173047503795, 6532.248791389051, 6582.605043697394, 6582.703778329987, 6611.272759996396, 5240.292560504359, 5247.606429517801, 5257.553107985864, 5258.842234732964, 5287.20691896211, 4660.0, 4721.7403042832975, 4740.502247264057, 4752.073345697625, 4785.976070119627, 6159.907601385983, 6319.115323854664, 6346.048092786119, 6365.0, 6383.808485745435, 6413.551051426449, 6508.9023664645065, 6611.173603299588, 6630.204375474974, 6707.731690732414, 6159.599626024294, 6289.685515724195, 6331.398517140864, 6343.460805831556, 6371.681415929185, 5819.476247137778, 5849.327327357409, 5854.356020837705, 5862.765489380377, 5895.793647222413, 6522.315156908646, 6720.6639668016405, 6779.457643388419, 6841.589504629738, 6844.4182244509775, 6529.183852018497, 6560.0, 6586.506012049212, 6639.900401493885, 6691.230508491586, 6792.626405547742, 6807.863842723217, 6821.488388370992, 6838.487113466411, 6852.931470685428, 6541.149650545399, 6559.0, 6595.307492713388, 6596.2744098148205, 6608.867822643424, 5830.2420685310635, 6398.328175541687, 6494.512911531559, 6620.702068406837, 6638.20341559016, 6416.069669897745, 6432.9678351607945, 6447.355264473703, 6449.064885591657, 6469.611823290617, 6269.811905642838, 6339.461145802474, 6389.009703495965, 6443.7744678936015, 6447.677616119269, 5111.361079865017, 5259.8422047338645, 6331.683415829098, 6345.524085693683, 6361.554691171574, 5366.221897824872, 6296.811095667137, 6420.935790642034, 6488.513361498001, 6504.869902602016, 6224.37756224374, 6283.2774230962195, 6308.369163083655, 6337.8732425352155, 6372.968135159294], "value": 6001.224323080005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3600927054405, 782.6869252299082, 826.7685048186506, 1291.5608693044362, 1296.0668318810465, 37950.24099518008, 38569.61430385695, 38660.420093698616, 38686.03284917879, 38822.029449263784, 33307.500387494205, 36878.52485900567, 38137.85586432411, 38441.80779096101, 38587.421188682194, 8168.673253069885, 8280.461769984962, 8525.74422767318, 8749.737507874774, 8804.20762131408, 8622.611982460772, 8722.171393717586, 8728.389012769108, 8737.08260632634, 8741.082186370435, 7285.708571657127, 7382.48322617417, 8611.655533778641, 8683.478991260514, 8716.607752651114, 8588.895720548444, 8671.089535598767, 8697.304215662733, 8718.607662655164, 8784.51685157316, 8565.357598180099, 8627.482351058894, 8635.956820215859, 8636.481811091355, 8644.65421383144, 37695.0, 37711.86864394045, 37912.0, 38008.61991380106, 38020.0, 3036.4079004594114, 3646.908827279313, 3655.5796083450214, 3694.039549717066, 3699.6115407882053, 30564.694353056406, 30740.692593074007, 30744.38511229763, 30827.7668893244, 30912.845435772902, 3144.827034513101, 3177.9046628601177, 3185.0604071798643, 3195.4887218045, 3196.360727854438, 233563.0, 239437.2253248608, 258369.9999999981, 277506.0, 278164.0, 47033.76483117563, 47119.822004449474, 47131.5286847134, 47199.292010619865, 47241.5275847244, 48134.518654813, 48364.27453588199, 48941.51058489441, 48976.510234897905, 49142.52572422833, 11731.35477548743, 14147.717045659028, 14211.715765684836, 14226.644333891736, 14231.430742770173, 11649.41752912351, 11656.18406711522, 11664.533418663159, 11669.649910502698, 11709.941450292694, 13150.276734779487, 13229.933850330879, 13272.270025148517, 13292.0, 13448.93275533616, 5759.568032397587, 5835.854103647443, 5839.394166604217, 5850.210221620112, 5873.3245676746865, 903.6069309850236, 984.4437892590663, 996.5515518016921, 1036.6268143468346, 1071.5124618298655, 23884.164054258017, 24040.797960101925, 24059.037638494265, 24076.759232407803, 24128.276151715476, 975.5512464266375, 1119.9496022679, 1133.3879704959395, 1145.4673576786668, 1166.7199872030822, 11443.828342574869, 12252.693682658004, 12487.562935297221, 12580.056495762672, 12589.181703189264, 381391.0, 383597.0, 383988.0, 385443.0727846343, 386474.0, 54762.72618636881, 55000.72499637476, 55031.0, 55050.17424738632, 55356.44643553594, 1483.4140514496714, 1510.1014896136562, 1549.8372670869621, 1552.1152942822482, 1571.701376738416, 23486.412839679146, 23632.05471781178, 23638.0, 23679.52640947206, 23688.644670329613, 30732.0, 37695.0, 37770.86687399382, 37857.0, 38064.048398790255, 233912.0, 234200.0, 234260.0, 235338.0, 235661.0, 30197.547036794906, 31886.36227275488, 33066.66933330636, 33744.83127584346, 36061.45907811332, 43899.56100438955, 44860.0, 44890.55109448994, 44948.55051449574, 45163.54836451593, 27139.72860271372, 29400.55899161557, 30030.549541756453, 30883.536746948364, 30981.225469362544, 29896.0, 30709.69290307068, 30816.0, 30859.0, 31153.53269700911, 36034.63965360313, 36395.818020909726, 36428.63571364358, 36443.817780910926, 37040.25919481649, 31018.68981310158, 31262.0, 31855.0, 31909.20226994344, 31913.521297180097, 22704.091836326363, 23888.761112389348, 24147.517049658556, 24496.897639606617, 24996.62505062389], "value": 17422.792319496246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.2047269243055, 429.60905575925915, 439.46604875076787, 458.9334546490759, 459.9701019433739, 17642.735358969625, 20337.59324813503, 22324.43728938975, 22603.321900342973, 22919.42701432465, 22104.0, 22744.86275686213, 22908.312750617508, 22914.770852291473, 23184.768152318473, 5988.0, 6016.548758843082, 6264.060390941349, 6276.121343011982, 6278.560500764948, 5905.793297234576, 6115.938840611581, 6150.354212807658, 6154.046122850965, 6171.0434882593045, 5022.522860328281, 6031.758729650831, 6106.511479081662, 6112.358202388752, 6117.724702388403, 5956.285245770492, 6064.818055458343, 6115.633062016271, 6129.448349648553, 6149.846253843645, 5351.0, 5419.187121931703, 5437.646552974044, 5558.805441809517, 5616.634918730269, 27710.475923824182, 27850.860745696344, 27868.0, 27926.02258920928, 27999.30001749952, 2168.0785666092006, 2247.449374903143, 2253.2226381898217, 2253.3690566641367, 2257.593633146033, 17426.0, 17513.0, 17561.0, 17981.01104439255, 18133.0, 2141.389703934371, 2166.8483206175574, 2187.595294870454, 2189.2337681811396, 2194.890255487235, 160444.19777901037, 160888.0, 163185.18407408005, 164546.0, 166154.1692291543, 10176.575279460882, 12163.331016794162, 12251.081168912368, 12446.25322480654, 12571.93714031424, 11623.709407264885, 12871.742565148645, 15973.920130399274, 16180.330245509595, 16182.0, 6879.484038697117, 7972.684507056387, 8257.710980115788, 8577.485350878967, 8995.0, 6774.932250677529, 8358.958205208935, 8394.370422218235, 8510.829783404297, 8530.914690853013, 7680.155182929873, 7776.494527855672, 7809.726659566888, 7828.804279892935, 7831.373490120776, 1979.8714732602277, 2159.7732238115086, 2167.6315026445227, 2170.7395112586273, 2370.6088495398412, 889.7775556110972, 913.3104506097986, 936.7143021378408, 991.5389343955095, 992.4025407896376, 20233.08951097204, 20464.181432742524, 20526.0, 20682.17271309131, 20730.689039664416, 997.5760301871676, 1001.2728044123974, 1004.4977511244377, 1021.8160731068479, 1037.6368271105205, 10094.495275236355, 10622.521986510472, 10676.89323106759, 10679.626213082505, 10686.625968091079, 615001.9249903722, 681953.7218511304, 711621.0, 738355.1575694825, 739056.0, 128657.0, 156631.21684391506, 156640.0, 156752.86494270278, 160152.1992390054, 1165.2650202370178, 1180.887815657511, 1205.6322821539338, 1206.9396530173456, 1211.6243964371074, 14355.779758720626, 21132.577348452636, 22563.88718056465, 22746.0, 22873.771262287166, 45318.54681453143, 47303.763481182374, 63444.365556343844, 64529.35470645234, 64602.676986614766, 80435.0, 81339.0, 82370.0, 85174.0, 85528.0, 8847.071057538866, 8884.156005179497, 8901.51041692713, 9054.868141482315, 9207.079292070739, 14274.571762847132, 14324.283785810876, 14431.0, 14560.980731349127, 14618.049826761226, 11743.354115523729, 11884.524619015143, 12077.818832717692, 12138.635840924786, 12191.878081219429, 9172.724818255463, 11341.943290283496, 11380.94309528447, 11519.0, 11780.410979451164, 11676.241044332091, 12081.516739330329, 12106.699727051831, 12374.257544547356, 12507.249565025764, 8835.293176545732, 8975.955120224357, 8978.910210897808, 9099.818003640023, 9111.681091161778, 11821.645350639494, 11912.76174476523, 11925.10561707858, 12136.0, 12271.141020128505], "value": 10551.951282234148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.6614463311855, 1403.796449514821, 1405.0445696926092, 1421.3959067396354, 1438.935247913844, 9718.757031074227, 12038.518459261619, 12044.337561434118, 12070.456829442684, 12390.504379824819, 12052.939735301334, 12204.877951220507, 12231.327276999762, 12255.203411778228, 12309.876901230986, 2559.2706078767555, 2559.9104031358906, 2563.2310306907852, 2567.7817385522158, 2569.6530968319225, 2470.3700556358103, 2474.6782918220697, 2493.925182244536, 2505.8245922785413, 2508.3102146909655, 2445.596476581362, 2516.2828593850754, 2517.2699917024133, 2524.3815265259946, 2525.7726804587583, 2284.0407029047756, 2307.8730669813153, 2330.359151233416, 2448.0574978633176, 2534.9493010139877, 2320.756320586348, 2357.976420235793, 2428.2229686500327, 2468.8642124683133, 2543.1480454047914, 11826.408679565988, 11905.583304584385, 11955.342456164908, 12030.398480076048, 12044.337561434118, 6625.138731964814, 6822.0, 6866.519343645947, 6871.4502839772695, 6924.792256232321, 4022.6781857451333, 4335.1763164998865, 4341.175176716414, 4410.0, 4411.889702757457, 1232.975340493185, 1240.3054289597765, 1269.6698858296818, 1282.448547124736, 1290.9483620655162, 14928.32822522989, 15474.922625386913, 16502.33990640373, 16641.750373744402, 16656.83343166565, 5470.425605311465, 5603.411641777636, 5837.0, 5839.240898683229, 5846.356900740915, 11426.97157255851, 12456.81314780279, 12481.500739970299, 12500.312482813351, 12563.623091307276, 6093.573449858556, 6604.1084453599115, 6663.666816659244, 6675.065490831287, 6690.364415380531, 6014.488768454643, 6233.376662333821, 6237.282712488122, 6269.279032911182, 6269.874602508015, 3792.488014118059, 4041.312976793952, 4136.01803006661, 4254.914996675828, 4446.4886538047895, 1296.708240645866, 1301.264785396248, 1302.160106731153, 1316.2760481735008, 1317.8220940172953, 761.162721006888, 762.9547519897776, 780.2782426255691, 780.5979920341028, 781.1290411191594, 6482.837929051717, 6833.077534532775, 6842.418394436529, 7045.0, 7049.718011279491, 823.3989187892872, 897.2507955856802, 929.1544694328129, 937.9577918993662, 937.962481500746, 3778.0, 4052.615001574846, 4094.61101195386, 4107.97946010274, 4206.305959516645, 14842.628934276514, 15407.691846163014, 15437.614059648598, 15476.845231547766, 15505.069695818287, 15176.924115379352, 15190.772138417933, 15358.539243822703, 15412.998155119882, 15433.074015559103, 11040.447977601249, 11057.944710276397, 11156.274842135235, 11190.66428007161, 11220.607278745369, 5349.598780091586, 5856.472917437451, 6661.966690166518, 6827.931720682928, 6837.1111755471475, 12515.499380024698, 12882.742345153232, 12914.547990820276, 12976.870231297566, 13007.609771706864, 13136.60590182296, 13219.867801322249, 13286.80069798973, 13474.393652285475, 13493.257870817199, 8732.432391894507, 8799.12008799115, 8806.735797926072, 8818.0, 8843.646254149762, 10711.571537138427, 10773.622923197963, 10849.132069434268, 10855.565777368816, 10872.456377181268, 8653.221210091122, 8816.86774698393, 8868.15752503511, 8908.73273801787, 8993.370464067713, 8609.966803983312, 8621.65513379483, 8680.739577812676, 8726.083761204982, 8846.380753347205, 6161.44546990773, 8069.798255043671, 8100.513969161869, 8222.136675648972, 8265.83468330618, 5620.847726216034, 5640.774369025193, 5845.970770146122, 5990.371011043778, 6190.7523699051535, 5388.46115388458, 5971.373005834324, 6015.2781666200335, 6137.110119032626, 6286.057091436322], "value": 5391.868802301782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.8824352694191, 407.96736261099113, 408.0472097651983, 411.15097324025885, 411.62336462137125, 4601.332806743028, 6071.60534565253, 6078.9392106078985, 6091.969540152299, 6120.0, 5335.439778823226, 5876.412358764122, 5922.5489755010085, 5953.136795164699, 5968.552358573113, 3764.5482542094987, 4580.702254353473, 4620.491745907947, 4625.5836974672275, 4625.907481850361, 3770.7549009314307, 4636.420447444069, 4637.46669133049, 4662.300654901758, 4679.485256621769, 3846.788426636534, 3870.2453021660785, 4405.933910991338, 4412.580804823553, 4436.733795972236, 4375.343698445226, 4404.603585677304, 4406.5593440656, 4411.1618792429335, 4414.3378493225955, 3221.4040402525607, 3312.403767321881, 3762.3039737648623, 3783.2622638585485, 3817.2365526894455, 4211.368294755781, 4918.04098200851, 5724.685142317171, 5778.5377169826315, 5852.209951656514, 4968.850934471971, 5267.47325267474, 5291.444398338158, 5315.548178404841, 5338.332708411449, 6393.976963685835, 6402.8719425611225, 6411.691790955252, 6439.903401448982, 6442.355764423567, 4097.405876147972, 4276.508201556799, 4320.675949303783, 4337.375887587996, 4353.434053573015, 6536.9673151634415, 6666.500012499082, 6719.899201511932, 6740.797776066677, 6755.898661520081, 4316.956830431655, 4332.371806088099, 4356.259435895905, 4357.694961352739, 4402.449693788277, 3328.400887840212, 4120.443740095108, 4438.778061096932, 4445.444319460067, 4461.925204779793, 4987.4015118185325, 5158.252053452228, 5223.869403264873, 5249.973750131225, 5255.290535777621, 6383.776567820104, 6394.552381333262, 6446.580972236789, 6467.741290348334, 6469.708863101172, 1412.258564253775, 1486.7769834524909, 1512.568917858405, 1517.6888737808722, 1532.3986434176313, 939.1021509108366, 941.463365881441, 995.8456439251928, 1012.7518757904213, 1018.0888105146001, 5836.795712150054, 6130.049842274455, 6136.355682653347, 6164.4760195383, 6197.6055387538345, 6571.704273307617, 6604.3395660434535, 6606.4415553269055, 6634.13756211699, 6651.66741662915, 4802.495737947535, 5110.029094472038, 5402.487843152874, 5865.9441300566305, 6107.0, 2529.519391315644, 2755.9448811023667, 3430.2281986552825, 3477.3914564951538, 3486.3550243205086, 5469.781208751685, 5638.859028524238, 6474.384933431316, 6720.219141927393, 6847.760328388483, 5054.519820617035, 5668.922904648103, 5678.5741069419955, 6783.796486105326, 6798.566723804546, 6468.2561505427475, 6766.8646627068165, 6876.793696189123, 6878.209005964378, 6908.92911598703, 5755.395683453177, 6484.902726459012, 6522.0, 6552.541322107407, 6639.767608133692, 6116.14373987651, 6485.254195767548, 6510.7721229756735, 6527.445167160845, 6538.411542961157, 5053.761828352077, 5670.914936276042, 6166.660833654192, 6767.898481522682, 6818.522703410714, 4183.811728472165, 4350.58669426404, 4351.260285751493, 4356.891077723082, 4365.628921541577, 5770.278715160605, 6302.243730752156, 6606.174228221473, 6633.2371777246235, 6635.535512514078, 5442.938626967703, 6093.725782339894, 6486.318936511787, 6487.967560162169, 6510.902336465051, 5577.9442205577425, 6284.245890492987, 6432.163818703539, 6450.677466126581, 6464.612123272619, 5442.809501667422, 5459.590530710292, 6258.937410625836, 6307.653079080695, 6375.776847810304, 6433.0, 6440.645764482811, 6468.5472016958365, 6497.512686548623, 6533.509986751108, 6020.578559500793, 6195.2875419325555, 6256.843578910563, 6268.0, 6336.651484168415], "value": 4629.576867249433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.4318391901544, 837.6188834080493, 847.809242920343, 870.0646804684965, 872.1104473437092, 13763.65590860229, 14416.062955907859, 16408.26162822673, 16434.42479513216, 16801.991880487163, 15680.76478852818, 17267.91366043168, 17294.56763580908, 17662.0, 17761.7335739964, 992.5037481259352, 1016.5730393234822, 1018.2973748113815, 1019.383273119763, 1025.0, 1002.3033991375996, 1022.9539670714836, 1028.1209565821227, 1031.7111208861531, 1033.6227277043863, 1069.6577095329499, 1076.1552181537495, 1076.5263284154985, 1082.821334479814, 1085.3433672628064, 1053.2416660004785, 1071.6410002649122, 1073.8926107389277, 1074.623881641427, 1078.8489611454443, 796.7530065679658, 797.0594698256056, 797.9920200798034, 801.4069588504465, 803.935685145187, 14171.0, 14209.218492982882, 16389.672206555922, 17034.933711931848, 17048.573785655335, 14117.78823317651, 15744.055356678637, 16593.585160370967, 16810.159492025472, 16947.57631059221, 11220.382878941655, 13532.32338383077, 13751.243681597509, 13962.092463989808, 13985.090969086978, 3448.827558622059, 3452.033430639425, 3456.7061799747053, 3480.617132115465, 3480.6519348065244, 81274.59362703208, 101716.0, 102731.97268027299, 102756.48621756918, 102929.48535257275, 11926.403679815974, 12049.457774400173, 12117.69705757363, 12172.57395991136, 12274.0, 20169.39491815248, 20183.69724454105, 20223.59552808965, 20392.796072039386, 20400.591988160155, 8966.058563850833, 9193.448393096436, 9217.861732074025, 9231.215346695471, 9242.81514369709, 4157.501099868035, 4230.450041494648, 4934.18585933317, 4950.628702847301, 4954.281629163823, 3425.3149370126075, 4170.457840480779, 4319.697621166488, 4323.48118225815, 4332.393464914914, 894.0924961164424, 923.1368670293298, 925.7639301978087, 929.4376901974208, 930.1721467893581, 655.1744801549986, 655.7442597387023, 666.5667316244383, 671.8891382921763, 691.1257259566652, 10845.295055821347, 11920.701982450335, 12002.979746721452, 12059.095567832448, 12108.21296615717, 663.3797399431451, 665.9134312539339, 667.2626747444101, 679.3851564334285, 693.9271376505495, 5386.730663466811, 5407.918881216706, 5422.457754224625, 5512.5589952804485, 5541.418151094158, 97854.0, 98175.0, 99192.50403747935, 100041.0, 100314.4984275074, 69574.65212673905, 86691.0, 90816.0, 91985.0, 92562.0, 59496.0, 60613.69693151506, 71241.03938172938, 72263.27736722566, 79587.0, 12097.818532722193, 12680.556180533637, 12690.746185076063, 12722.491100355883, 12736.23582585048, 35785.0, 39203.235854386054, 39264.41103383509, 40093.79953100332, 40100.598994009684, 36417.90447811966, 45104.0, 45514.54485455103, 45723.62829114999, 46182.0, 13653.726925461633, 15607.297671605033, 15819.446319378767, 16852.241649126063, 16899.408520701716, 17899.37352192667, 18040.097995100456, 18478.81521184771, 18483.72274415858, 18532.351367702067, 16781.496555103367, 17169.74245386345, 17222.0, 17287.0, 17383.47849564515, 16131.919340403692, 16254.51236462908, 16807.579810504834, 16840.915795420944, 17352.219150138022, 16106.27521761547, 16146.919265403598, 16468.42360517376, 16766.497005089866, 16934.237959292106, 11625.825612615987, 11704.356260405759, 12243.32661703615, 12332.19840710351, 12350.44423000949, 12446.688832779253, 13001.414936328078, 13042.673933151747, 13073.542426015043, 13188.604341869759], "value": 8194.158183197444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1718.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 183.0, 123.0, 124.0, 121.0, 121.0, 129.0, 179.0, 120.0, 171.0], "value": 142.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 107.0, 156.0, 156.0, 118.0, 119.0, 118.0, 173.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 224.0, 225.0, 238.0, 221.0, 196.0, 296.0, 277.0, 261.0, 287.0], "value": 244.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 63.0, 75.0, 87.0, 88.0, 92.0, 89.0, 95.0, 99.0, 62.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 89.0, 86.0, 112.0, 111.0, 85.0, 72.0, 76.0, 127.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 93.0, 91.0, 91.0, 94.0, 90.0, 92.0, 91.0, 93.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 155.0, 100.0, 107.0, 102.0, 102.0, 158.0, 101.0, 101.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 101.0, 101.0, 118.0, 156.0, 125.0, 146.0, 136.0, 114.0, 162.0], "value": 130.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 54.0, 56.0, 57.0, 48.0, 49.0, 72.0, 75.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 65.0, 76.0, 69.0, 71.0, 84.0, 76.0, 60.0, 62.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 106.0, 83.0, 103.0, 85.0, 100.0, 114.0, 103.0, 86.0, 116.0], "value": 98.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 153.0, 162.0, 142.0, 143.0, 139.0, 167.0, 230.0, 187.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 198.0, 197.0, 198.0, 197.0, 201.0, 197.0, 244.0, 259.0], "value": 208.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 102.0, 111.0, 100.0, 106.0, 101.0, 74.0, 72.0, 72.0], "value": 87.3, "unit": "score"}]}]} 10:30:30 INFO - Return code: 0 10:30:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:30 ERROR - # TBPL SUCCESS # 10:30:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:30:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:30:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:30:30 INFO - 2017-04-09 10:30:30.427 screenresolution[1953:23797] starting screenresolution argv=screenresolution get 10:30:30 INFO - 2017-04-09 10:30:30.430 screenresolution[1953:23797] Display 0: 1600x1200x32@60 10:30:30 INFO - 2017-04-09 10:30:30.436 screenresolution[1954:23800] starting screenresolution argv=screenresolution list 10:30:30 INFO - Available Modes on Display 0 10:30:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:30:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:30:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:30:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:30:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:30:30 INFO - Intel Iris: 10:30:30 INFO - Chipset Model: Intel Iris 10:30:30 INFO - Type: GPU 10:30:30 INFO - Bus: Built-In 10:30:30 INFO - VRAM (Dynamic, Max): 1536 MB 10:30:30 INFO - Vendor: Intel (0x8086) 10:30:30 INFO - Device ID: 0x0a2e 10:30:30 INFO - Revision ID: 0x0009 10:30:30 INFO - Displays: 10:30:30 INFO - Display: 10:30:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:30:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:30:30 INFO - Display Serial Number: 1600x1200 60 10:30:30 INFO - Main Display: Yes 10:30:30 INFO - Mirror: Off 10:30:30 INFO - Online: Yes 10:30:30 INFO - Rotation: Supported 10:30:30 INFO - Return code: 0 10:30:30 INFO - Running post-action listener: _resource_record_post_action 10:30:30 INFO - [mozharness: 2017-04-09 17:30:30.681368Z] Finished run-tests step (success) 10:30:30 INFO - Running post-run listener: _resource_record_post_run 10:30:30 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 761856; Write bytes: 526696448; Read time: 8; Write time: 1691 10:30:30 INFO - TinderboxPrint: CPU usage
54.2% 10:30:30 INFO - TinderboxPrint: I/O read bytes / time
761,856 / 8 10:30:30 INFO - TinderboxPrint: I/O write bytes / time
526,696,448 / 1,691 10:30:30 INFO - TinderboxPrint: CPU idle
2,203.0 (45.8%) 10:30:30 INFO - TinderboxPrint: CPU system
967.8 (20.1%) 10:30:30 INFO - TinderboxPrint: CPU user
1,635.0 (34.0%) 10:30:30 INFO - TinderboxPrint: Swap in / out
207,822,848 / 0 10:30:30 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208531968; Write bytes: 210728960; Read time: 16044; Write time: 474 10:30:30 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 561152; Write bytes: 314615808; Read time: 6; Write time: 1208 10:30:31 INFO - Running post-run listener: _upload_blobber_files 10:30:31 INFO - Blob upload gear active. 10:30:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:31 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 10:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:30:31 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:32 INFO - (blobuploader) - INFO - Done attempting. 10:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:33 INFO - (blobuploader) - INFO - Done attempting. 10:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:34 INFO - (blobuploader) - INFO - Done attempting. 10:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:36 INFO - (blobuploader) - INFO - Done attempting. 10:30:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:36 INFO - Return code: 0 10:30:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655c1731fd97c6576fe35fdb0ae8340debc6fe37af21122e95f736b54421831174072738e85c41b94aa7181d5e052977b7fb013093b3c84a6c85f7d88cdee771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a13717d0845da082d899b623c173a0b6802b6397cba798d0381c06a1941ce16b18aaef7218a1d6b1f6e0fbe661f5174c645bd0a49ef15990d27fdecd6132d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2998d1eb3eda0f708587ed01e9f3b7b5f8a235b21b1ac051db36e383212aaf48209249e3aba4ff9d6d825723f1d11b6dc85427230bc125bda5b4d7a44ecbdb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f655cdcf83fb5b8b89560fe2c9300311c46e2f2595cb01935a9ea3bceb47850efceba85c9f06b6bc003120dbb755dfaa796ad7c796a446a3eafe0bbb844d808d"} 10:30:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:36 INFO - Contents: 10:30:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655c1731fd97c6576fe35fdb0ae8340debc6fe37af21122e95f736b54421831174072738e85c41b94aa7181d5e052977b7fb013093b3c84a6c85f7d88cdee771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a13717d0845da082d899b623c173a0b6802b6397cba798d0381c06a1941ce16b18aaef7218a1d6b1f6e0fbe661f5174c645bd0a49ef15990d27fdecd6132d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2998d1eb3eda0f708587ed01e9f3b7b5f8a235b21b1ac051db36e383212aaf48209249e3aba4ff9d6d825723f1d11b6dc85427230bc125bda5b4d7a44ecbdb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f655cdcf83fb5b8b89560fe2c9300311c46e2f2595cb01935a9ea3bceb47850efceba85c9f06b6bc003120dbb755dfaa796ad7c796a446a3eafe0bbb844d808d"} 10:30:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:36 INFO - Copying logs to upload dir... 10:30:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.256414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-09 10:30:36.509169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 10:30:36.513806) ========= 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.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655c1731fd97c6576fe35fdb0ae8340debc6fe37af21122e95f736b54421831174072738e85c41b94aa7181d5e052977b7fb013093b3c84a6c85f7d88cdee771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a13717d0845da082d899b623c173a0b6802b6397cba798d0381c06a1941ce16b18aaef7218a1d6b1f6e0fbe661f5174c645bd0a49ef15990d27fdecd6132d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2998d1eb3eda0f708587ed01e9f3b7b5f8a235b21b1ac051db36e383212aaf48209249e3aba4ff9d6d825723f1d11b6dc85427230bc125bda5b4d7a44ecbdb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f655cdcf83fb5b8b89560fe2c9300311c46e2f2595cb01935a9ea3bceb47850efceba85c9f06b6bc003120dbb755dfaa796ad7c796a446a3eafe0bbb844d808d"} build_url:https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/etfA-71bQSm2xz02px3QpQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655c1731fd97c6576fe35fdb0ae8340debc6fe37af21122e95f736b54421831174072738e85c41b94aa7181d5e052977b7fb013093b3c84a6c85f7d88cdee771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a13717d0845da082d899b623c173a0b6802b6397cba798d0381c06a1941ce16b18aaef7218a1d6b1f6e0fbe661f5174c645bd0a49ef15990d27fdecd6132d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2998d1eb3eda0f708587ed01e9f3b7b5f8a235b21b1ac051db36e383212aaf48209249e3aba4ff9d6d825723f1d11b6dc85427230bc125bda5b4d7a44ecbdb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f655cdcf83fb5b8b89560fe2c9300311c46e2f2595cb01935a9ea3bceb47850efceba85c9f06b6bc003120dbb755dfaa796ad7c796a446a3eafe0bbb844d808d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 10:30:36.553086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:30:36.553437) ========= 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.mIF2QylG6A/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.5qBzPKGp2v/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.005212 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 10:30:36.601974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 10:30:36.602298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 10:30:36.602631) ========= ========= Total master_lag: 0.19 =========