builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0218 starttime: 1491690634.77 results: success (0) buildid: 20170408135022 builduid: 7dc60da13575404d97381b8fabca1442 revision: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:34.768855) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:34.769273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:34.769597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:34.797114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:34.797458) ========= 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.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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-08 15:30:34-- 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% 171M=0s 2017-04-08 15:30:35 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.609593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:35.431101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:35.431443) ========= 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.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.026517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:35.480562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 15:30:35.480959) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 --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 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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-08 15:30:35,578 truncating revision to first 12 chars 2017-04-08 15:30:35,578 Setting DEBUG logging. 2017-04-08 15:30:35,578 attempt 1/10 2017-04-08 15:30:35,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a3ecdb7d1ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 15:30:37,011 unpacking tar archive at: mozilla-central-2a3ecdb7d1ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.705171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 15:30:37.210124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:37.210527) ========= script_repo_revision: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:37.210954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:37.211243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 15:30:37.231171) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-08 15:30:37.231454) ========= /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.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:30:37 INFO - MultiFileLogger online at 20170408 15:30:37 in /builds/slave/test 15:30:37 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 15:30:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:37 INFO - {'append_to_log': False, 15:30:37 INFO - 'base_work_dir': '/builds/slave/test', 15:30:37 INFO - 'blob_upload_branch': 'Firefox', 15:30:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:37 INFO - 'branch': 'Firefox', 15:30:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:37 INFO - 'config_files': ('talos/mac_config.py',), 15:30:37 INFO - 'default_actions': ('clobber', 15:30:37 INFO - 'read-buildbot-config', 15:30:37 INFO - 'download-and-extract', 15:30:37 INFO - 'populate-webroot', 15:30:37 INFO - 'create-virtualenv', 15:30:37 INFO - 'install', 15:30:37 INFO - 'run-tests'), 15:30:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:37 INFO - 'download_minidump_stackwalk': True, 15:30:37 INFO - 'download_symbols': 'ondemand', 15:30:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:37 INFO - 'gecko_profile': False, 15:30:37 INFO - 'gecko_profile_interval': 0, 15:30:37 INFO - 'installer_path': 'installer.exe', 15:30:37 INFO - 'log_level': 'info', 15:30:37 INFO - 'log_name': 'talos', 15:30:37 INFO - 'log_to_console': True, 15:30:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:30:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:30:37 INFO - 'opt_config_files': (), 15:30:37 INFO - 'pip_index': False, 15:30:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:37 INFO - 'cmd': ('bash', 15:30:37 INFO - '-c', 15:30:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:37 INFO - 'enabled': True, 15:30:37 INFO - 'halt_on_failure': False, 15:30:37 INFO - 'name': 'check_screen_resolution'},), 15:30:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:37 INFO - 'cmd': ('bash', 15:30:37 INFO - '-c', 15:30:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:37 INFO - 'enabled': True, 15:30:37 INFO - 'halt_on_failure': False, 15:30:37 INFO - 'name': 'check_screen_resolution'},), 15:30:37 INFO - 'run_cmd_checks_enabled': True, 15:30:37 INFO - 'suite': 'dromaeojs-e10s', 15:30:37 INFO - 'system_bits': '32', 15:30:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:37 INFO - 'title': 't-yosemite-r7-0218', 15:30:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:37 INFO - 'use_talos_json': True, 15:30:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:37 INFO - 'work_dir': 'build'} 15:30:37 INFO - [mozharness: 2017-04-08 22:30:37.440276Z] Running clobber step. 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: clobber 15:30:37 INFO - rmtree: /builds/slave/test/build 15:30:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:39 INFO - Running post-action listener: _resource_record_post_action 15:30:39 INFO - [mozharness: 2017-04-08 22:30:39.885925Z] Finished clobber step (success) 15:30:39 INFO - [mozharness: 2017-04-08 22:30:39.886103Z] Running read-buildbot-config step. 15:30:39 INFO - Running pre-action listener: _resource_record_pre_action 15:30:39 INFO - Running main action method: read_buildbot_config 15:30:39 INFO - Using buildbot properties: 15:30:39 INFO - { 15:30:39 INFO - "project": "", 15:30:39 INFO - "product": "firefox", 15:30:39 INFO - "script_repo_revision": "production", 15:30:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:30:39 INFO - "repository": "", 15:30:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:30:39 INFO - "buildid": "20170408135022", 15:30:39 INFO - "pgo_build": "False", 15:30:39 INFO - "basedir": "/builds/slave/test", 15:30:39 INFO - "buildnumber": 6, 15:30:39 INFO - "slavename": "t-yosemite-r7-0218", 15:30:39 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 15:30:39 INFO - "platform": "yosemite_r7", 15:30:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:30:39 INFO - "branch": "mozilla-central", 15:30:39 INFO - "repo_path": "mozilla-central", 15:30:39 INFO - "revision": "2a3ecdb7d1ea814708021fee6735b3aedcf03e48", 15:30:39 INFO - "stage_platform": "macosx64", 15:30:39 INFO - "builduid": "7dc60da13575404d97381b8fabca1442", 15:30:39 INFO - "slavebuilddir": "test" 15:30:39 INFO - } 15:30:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:30:39 INFO - Running post-action listener: _resource_record_post_action 15:30:39 INFO - [mozharness: 2017-04-08 22:30:39.889467Z] Finished read-buildbot-config step (success) 15:30:39 INFO - [mozharness: 2017-04-08 22:30:39.889602Z] Running download-and-extract step. 15:30:39 INFO - Running pre-action listener: _resource_record_pre_action 15:30:39 INFO - Running main action method: download_and_extract 15:30:39 INFO - mkdir: /builds/slave/test/build/tests 15:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:39 INFO - trying https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:30:39 INFO - Downloading https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/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 15:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/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 15:30:40 INFO - Downloaded 1325 bytes. 15:30:40 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:30:40 INFO - Using the following test package requirements: 15:30:40 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:30:40 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:30:40 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:30:40 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:30:40 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'jsshell-mac.zip'], 15:30:40 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:30:40 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:30:40 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:30:40 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:30:40 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:30:40 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:30:40 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:30:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:30:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:30:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:30:40 INFO - Fetch https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:30:42 INFO - Expected file size: 52526195 15:30:42 INFO - Obtained file size: 52526195 15:30:58 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 15:30:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:30:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:30:58 INFO - Fetch https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:30:59 INFO - Expected file size: 52526195 15:30:59 INFO - Obtained file size: 52526195 15:31:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:31:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:31:15 INFO - Fetch https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:31:15 INFO - Expected file size: 14404129 15:31:15 INFO - Obtained file size: 14404129 15:31: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')]} 15:31:16 INFO - trying https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:31:16 INFO - Downloading https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/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 15:31:18 INFO - Downloaded 70926163 bytes. 15:31:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:31:18 INFO - mkdir: /builds/slave/test/properties 15:31:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:18 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:18 INFO - Contents: 15:31:18 INFO - build_url:https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:31:19 INFO - Running post-action listener: _resource_record_post_action 15:31:19 INFO - Running post-action listener: set_extra_try_arguments 15:31:19 INFO - [mozharness: 2017-04-08 22:31:19.384888Z] Finished download-and-extract step (success) 15:31:19 INFO - [mozharness: 2017-04-08 22:31:19.385008Z] Running populate-webroot step. 15:31:19 INFO - Running pre-action listener: _resource_record_pre_action 15:31:19 INFO - Running main action method: populate_webroot 15:31:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:19 INFO - '--tppagecycles', 15:31:19 INFO - '7'], 15:31:19 INFO - 'tests': ['tsvgm']}}, 15:31:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:31:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:31:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['damp', 'tps']}, 15:31:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'tests': ['damp', 'tps']}, 15:31:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['dromaeo_dom']}, 15:31:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['basic_compositor_video']}, 15:31:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:31:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['a11yr', 15:31:19 INFO - 'ts_paint', 15:31:19 INFO - 'tpaint', 15:31:19 INFO - 'sessionrestore', 15:31:19 INFO - 'sessionrestore_no_auto_restore', 15:31:19 INFO - 'tabpaint']}, 15:31:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['tsvgx', 15:31:19 INFO - 'tsvgr_opacity', 15:31:19 INFO - 'tart', 15:31:19 INFO - 'tscrollx', 15:31:19 INFO - 'cart', 15:31:19 INFO - 'tsvg_static']}, 15:31:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:31:19 INFO - 'tsvgr_opacity', 15:31:19 INFO - 'tart', 15:31:19 INFO - 'tscrollx', 15:31:19 INFO - 'cart', 15:31:19 INFO - 'tsvg_static']}, 15:31:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'talos_options': ['--disable-e10s'], 15:31:19 INFO - 'tests': ['tp5o']}, 15:31:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:31:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'talos_options': ['--disable-e10s', 15:31:19 INFO - '--xperf_path', 15:31:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:19 INFO - 'tests': ['tp5n']}, 15:31:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:31:19 INFO - 'talos_options': ['--xperf_path', 15:31:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:19 INFO - 'tests': ['tp5n']}}, 15:31:19 INFO - 'talos.zip': {'path': '', 15:31:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:19 INFO - Running post-action listener: _resource_record_post_action 15:31:19 INFO - [mozharness: 2017-04-08 22:31:19.403580Z] Finished populate-webroot step (success) 15:31:19 INFO - [mozharness: 2017-04-08 22:31:19.403712Z] Running create-virtualenv step. 15:31:19 INFO - Running pre-action listener: _resource_record_pre_action 15:31:19 INFO - Running main action method: create_virtualenv 15:31:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:19 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 15:31:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:19 INFO - Using real prefix '/tools/python27' 15:31:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:23 INFO - Installing pip.................done. 15:31:23 INFO - Return code: 0 15:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:31:23 INFO - Reading from file tmpfile_stdout 15:31:23 INFO - Output received: 15:31:23 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) 15:31:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:23 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')]} 15:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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')]} 15:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:23 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 15:31:23 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 15:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:23 INFO - 'HOME': '/Users/cltbld', 15:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:23 INFO - 'LOGNAME': 'cltbld', 15:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:23 INFO - 'MOZ_NO_REMOTE': '1', 15:31:23 INFO - 'NO_EM_RESTART': '1', 15:31:23 INFO - 'PAGER': '/bin/cat', 15:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:23 INFO - 'PWD': '/builds/slave/test', 15:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:23 INFO - 'SHELL': '/bin/bash', 15:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:23 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:23 INFO - 'USER': 'cltbld', 15:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:23 INFO - 'XPC_FLAGS': '0x0', 15:31:23 INFO - 'XPC_SERVICE_NAME': '0', 15:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:23 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 15:31:23 INFO - Cleaning up... 15:31:23 INFO - Return code: 0 15:31:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31:23 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')]} 15:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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')]} 15:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:23 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 15:31:23 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 15:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:23 INFO - 'HOME': '/Users/cltbld', 15:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:23 INFO - 'LOGNAME': 'cltbld', 15:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:23 INFO - 'MOZ_NO_REMOTE': '1', 15:31:23 INFO - 'NO_EM_RESTART': '1', 15:31:23 INFO - 'PAGER': '/bin/cat', 15:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:23 INFO - 'PWD': '/builds/slave/test', 15:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:23 INFO - 'SHELL': '/bin/bash', 15:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:23 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:23 INFO - 'USER': 'cltbld', 15:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:23 INFO - 'XPC_FLAGS': '0x0', 15:31:23 INFO - 'XPC_SERVICE_NAME': '0', 15:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:23 INFO - Downloading/unpacking psutil>=3.1.1 15:31:23 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 15:31:23 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 15:31:23 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 15:31:23 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 15:31:23 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 15:31:23 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 15:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:27 INFO - Installing collected packages: psutil 15:31:27 INFO - Running setup.py install for psutil 15:31:27 INFO - building 'psutil._psutil_osx' extension 15:31:27 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 15:31:28 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 15:31:28 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 15:31:28 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 15:31:28 INFO - building 'psutil._psutil_posix' extension 15:31:28 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 15:31:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:31:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:31:28 INFO - ^ 15:31:28 INFO - 1 warning generated. 15:31:28 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 15:31:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:28 INFO - Successfully installed psutil 15:31:28 INFO - Cleaning up... 15:31:28 INFO - Return code: 0 15:31:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:31: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 mozsystemmonitor==0.3 15:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:28 INFO - 'HOME': '/Users/cltbld', 15:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:28 INFO - 'LOGNAME': 'cltbld', 15:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:28 INFO - 'MOZ_NO_REMOTE': '1', 15:31:28 INFO - 'NO_EM_RESTART': '1', 15:31:28 INFO - 'PAGER': '/bin/cat', 15:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:28 INFO - 'PWD': '/builds/slave/test', 15:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:28 INFO - 'SHELL': '/bin/bash', 15:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:28 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:28 INFO - 'USER': 'cltbld', 15:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:28 INFO - 'XPC_FLAGS': '0x0', 15:31:28 INFO - 'XPC_SERVICE_NAME': '0', 15:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:31 INFO - Installing collected packages: mozsystemmonitor 15:31:31 INFO - Running setup.py install for mozsystemmonitor 15:31:32 INFO - Successfully installed mozsystemmonitor 15:31:32 INFO - Cleaning up... 15:31:32 INFO - Return code: 0 15:31:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31:32 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')]} 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:32 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')]} 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:32 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:32 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 15:31:32 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 15:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:32 INFO - 'HOME': '/Users/cltbld', 15:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:32 INFO - 'LOGNAME': 'cltbld', 15:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:32 INFO - 'MOZ_NO_REMOTE': '1', 15:31:32 INFO - 'NO_EM_RESTART': '1', 15:31:32 INFO - 'PAGER': '/bin/cat', 15:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:32 INFO - 'PWD': '/builds/slave/test', 15:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:32 INFO - 'SHELL': '/bin/bash', 15:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:32 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:32 INFO - 'USER': 'cltbld', 15:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:32 INFO - 'XPC_FLAGS': '0x0', 15:31:32 INFO - 'XPC_SERVICE_NAME': '0', 15:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31:35 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 15:31:35 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 15:31:35 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 15:31:35 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 15:31:35 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 15:31:35 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 15:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:35 INFO - warning: no files found matching '*.txt' 15:31:35 INFO - no previously-included directories found matching 'build' 15:31:35 INFO - no previously-included directories found matching 'dist' 15:31:35 INFO - no previously-included directories found matching '.git*' 15:31:35 INFO - Installing collected packages: jsonschema, functools32 15:31:35 INFO - Running setup.py install for functools32 15:31:35 INFO - warning: no files found matching '*.txt' 15:31:35 INFO - no previously-included directories found matching 'build' 15:31:35 INFO - no previously-included directories found matching 'dist' 15:31:35 INFO - no previously-included directories found matching '.git*' 15:31:35 INFO - Successfully installed jsonschema functools32 15:31:35 INFO - Cleaning up... 15:31:35 INFO - Return code: 0 15:31:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:31:35 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')]} 15:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:35 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')]} 15:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:35 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:35 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 15:31:35 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 15:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:35 INFO - 'HOME': '/Users/cltbld', 15:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:35 INFO - 'LOGNAME': 'cltbld', 15:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:35 INFO - 'MOZ_NO_REMOTE': '1', 15:31:35 INFO - 'NO_EM_RESTART': '1', 15:31:35 INFO - 'PAGER': '/bin/cat', 15:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:35 INFO - 'PWD': '/builds/slave/test', 15:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:35 INFO - 'SHELL': '/bin/bash', 15:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:35 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:35 INFO - 'USER': 'cltbld', 15:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:35 INFO - 'XPC_FLAGS': '0x0', 15:31:35 INFO - 'XPC_SERVICE_NAME': '0', 15:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:31:36 INFO - Cleaning up... 15:31:36 INFO - Return code: 0 15:31:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:36 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')]} 15:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:36 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')]} 15:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:36 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:36 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 15:31:36 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 15:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:36 INFO - 'HOME': '/Users/cltbld', 15:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:36 INFO - 'LOGNAME': 'cltbld', 15:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:36 INFO - 'MOZ_NO_REMOTE': '1', 15:31:36 INFO - 'NO_EM_RESTART': '1', 15:31:36 INFO - 'PAGER': '/bin/cat', 15:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:36 INFO - 'PWD': '/builds/slave/test', 15:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:36 INFO - 'SHELL': '/bin/bash', 15:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:36 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:36 INFO - 'USER': 'cltbld', 15:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:36 INFO - 'XPC_FLAGS': '0x0', 15:31:36 INFO - 'XPC_SERVICE_NAME': '0', 15:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:36 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 15:31:36 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 15:31:36 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 15:31:36 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 15:31:36 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 15:31:36 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 15:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:40 INFO - Downloading docopt-0.6.1.tar.gz 15:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:40 INFO - Running setup.py install for blobuploader 15:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:40 INFO - Running setup.py install for requests 15:31:41 INFO - Running setup.py install for docopt 15:31:41 INFO - Successfully installed blobuploader requests docopt 15:31:41 INFO - Cleaning up... 15:31:41 INFO - Return code: 0 15:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:41 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')]} 15:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:41 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')]} 15:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:41 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:41 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 15:31:41 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 15:31:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:41 INFO - 'HOME': '/Users/cltbld', 15:31:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:41 INFO - 'LOGNAME': 'cltbld', 15:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:41 INFO - 'MOZ_NO_REMOTE': '1', 15:31:41 INFO - 'NO_EM_RESTART': '1', 15:31:41 INFO - 'PAGER': '/bin/cat', 15:31:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:41 INFO - 'PWD': '/builds/slave/test', 15:31:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:41 INFO - 'SHELL': '/bin/bash', 15:31:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:41 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:41 INFO - 'USER': 'cltbld', 15:31:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:41 INFO - 'XPC_FLAGS': '0x0', 15:31:41 INFO - 'XPC_SERVICE_NAME': '0', 15:31:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-JtUNpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-27f1lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-nzsYiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-wNmPom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-bAIf7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-lNvAKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-5Cf2T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-KAbFdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-i1_aGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-EDiRXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-F3i4yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-yTclVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-hmvtlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:42 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-jpqcbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:43 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-8RNoRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:43 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Isp1vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:43 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-HJg61D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:43 INFO - Running setup.py install for manifestparser 15:31:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozcrash 15:31:43 INFO - Running setup.py install for mozdebug 15:31:43 INFO - Running setup.py install for mozdevice 15:31:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozfile 15:31:44 INFO - Running setup.py install for mozhttpd 15:31:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozinfo 15:31:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozInstall 15:31:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozleak 15:31:44 INFO - Running setup.py install for mozlog 15:31:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for moznetwork 15:31:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Running setup.py install for mozprocess 15:31:45 INFO - Running setup.py install for mozprofile 15:31:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Running setup.py install for mozrunner 15:31:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Running setup.py install for mozscreenshot 15:31:45 INFO - Running setup.py install for moztest 15:31:45 INFO - Running setup.py install for mozversion 15:31:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:45 INFO - Cleaning up... 15:31:45 INFO - Return code: 0 15:31:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:45 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:45 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 15:31:45 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 15:31:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:45 INFO - 'HOME': '/Users/cltbld', 15:31:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:45 INFO - 'LOGNAME': 'cltbld', 15:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:45 INFO - 'MOZ_NO_REMOTE': '1', 15:31:45 INFO - 'NO_EM_RESTART': '1', 15:31:45 INFO - 'PAGER': '/bin/cat', 15:31:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:45 INFO - 'PWD': '/builds/slave/test', 15:31:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:45 INFO - 'SHELL': '/bin/bash', 15:31:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:45 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:45 INFO - 'USER': 'cltbld', 15:31:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:45 INFO - 'XPC_FLAGS': '0x0', 15:31:45 INFO - 'XPC_SERVICE_NAME': '0', 15:31:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Mvxaew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-OuGQlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-sH3vWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-QrE5yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-dWfAfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-q1LiSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-PrtEMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:46 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)) 15:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:46 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-NWtSKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Sa6h9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-4obTw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-p0zMR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-ECd_8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-p0w2Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-o0fufy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-uQWAaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-TyQfXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:47 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)) 15:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:47 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-h774k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:47 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)) 15:31:47 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)) 15:31:47 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)) 15:31:47 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)) 15:31:47 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)) 15:31:47 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)) 15:31:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:47 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 15:31:47 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 15:31:47 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 15:31:48 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 15:31:48 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 15:31:48 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 15:31:50 INFO - Downloading blessings-1.6.tar.gz 15:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:50 INFO - Installing collected packages: blessings 15:31:50 INFO - Running setup.py install for blessings 15:31:50 INFO - Successfully installed blessings 15:31:50 INFO - Cleaning up... 15:31:51 INFO - Return code: 0 15:31:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:51 INFO - Reading from file tmpfile_stdout 15:31:51 INFO - Current package versions: 15:31:51 INFO - blessings == 1.6 15:31:51 INFO - blobuploader == 1.2.4 15:31:51 INFO - docopt == 0.6.1 15:31:51 INFO - functools32 == 3.2.3-2 15:31:51 INFO - jsonschema == 2.5.1 15:31:51 INFO - manifestparser == 1.1 15:31:51 INFO - mozInstall == 1.12 15:31:51 INFO - mozcrash == 1.0 15:31:51 INFO - mozdebug == 0.1 15:31:51 INFO - mozdevice == 0.50 15:31:51 INFO - mozfile == 1.2 15:31:51 INFO - mozhttpd == 0.7 15:31:51 INFO - mozinfo == 0.9 15:31:51 INFO - mozleak == 0.1 15:31:51 INFO - mozlog == 3.4 15:31:51 INFO - moznetwork == 0.27 15:31:51 INFO - mozprocess == 0.25 15:31:51 INFO - mozprofile == 0.28 15:31:51 INFO - mozrunner == 6.13 15:31:51 INFO - mozscreenshot == 0.1 15:31:51 INFO - mozsystemmonitor == 0.3 15:31:51 INFO - moztest == 0.8 15:31:51 INFO - mozversion == 1.4 15:31:51 INFO - psutil == 3.1.1 15:31:51 INFO - requests == 1.2.3 15:31:51 INFO - wsgiref == 0.1.2 15:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:51 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')]} 15:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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')]} 15:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:51 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 15:31:51 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 15:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:51 INFO - 'HOME': '/Users/cltbld', 15:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:51 INFO - 'LOGNAME': 'cltbld', 15:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:51 INFO - 'MOZ_NO_REMOTE': '1', 15:31:51 INFO - 'NO_EM_RESTART': '1', 15:31:51 INFO - 'PAGER': '/bin/cat', 15:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:51 INFO - 'PWD': '/builds/slave/test', 15:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:51 INFO - 'SHELL': '/bin/bash', 15:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:51 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:51 INFO - 'USER': 'cltbld', 15:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:51 INFO - 'XPC_FLAGS': '0x0', 15:31:51 INFO - 'XPC_SERVICE_NAME': '0', 15:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 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)) 15:31:51 INFO - Cleaning up... 15:31:51 INFO - Return code: 0 15:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:51 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')]} 15:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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')]} 15:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:51 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 0x10d670b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d673768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29147e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, '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.yTDOxofe3L/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.YdUgqnNzla/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 15:31:51 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 15:31:51 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 15:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:51 INFO - 'HOME': '/Users/cltbld', 15:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:51 INFO - 'LOGNAME': 'cltbld', 15:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:51 INFO - 'MOZ_NO_REMOTE': '1', 15:31:51 INFO - 'NO_EM_RESTART': '1', 15:31:51 INFO - 'PAGER': '/bin/cat', 15:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:51 INFO - 'PWD': '/builds/slave/test', 15:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:51 INFO - 'SHELL': '/bin/bash', 15:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:31:51 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:51 INFO - 'USER': 'cltbld', 15:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:51 INFO - 'XPC_FLAGS': '0x0', 15:31:51 INFO - 'XPC_SERVICE_NAME': '0', 15:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:51 INFO - Cleaning up... 15:31:51 INFO - Return code: 0 15:31:51 INFO - Running post-action listener: _resource_record_post_action 15:31:51 INFO - Running post-action listener: _start_resource_monitoring 15:31:51 INFO - Starting resource monitoring. 15:31:51 INFO - [mozharness: 2017-04-08 22:31:51.867499Z] Finished create-virtualenv step (success) 15:31:51 INFO - [mozharness: 2017-04-08 22:31:51.868440Z] Running install step. 15:31:51 INFO - Running pre-action listener: _resource_record_pre_action 15:31:51 INFO - Running main action method: install 15:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:52 INFO - Reading from file tmpfile_stdout 15:31:52 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:52 INFO - Reading from file tmpfile_stdout 15:31:52 INFO - Output received: 15:31:52 INFO - Usage: mozinstall [options] installer 15:31:52 INFO - Options: 15:31:52 INFO - -h, --help show this help message and exit 15:31:52 INFO - -d DEST, --destination=DEST 15:31:52 INFO - Directory to install application into. [default: 15:31:52 INFO - "/builds/slave/test"] 15:31:52 INFO - --app=APP Application being installed. [default: firefox] 15:31:52 INFO - mkdir: /builds/slave/test/build/application 15:31:52 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'] 15:31:52 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 15:32:11 INFO - Reading from file tmpfile_stdout 15:32:11 INFO - Output received: 15:32:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:32:11 INFO - Running post-action listener: _resource_record_post_action 15:32:11 INFO - [mozharness: 2017-04-08 22:32:11.831891Z] Finished install step (success) 15:32:11 INFO - [mozharness: 2017-04-08 22:32:11.832022Z] Running run-tests step. 15:32:11 INFO - Running pre-action listener: _resource_record_pre_action 15:32:11 INFO - Running main action method: run_tests 15:32:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:32:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:32:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:32:11 INFO - 2017-04-08 15:32:11.846 screenresolution[1627:7954] starting screenresolution argv=screenresolution get 15:32:11 INFO - 2017-04-08 15:32:11.849 screenresolution[1627:7954] Display 0: 1600x1200x32@60 15:32:11 INFO - 2017-04-08 15:32:11.854 screenresolution[1628:7957] starting screenresolution argv=screenresolution list 15:32:11 INFO - Available Modes on Display 0 15:32:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:32:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:32:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:32:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:32:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:32:12 INFO - Intel Iris: 15:32:12 INFO - Chipset Model: Intel Iris 15:32:12 INFO - Type: GPU 15:32:12 INFO - Bus: Built-In 15:32:12 INFO - VRAM (Dynamic, Max): 1536 MB 15:32:12 INFO - Vendor: Intel (0x8086) 15:32:12 INFO - Device ID: 0x0a2e 15:32:12 INFO - Revision ID: 0x0009 15:32:12 INFO - Displays: 15:32:12 INFO - Display: 15:32:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:32:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:32:12 INFO - Display Serial Number: 1600x1200 60 15:32:12 INFO - Main Display: Yes 15:32:12 INFO - Mirror: Off 15:32:12 INFO - Online: Yes 15:32:12 INFO - Rotation: Supported 15:32:12 INFO - Return code: 0 15:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:12 INFO - Python 2.7.3 15:32:12 INFO - Return code: 0 15:32:12 INFO - grabbing minidump binary from tooltool 15:32: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')]} 15:32:12 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 0x10d44ed30>, '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 0x10d375db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d443be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:12 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 15:32:12 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 15:32:12 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 15:32:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:12 INFO - Return code: 0 15:32:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:32:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:12 INFO - ENV: RUST_BACKTRACE is now 1 15:32:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:32:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:12 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/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 15:32:12 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/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0218 --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 15:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTDOxofe3L/Render', 15:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:12 INFO - 'HOME': '/Users/cltbld', 15:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:12 INFO - 'LOGNAME': 'cltbld', 15:32:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:12 INFO - 'MOZ_NO_REMOTE': '1', 15:32:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:12 INFO - 'NO_EM_RESTART': '1', 15:32:12 INFO - 'PAGER': '/bin/cat', 15:32:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:12 INFO - 'PWD': '/builds/slave/test', 15:32:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:12 INFO - 'RUST_BACKTRACE': '1', 15:32:12 INFO - 'SHELL': '/bin/bash', 15:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YdUgqnNzla/Listeners', 15:32:12 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 15:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:12 INFO - 'USER': 'cltbld', 15:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:12 INFO - 'XPC_FLAGS': '0x0', 15:32:12 INFO - 'XPC_SERVICE_NAME': '0', 15:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:12 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/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 15:32:12 INFO - mozversion application_buildid: 20170408135022 15:32:12 INFO - mozversion application_changeset: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 15:32:12 INFO - mozversion application_display_name: Nightly 15:32:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:12 INFO - mozversion application_name: Firefox 15:32:12 INFO - mozversion application_remotingname: firefox 15:32:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:32:12 INFO - mozversion application_vendor: Mozilla 15:32:12 INFO - mozversion application_version: 55.0a1 15:32:12 INFO - mozversion platform_buildid: 20170408135022 15:32:12 INFO - mozversion platform_changeset: 2a3ecdb7d1ea814708021fee6735b3aedcf03e48 15:32:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:32:12 INFO - mozversion platform_version: 55.0a1 15:32:12 INFO - using testdate: 1491690732 15:32:12 INFO - actual date: 1491690732 15:32:12 INFO - starting webserver on 'localhost:49235' 15:32:12 INFO - SUITE-START | Running 2 tests 15:32:12 INFO - TEST-START | dromaeo_css 15:32:12 INFO - operating with platform_type : mac_ 15:32:12 INFO - Initialising browser for dromaeo_css test... 15:32:12 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmp8zjJjB/profile http://localhost:49235/getInfo.html) 15:32:15 INFO - PID 1638 | 2017-04-08 15:32:15.734 plugin-container[1641:8145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 15:32:15 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:32:15 INFO - PID 1638 | 2017-04-08 15:32:15.739 plugin-container[1641:8145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 15:32:15 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:32:15 INFO - PID 1638 | 2017-04-08 15:32:15.739 plugin-container[1641:8145] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:32:15 INFO - PID 1638 | __metrics Screen width/height:1600/1200 15:32:15 INFO - PID 1638 | colorDepth:24 15:32:15 INFO - PID 1638 | Browser inner width/height: 1024/689 15:32:15 INFO - PID 1638 | __metrics 15:32:15 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 15:32:16 INFO - TEST-INFO | 1638: exit 0 15:32:16 INFO - Browser initialized. 15:32:16 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:16 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmp8zjJjB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:19 INFO - PID 1642 | 2017-04-08 15:32:19.407 plugin-container[1643:8276] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 15:32:19 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:32:19 INFO - PID 1642 | 2017-04-08 15:32:19.407 plugin-container[1643:8276] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 15:32:19 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:32:19 INFO - PID 1642 | 2017-04-08 15:32:19.407 plugin-container[1643:8276] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:32:29 INFO - PID 1642 | RSS: Main: 237461504 15:32:29 INFO - PID 1642 | 15:35:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 15:35:34 INFO - PID 1642 | RSS: Main: 255610880 15:35:34 INFO - PID 1642 | 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 15:37:17 INFO - PID 1642 | 15:37:17 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:37:17 INFO - PID 1642 | Full stack: 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 15:37:17 INFO - PID 1642 | 15:37:17 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:37:17 INFO - PID 1642 | Full stack: 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 15:37:17 INFO - PID 1642 | 15:37:17 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:37:17 INFO - PID 1642 | Full stack: 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | ************************* 15:37:17 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 15:37:17 INFO - PID 1642 | 15:37:17 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:37:17 INFO - PID 1642 | Full stack: 15:37:17 INFO - PID 1642 | ************************* 15:38:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 15:38:36 INFO - PID 1642 | RSS: Main: 263045120 15:38:36 INFO - PID 1642 | 15:41:38 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 15:41:38 INFO - PID 1642 | RSS: Main: 274833408 15:41:38 INFO - PID 1642 | 15:44:40 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 15:44:41 INFO - PID 1642 | RSS: Main: 268533760 15:44:41 INFO - PID 1642 | 15:47:44 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 15:47:44 INFO - PID 1642 | RSS: Main: 278401024 15:47:44 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 15:50:46 INFO - PID 1642 | RSS: Main: 272125952 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | __start_tp_report 15:50:46 INFO - PID 1642 | _x_x_mozilla_page_load 15:50:46 INFO - PID 1642 | _x_x_mozilla_page_load_details 15:50:46 INFO - PID 1642 | |i|pagename|runs| 15:50:46 INFO - PID 1642 | |0;dojo.html;2990.9850450747745;3161.2571045804234;3483.9303213935705;3515.753897227195;3517.665821746933;4647.837325693601;5595.41248168942;5957.761689532419;5985.4014598540125;6032.457078862902;6067.666278354689;6069.908951365733;6090.969545152279;6098.522998457013;6120.843333897677;5255.106631872591;5284.9958507883575;5329.653572517794;5337.412884582693;5373.247745315659;5341.839744807662;5386.622936394454;5401.27082843817;5434.103372943459;5474.72626368682;5222.895542089175;5284.682919024871;5311.787528498855;5319.20211968204;5331.840044798623;5304.734763261821;5311.362636483646;5312.92030619541;5315.548178404841;5322.121849894763;5152.845414637567;5267;5270.710110943896;5284.762185701653;5286.841394758163;5679.971600142014;5700.173474846124;5916.792912248094;5992.0712289595185;6065;6458.2895881453005;6461.967690161566;6476.6114033158165;6487.7080531376205;6488.28628850826;6547.279799222082;6551.737930482775;6559.245686746038;6560.606363618198;6596.373344532261;4999.625028122905;6037.034074548052;6096.359882212304;6191.783287584913;6228.252609686867;6508.446782023581;6598.505112116611;6648.767293144813;6650.70071846768;6668.83327916806;5264.842054738364;6046.909296360558;6229.750809967551;6285.277193122758;6301.495880329563;4900.26496025599;6509;6546.312637173029;6547.476201903836;6549.476041916635;6225.066240064027;6435.581687190318;6455.903161452582;6469.708863101172;6498.252700939453;5338.973305133527;6300.527460440394;6349.936500634934;6431.678416079178;6471.385218404244;5158.484151584887;5186.896262074737;5206.088934436534;5211.530962213419;5227.947720522822;4159.7920103994675;4653.60444362233;4658.790354434059;4660.860174194711;4673.556012178838;4726.503717109723;6059.697015149225;6108.908366374508;6111.9694401528595;6241.812745617639;5974.193483879708;6105.748321594063;6320;6425.164728585348;6543.247526534415;6194.008958566607;6233.096201050913;6242.75028998844;6243.375662433811;6254.15568898202;5668.744906479218;5701.828945131652;5714.200011998323;5730.865072984161;5759.683217423082;6430.3891130342545;6517.837054073591;6597.967010164918;6667.966660166668;6684.097646817618;5609.663420194802;6504.121943537752;6531.934680653133;6542.149520562487;6562.737490500326;6585.539012269095;6677.69950352245;6697.732090716317;6708.060871477899;6710.496712746662;6287.2140982377205;6320.462760665395;6336.778212762531;6353.809385718436;6429.903551446826;5447.972760136174;5451.781928722965;6510.316416776171;6533.216014078341;6550.246721627074;5461.453854614507;6113.506711826804;6276.560640755103;6294.779682711083;6360.745570177326;6245.500359971283;6353.332900045613;6375.394337537927;6383.904241436289;6397.680115994089;5314.388845282842;5961.165436838759;6126.203593532812;6169.9691501544;6208.720607572761;6274.121622972696;6320.747170113144;6379.553431259767;6401.071844582416;6401.327860574573;6237.906431403442;6268.373162683695;6293.496520278275;6294.905576416266;6296.212973378328 15:50:46 INFO - PID 1642 | |1;ext.html;806.749907528666;831.3889291370843;1022.5143057047903;1071.3036526257936;1144.4907016377715;36702.63297367029;37554.8733537994;37587.24825503488;37641.435378469345;37682.81158594203;37913.62086379135;38307;38385.04037399066;38398;38757.22485550287;8057.113717491056;8219.095899451055;8225.588720563977;8641.179087986631;8793.384463087586;8793.03276639569;8910.732678019669;8918.821623567525;8928.642854285821;8939.731808045737;8841.646334146626;8856.601452934634;8937.821243575125;8948.194662480375;8954.462732236054;8849.601767920427;8893.155150260714;8896.288296936229;8898.911010889939;8915.910840891573;8613.267872230868;8622.223999839982;8670.219680228747;8682.26200772935;8693.347998900108;38066;38225.426618600744;38360.23279534394;38393.040173995876;38395.04012399684;3612.096975756061;3652.726045546568;3661.5972243053243;3665.816709164558;3672.8714494992814;30864.074077777703;31062.757489700383;31207.907723229804;31244;31267.530987035214;3199.984000080008;3209.117492689529;3222.677732226782;3237.53055806909;3244.497102949023;234173;296619;297332;300539;301644.4917775397;39595;40536.391954120714;47162;49378.75310623424;49608.75195623999;50151;50203;50318;50513.74743126261;50546.49453505492;14788;14897;14899.404023839143;14903.627409314637;14908.478203262834;12045.156839021185;12051.879481205251;12058.216215945935;12058.819117713241;12064.819027714591;13540.796888046687;13645.863541364657;13700.794488082687;13754.005669177914;13902.652433689036;5176.559992400613;6062.302835174011;6093.451589356979;6101.725422355916;6135.693215339215;1020.7805321855836;1021.7496713305139;1023.8720159980003;1051.9263651544472;1063.7393838509615;23265.767342326697;23454.413639659146;24323.932465740258;24453.755462445504;24682.629760553245;1079.7367080515814;1136.0286954653818;1146.5643055638805;1169.6140273709655;1189.4766302826729;9806.509674516246;11917.702057448632;12530.874691252971;12533.623991280276;12539.811902821464;381563;381693;383101;383213;384406;44840.77579612081;46857.765711171225;51455;53586.19620705693;53677.1948420774;1376.717772856562;1459.4818839312316;1487.7396455620224;1518.4457672949293;1558.1508078097463;20133.798662013778;24139.396515087265;24320.513589727754;24344.147954821496;24805.50388992246;38565.22869542537;38635.42046869243;38668;38704.61295387123;38767.418488723255;315870;334306;334878;335117;335869;35229;35239.29521409506;35249;35959;36088.81955590205;45021.099578007605;45409.77295113636;45919.93360298728;45961.540384595726;45976;25270.49459010846;29902.850485747433;30526.542101868046;31275.84362078175;31544;30457.933972310864;31000.534991974688;31052.844735776176;31168.753249870657;31493.52759708652;36019;36742.44886326654;36862.8156859214;36948.815255923546;37090.81454592818;31460.528092079094;31473.370532589677;31711.04866853998;31830.68169318277;31899.84050079735;20339;22625.660615091118;23825;24247.362895565806;24424.511509770062 15:50:46 INFO - PID 1642 | |2;jquery.html;411.6994593946419;432.8593207207658;445.85064003558807;446.2302528138961;461.6514531528696;19854.801451985477;21475.355739327806;22141.225057123003;22345;22354.329370118903;22350.994205260762;22930.197443089495;23337.533249335003;23719.76280237197;23922.76077239227;6036;6093.598472351351;6277.560570760049;6281;6296.496280297565;6032.728527216286;6174.84562885927;6180.536459765513;6185.134081228632;6193;5969.611975221618;6146.323904370515;6148.938510614881;6167.444929956303;6205.9379406206035;6157.907631385533;6170.413810687977;6214.440700336969;6221.191245138149;6232.563720539564;5453.809116680937;5474.808381706621;5499.450054994509;5558.194061861008;5561.694106824123;22645.886770566205;26963.1911042669;27321.043763468184;28000.159995200178;28150.155495335173;2225.354647152324;2282.6804247405375;2286.0627142871344;2286.1084177170915;2287.2337766848127;17781.822181778145;17843.73234401485;17946;18496.35262765797;18721;1734.6010417604023;1982.157583027222;2007.5984803039305;2034.1761586557468;2040.8877511736848;144554;144812;144896;145825;164608.07007194086;12201.68168048068;12869.806952895715;12904.935475322563;12942.935285323512;12992.805107923388;16504.587385315463;16593.170341482877;16667.24997375121;16667.83332166663;16668.416605418995;7340.37606803417;7661.731839385595;9224.354295199406;9276.7680807979;9306.906930930603;8671.393002489891;8728.607212675444;8757.69348072827;8902.955485222532;8908.821823563621;6385.904211436832;7013.193482749447;7380.077490313711;7774.65014074368;7806.687732490636;1682.7812384389952;2163.913443462244;2194.626913424722;2201.317591546626;2204.151401710353;934.0612684252283;947.1664934857281;975.8048390321964;996.5913975270105;1021.443313394187;21084;21517.462063448227;21689.13243470275;21690.34928952134;21813.345599632037;1008.1581879130861;1030.907218350352;1036.233187441288;1050.6742909698019;1051.831706926888;10515.42165180907;10997.680278366648;11088.501017454233;11107.722306942229;11161.609343672932;599063;701757;712215.6335309949;722749;730404;151607.24196378948;156072;160383;162317;163161;1104.5913012185542;1181.421103659218;1194.1044216837372;1202.1164444133556;1205.6443349212004;21333.040013199752;21361.25235616746;22530.5493890118;22728.545429090995;22837.657435138153;57181.42818571928;64168;64676.059718208526;64994.70010599856;65275.67362163159;90343.74140646274;90347.54826225826;90557.54721226351;90951;90993.18013639822;8703.086175951687;8935.776605584912;8957.641694332153;8987.46075235488;9087.818243635222;11464.796196399258;12547.372631368578;13367.532136375181;13556.186628802303;13719.45122195101;11896;11944.581939632071;12047.096467764777;12149.939250303692;12169.087318450975;10859.402732849769;10948.397838118979;11096.778064438828;11214.55141794319;11469.426528673366;9281.257499400166;11491.482883270106;11660.30038197711;11689.006434453167;11890.762184756084;8444.113368096261;8559.657613695383;8845.115488451103;8909.37634365614;8944.910550894409;11788.646340609796;11797.587084452003;11975.64073077809;12058.03535717158;12096.939515302367 15:50:46 INFO - PID 1642 | |3;mootools.html;1280.8270883430737;1463.9926800366004;1467.2443691498872;1467.9266036698161;1482.9184394858278;11525.36610486423;11976.940115299432;11980.101492388063;11988.64034078978;12352.011839052877;11747.060235181187;11771.587994420197;11812.17314787963;11956.701082472942;11977.640670779869;2536.5180615683007;2574.7940164786864;2578.8968441262327;2583.8191326607143;2585.043533892453;2482.40754603983;2508.6613307203565;2553.502067096917;2555.2589748972778;2558.0535201975295;2470.308313672175;2516.55960206964;2531.6455696202547;2544.3639090227443;2551.081610620175;2456.742042085591;2523.3187039499326;2532.2909585316143;2534.1383929463977;2537.175417989161;2461.4953934443397;2492.264781889347;2513.3842208658994;2563.2054063240457;2571.3443072016516;11975;11991;12106.970907472876;12109.697257568543;12122.636320910387;6593.307702691196;6831.897521537181;6851.1778586569435;6851.212110607295;6854.794356169323;4075.7350772200007;4288.421063156465;4298.861830863456;4371.693981421302;4383.298672212431;1215.1918973882357;1241.962741117768;1267.5436842736608;1287.182639024217;1289.5293217975466;15244.23778811066;15765;16301.755473667905;16399.508014759576;16566.751498727528;4646.465656449552;5259.815906443333;5884.146798714248;5886.6173698709445;5915.615484993462;12349.259044457362;12444;12457.252564846138;12458.563950261878;12463.065270104778;6241.687915604201;6322.557420980579;6322.873542529215;6327.367263273636;6333.145025421509;5882.470577648032;5922.970385148046;6052.273727152769;6197.25632924052;6286.717097730613;3788.6400791924725;4423.977880110579;4532.5694059064335;4584;4606.815727370935;1323.9007074469453;1326.2559733949824;1327.3164320375015;1340.1958824705098;1345.9192448453125;776.1539921485607;796.3310818912141;816.1512027491461;816.31429599137;837.1544739812712;6097.390260973867;6156.907646385308;6216.720247588869;6330.936690633035;6373.362663733589;502.9823956161517;599.5413508665874;602.8040886711836;604.1360853978765;612.2469362683923;3890.7471014383973;3990.6408423242046;4210.810513526899;4260.765657888784;4289.313709806416;14761.926190369195;15557.988730732466;15580.766288505682;15588.298526566332;15591.766123508156;12297.877021229851;14911.03078299907;15272.930894837255;15442.305096270695;15491.993020453634;10917.344959302467;10970.341779493096;11153;11219.495122719334;11229.3262404256;6062.848428789139;6793.286704895915;7030.894536581853;7105.82235444118;7130.215676275502;12795.93602031984;12945.223286602833;12969.157004794659;12991.15557488798;13209.405576748877;13463.663408414475;13611.183329000292;13624.182549046693;13710.862891371358;13714.0400171987;9674.22606191489;9788.265880058882;9845.163161131384;9879;9900.257480688833;10768;10781.9460902695;10986.01125898673;10990.945045274722;10993.61522346714;9232.307576931622;9322.627094916128;9376.953115234654;9416.05839416053;9505.66730164441;7823.491473054233;8880.1563851434;9053.502057386908;9106.134917182857;9196.172344489029;8167.509949403055;8268.338532917232;8304;8364.916350836656;8382.455140415854;6094.238220222473;6127.437503436773;6146.170267014075;6192.690365481798;6287.654179020198;6132.969335153474;6233.875322493434;6276.748930042747;6340.809775706736;6459.709313081016 15:50:46 INFO - PID 1642 | |4;prototype.html;406.4249087541129;407.3441460463218;410.5094412177449;412.13246116923875;418.2909967604907;5549.1676248562735;5961.374055724152;5970.79102231422;6095.085737139431;6153.969230153854;5340.798320377923;5488.670679759217;5801.216835727176;5927.792527261547;5989.3112292086425;3266.395716792401;3974.3442332015184;4288.270993931039;4366.476022877259;4403.625691816192;4269.124829409979;4426.734395936254;4436.578525040132;4472.284434490482;4485.484169320521;3577.427611582147;4383;4390.9242235652155;4425.889352766175;4448.729219948853;3913.3151698452943;4355.8457008892665;4395.230834603932;4435.068635586531;4441.933370999438;3298.795939482096;3712.867575389505;3813.504244448232;3819.1216020315205;3827.961720382816;5011.348524691767;5466.387415712375;5815.447532484407;5830.4169583041785;5863.413658634145;3949.8617548385955;5021.799128034874;5267;5282;5308.73456327186;6321.683915804238;6349.650769207692;6350.682465876687;6359.36406359365;6379.425851673372;3759.887203383903;3864.2657895000143;4280.9143817123795;4296.5059018213;4337.609615134622;5215.6349055566125;5593.244911936918;6177.567570270083;6382.87234255317;6741.123653925008;4399.9660079881205;4404.757738324359;4420.248557745191;4438.733675979452;4443.755593442327;3951.92096158081;4106.630403263721;4473.217186992263;4501.257292546693;4538.387317712132;4316.827326906951;5017.598592112622;5250.606204534599;5274.419813820554;5295.311609490818;5658.801941932013;6154.98442756949;6469.126667899774;6476.740930362827;6554.557997240599;1518.6051626577168;1523.3449616664718;1525.4965861265755;1525.7024880148265;1530.6453788397125;931.3713243560569;960.5917485068818;963.494165563085;1010.9494525273707;1015.4212099103588;6045.274567051982;6049.578349087961;6080.540670239111;6099.634021958696;6109.358517355702;5144.948550514447;6528.347165283433;6563.671816409161;6572.277573850706;6584.6378449184795;5118.564921981599;5128.230765385148;5728.398518155534;6000.819975400745;6044.123602077674;3328.833558322074;3419;3419.794812311269;3422.3155368926314;3430.7134824440836;6229.595076320024;6457.903131453032;6518.543701940914;6736.46108311334;6747.797566073025;5222.451642577551;5875.794347197828;6836.487263455261;6878.7248510060035;6898.034275201476;5627.6904770237215;6751.56114852533;6854.383105520527;6861.622610756356;6874.243833178346;5525.696086715108;6212.285587157535;6331.556791024768;6663.300353462817;6671.099401580725;5086.415062267886;6189.597676151036;6260.311365749672;6556.246031706415;6633.469322454289;4943.060818444484;5639.718014099197;6285.088662144055;6399.7440102395385;6855.211650660238;4004.599540045972;4196.454460920061;4340.459137006444;4371.475422949266;4405.449318835145;6494.642794646151;6574.572652777554;6598.406143447113;6608.372204640552;6655.733770649314;5747.683877386784;5838.182654428469;6343.397377249154;6434.774782882577;6442.194725659293;4778.116048531033;5278.656887302467;6149.754009839735;6400.615963042233;6459.160309159967;4720.622350212044;5413.431589683027;6259.436650701458;6267.46726528232;6279;5631.802886898939;6249.843753906189;6326.873462530815;6427.935720642734;6430.549861509837;5445.292112025411;6219.533534984985;6244.718987645658;6268.52986026059;6284.685765711604 15:50:46 INFO - PID 1642 | |5;yui.html;778.5951305321237;841.3143288220105;858.4463021351229;865.4763867859945;875.2560323724832;14307.57077287683;15025.32386042628;15616.141112238822;16686;17123.82876171238;17185.82814171858;17809.73285400717;17878.374256900977;17942.551436214068;18164.909175454137;975.8682577851988;1000.6997900629818;1009.7172791618359;1015.9390436573792;1018.5416562546847;1004.7237009822285;1007.6775431861807;1021.0249212002519;1024.7182024943163;1026.009900446073;1065.984010239847;1072.1155047086147;1075.1184029096144;1084.7993121272589;1085.4138765066893;1056.873175218971;1061.9044286014218;1064.2443864855961;1072.3512275073624;1073.8013467508536;781.8514482248355;786.2844811221761;786.9016372953381;791.9981223751959;793.7261644732615;14882.181480018595;16966.830331696772;17278.395256165975;17513.562160945952;17677.823221767747;17148.657026859393;17243.74134387985;17342.826571734247;17372.739408908878;17780.91109544444;13958.232297223649;14009.13834860561;14131.222782746945;14255.429782808675;14296.285185740671;3363.596368435779;3448.77582957107;3454.447288433864;3454.602720687128;3459.584849818038;118164.40917795357;118950;119088.21367679579;119575;120304;12293.877061229452;12344.81482777759;12358.50565977351;12376.690582735324;12417.19288246261;20789.584208316053;20924;20962.16151353959;21099;21125.471863203235;7670.4247181461615;7892.250236227549;8356.874646880302;8736.78158046054;8826.205641492168;4878.390201224847;4923.75381230937;4985.5762260208285;4990.076835785391;4998.000399920031;3843.36584463566;4339.913201735948;4392.857856957214;4442.622377097983;4517.661175411858;791.6318911706085;827.4166712467696;901.1484147480699;954.8281309364381;955.8566215067796;660.2209392916309;661.6460193796296;667.5393978155057;673.0711617967174;677.8779819632514;10703.946480267548;10935.781284374269;11965.162438629386;11994;12019.21875078117;666.9266380698119;675.4596322941627;681.7477533312706;683.4122654517112;691.5815931361453;5525.143602741581;5657;5706.17402431218;5726.77092916287;5828.125781132864;100848.49575752074;100975.49512252392;101167.49416253019;104700.95938966965;105213;85600.57199713962;92938.07061929429;93043;95252;95459;66457.66771166114;80183;81627.18372816315;82191.76712349319;82377.76433353504;8975.416597921114;10103.696889093339;11465.025472834903;11476.254043487146;11554.480048397674;40463.393049104874;40710;40710.79644601758;40831;40970.38544421776;53213.4678653224;53362.73318633382;53737.46262537324;53963.730181348845;54456;11889.643310700692;14062.78905816434;14109.858901411266;14120.011599188369;14339;15489;15631.92184039118;15890.364385424453;15920.920395398412;15964.441244556385;14384.35270412813;14492.275386230856;14715.043522171025;14799.630009249855;14804.185769782334;14674.41302347894;14692.118472891661;14694.338754755849;14768.926155369154;14847.851521484647;14315.856841431869;14333.56999290023;14511.564653060424;14619.853801462275;14653.267336633338;10795.6221532246;10817.026467617952;10943.343399396063;11084.944575277072;11162.832557511481;11660.475278612314;11747.706307342043;11820.527178913091;11894.405279736151;11922.463489142836 15:50:46 INFO - PID 1642 | __end_tp_report 15:50:46 INFO - PID 1642 | __start_cc_report 15:50:46 INFO - PID 1642 | _x_x_mozilla_cycle_collect,426 15:50:46 INFO - PID 1642 | __end_cc_report 15:50:46 INFO - PID 1642 | __startTimestamp1491691846817__endTimestamp 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | ------- Summary: start ------- 15:50:46 INFO - PID 1642 | Number of tests: 6 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:5904.25 Median:6191.78 stddev:724.44 (11.7%) stddev-sans-first:689.67 15:50:46 INFO - PID 1642 | Values: 2991.0 3161.3 3483.9 3515.8 3517.7 4647.8 5595.4 5957.8 5985.4 6032.5 6067.7 6069.9 6091.0 6098.5 6120.8 5255.1 5285.0 5329.7 5337.4 5373.2 5341.8 5386.6 5401.3 5434.1 5474.7 5222.9 5284.7 5311.8 5319.2 5331.8 5304.7 5311.4 5312.9 5315.5 5322.1 5152.8 5267.0 5270.7 5284.8 5286.8 5680.0 5700.2 5916.8 5992.1 6065.0 6458.3 6462.0 6476.6 6487.7 6488.3 6547.3 6551.7 6559.2 6560.6 6596.4 4999.6 6037.0 6096.4 6191.8 6228.3 6508.4 6598.5 6648.8 6650.7 6668.8 5264.8 6046.9 6229.8 6285.3 6301.5 4900.3 6509.0 6546.3 6547.5 6549.5 6225.1 6435.6 6455.9 6469.7 6498.3 5339.0 6300.5 6349.9 6431.7 6471.4 5158.5 5186.9 5206.1 5211.5 5227.9 4159.8 4653.6 4658.8 4660.9 4673.6 4726.5 6059.7 6108.9 6112.0 6241.8 5974.2 6105.7 6320.0 6425.2 6543.2 6194.0 6233.1 6242.8 6243.4 6254.2 5668.7 5701.8 5714.2 5730.9 5759.7 6430.4 6517.8 6598.0 6668.0 6684.1 5609.7 6504.1 6531.9 6542.1 6562.7 6585.5 6677.7 6697.7 6708.1 6710.5 6287.2 6320.5 6336.8 6353.8 6429.9 5448.0 5451.8 6510.3 6533.2 6550.2 5461.5 6113.5 6276.6 6294.8 6360.7 6245.5 6353.3 6375.4 6383.9 6397.7 5314.4 5961.2 6126.2 6170.0 6208.7 6274.1 6320.7 6379.6 6401.1 6401.3 6237.9 6268.4 6293.5 6294.9 6296.2 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:47898.11 Median:35989.00 stddev:88516.63 (246.0%) stddev-sans-first:88694.33 15:50:46 INFO - PID 1642 | Values: 806.7 831.4 1022.5 1071.3 1144.5 36702.6 37554.9 37587.2 37641.4 37682.8 37913.6 38307.0 38385.0 38398.0 38757.2 8057.1 8219.1 8225.6 8641.2 8793.4 8793.0 8910.7 8918.8 8928.6 8939.7 8841.6 8856.6 8937.8 8948.2 8954.5 8849.6 8893.2 8896.3 8898.9 8915.9 8613.3 8622.2 8670.2 8682.3 8693.3 38066.0 38225.4 38360.2 38393.0 38395.0 3612.1 3652.7 3661.6 3665.8 3672.9 30864.1 31062.8 31207.9 31244.0 31267.5 3200.0 3209.1 3222.7 3237.5 3244.5 234173.0 296619.0 297332.0 300539.0 301644.5 39595.0 40536.4 47162.0 49378.8 49608.8 50151.0 50203.0 50318.0 50513.7 50546.5 14788.0 14897.0 14899.4 14903.6 14908.5 12045.2 12051.9 12058.2 12058.8 12064.8 13540.8 13645.9 13700.8 13754.0 13902.7 5176.6 6062.3 6093.5 6101.7 6135.7 1020.8 1021.7 1023.9 1051.9 1063.7 23265.8 23454.4 24323.9 24453.8 24682.6 1079.7 1136.0 1146.6 1169.6 1189.5 9806.5 11917.7 12530.9 12533.6 12539.8 381563.0 381693.0 383101.0 383213.0 384406.0 44840.8 46857.8 51455.0 53586.2 53677.2 1376.7 1459.5 1487.7 1518.4 1558.2 20133.8 24139.4 24320.5 24344.1 24805.5 38565.2 38635.4 38668.0 38704.6 38767.4 315870.0 334306.0 334878.0 335117.0 335869.0 35229.0 35239.3 35249.0 35959.0 36088.8 45021.1 45409.8 45919.9 45961.5 45976.0 25270.5 29902.9 30526.5 31275.8 31544.0 30457.9 31000.5 31052.8 31168.8 31493.5 36019.0 36742.4 36862.8 36948.8 37090.8 31460.5 31473.4 31711.0 31830.7 31899.8 20339.0 22625.7 23825.0 24247.4 24424.5 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:40839.25 Median:22687.22 stddev:116676.47 (514.3%) stddev-sans-first:116964.29 15:50:46 INFO - PID 1642 | Values: 411.7 432.9 445.9 446.2 461.7 19854.8 21475.4 22141.2 22345.0 22354.3 22351.0 22930.2 23337.5 23719.8 23922.8 6036.0 6093.6 6277.6 6281.0 6296.5 6032.7 6174.8 6180.5 6185.1 6193.0 5969.6 6146.3 6148.9 6167.4 6205.9 6157.9 6170.4 6214.4 6221.2 6232.6 5453.8 5474.8 5499.5 5558.2 5561.7 22645.9 26963.2 27321.0 28000.2 28150.2 2225.4 2282.7 2286.1 2286.1 2287.2 17781.8 17843.7 17946.0 18496.4 18721.0 1734.6 1982.2 2007.6 2034.2 2040.9 144554.0 144812.0 144896.0 145825.0 164608.1 12201.7 12869.8 12904.9 12942.9 12992.8 16504.6 16593.2 16667.2 16667.8 16668.4 7340.4 7661.7 9224.4 9276.8 9306.9 8671.4 8728.6 8757.7 8903.0 8908.8 6385.9 7013.2 7380.1 7774.7 7806.7 1682.8 2163.9 2194.6 2201.3 2204.2 934.1 947.2 975.8 996.6 1021.4 21084.0 21517.5 21689.1 21690.3 21813.3 1008.2 1030.9 1036.2 1050.7 1051.8 10515.4 10997.7 11088.5 11107.7 11161.6 599063.0 701757.0 712215.6 722749.0 730404.0 151607.2 156072.0 160383.0 162317.0 163161.0 1104.6 1181.4 1194.1 1202.1 1205.6 21333.0 21361.3 22530.5 22728.5 22837.7 57181.4 64168.0 64676.1 64994.7 65275.7 90343.7 90347.5 90557.5 90951.0 90993.2 8703.1 8935.8 8957.6 8987.5 9087.8 11464.8 12547.4 13367.5 13556.2 13719.5 11896.0 11944.6 12047.1 12149.9 12169.1 10859.4 10948.4 11096.8 11214.6 11469.4 9281.3 11491.5 11660.3 11689.0 11890.8 8444.1 8559.7 8845.1 8909.4 8944.9 11788.6 11797.6 11975.6 12058.0 12096.9 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7235.17 Median:2573.07 stddev:4575.49 (177.8%) stddev-sans-first:4566.45 15:50:46 INFO - PID 1642 | Values: 1280.8 1464.0 1467.2 1467.9 1482.9 11525.4 11976.9 11980.1 11988.6 12352.0 11747.1 11771.6 11812.2 11956.7 11977.6 2536.5 2574.8 2578.9 2583.8 2585.0 2482.4 2508.7 2553.5 2555.3 2558.1 2470.3 2516.6 2531.6 2544.4 2551.1 2456.7 2523.3 2532.3 2534.1 2537.2 2461.5 2492.3 2513.4 2563.2 2571.3 11975.0 11991.0 12107.0 12109.7 12122.6 6593.3 6831.9 6851.2 6851.2 6854.8 4075.7 4288.4 4298.9 4371.7 4383.3 1215.2 1242.0 1267.5 1287.2 1289.5 15244.2 15765.0 16301.8 16399.5 16566.8 4646.5 5259.8 5884.1 5886.6 5915.6 12349.3 12444.0 12457.3 12458.6 12463.1 6241.7 6322.6 6322.9 6327.4 6333.1 5882.5 5923.0 6052.3 6197.3 6286.7 3788.6 4424.0 4532.6 4584.0 4606.8 1323.9 1326.3 1327.3 1340.2 1345.9 776.2 796.3 816.2 816.3 837.2 6097.4 6156.9 6216.7 6330.9 6373.4 503.0 599.5 602.8 604.1 612.2 3890.7 3990.6 4210.8 4260.8 4289.3 14761.9 15558.0 15580.8 15588.3 15591.8 12297.9 14911.0 15272.9 15442.3 15492.0 10917.3 10970.3 11153.0 11219.5 11229.3 6062.8 6793.3 7030.9 7105.8 7130.2 12795.9 12945.2 12969.2 12991.2 13209.4 13463.7 13611.2 13624.2 13710.9 13714.0 9674.2 9788.3 9845.2 9879.0 9900.3 10768.0 10781.9 10986.0 10990.9 10993.6 9232.3 9322.6 9377.0 9416.1 9505.7 7823.5 8880.2 9053.5 9106.1 9196.2 8167.5 8268.3 8304.0 8364.9 8382.5 6094.2 6127.4 6146.2 6192.7 6287.7 6133.0 6233.9 6276.7 6340.8 6459.7 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5071.54 Median:5610.47 stddev:1590.38 (28.3%) stddev-sans-first:1555.82 15:50:46 INFO - PID 1642 | Values: 406.4 407.3 410.5 412.1 418.3 5549.2 5961.4 5970.8 6095.1 6154.0 5340.8 5488.7 5801.2 5927.8 5989.3 3266.4 3974.3 4288.3 4366.5 4403.6 4269.1 4426.7 4436.6 4472.3 4485.5 3577.4 4383.0 4390.9 4425.9 4448.7 3913.3 4355.8 4395.2 4435.1 4441.9 3298.8 3712.9 3813.5 3819.1 3828.0 5011.3 5466.4 5815.4 5830.4 5863.4 3949.9 5021.8 5267.0 5282.0 5308.7 6321.7 6349.7 6350.7 6359.4 6379.4 3759.9 3864.3 4280.9 4296.5 4337.6 5215.6 5593.2 6177.6 6382.9 6741.1 4400.0 4404.8 4420.2 4438.7 4443.8 3951.9 4106.6 4473.2 4501.3 4538.4 4316.8 5017.6 5250.6 5274.4 5295.3 5658.8 6155.0 6469.1 6476.7 6554.6 1518.6 1523.3 1525.5 1525.7 1530.6 931.4 960.6 963.5 1010.9 1015.4 6045.3 6049.6 6080.5 6099.6 6109.4 5144.9 6528.3 6563.7 6572.3 6584.6 5118.6 5128.2 5728.4 6000.8 6044.1 3328.8 3419.0 3419.8 3422.3 3430.7 6229.6 6457.9 6518.5 6736.5 6747.8 5222.5 5875.8 6836.5 6878.7 6898.0 5627.7 6751.6 6854.4 6861.6 6874.2 5525.7 6212.3 6331.6 6663.3 6671.1 5086.4 6189.6 6260.3 6556.2 6633.5 4943.1 5639.7 6285.1 6399.7 6855.2 4004.6 4196.5 4340.5 4371.5 4405.4 6494.6 6574.6 6598.4 6608.4 6655.7 5747.7 5838.2 6343.4 6434.8 6442.2 4778.1 5278.7 6149.8 6400.6 6459.2 4720.6 5413.4 6259.4 6267.5 6279.0 5631.8 6249.8 6326.9 6427.9 6430.5 5445.3 6219.5 6244.7 6268.5 6284.7 15:50:46 INFO - PID 1642 | 15:50:46 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:20989.78 Median:17167.24 stddev:29849.07 (173.9%) stddev-sans-first:29894.22 15:50:46 INFO - PID 1642 | Values: 778.6 841.3 858.4 865.5 875.3 14307.6 15025.3 15616.1 16686.0 17123.8 17185.8 17809.7 17878.4 17942.6 18164.9 975.9 1000.7 1009.7 1015.9 1018.5 1004.7 1007.7 1021.0 1024.7 1026.0 1066.0 1072.1 1075.1 1084.8 1085.4 1056.9 1061.9 1064.2 1072.4 1073.8 781.9 786.3 786.9 792.0 793.7 14882.2 16966.8 17278.4 17513.6 17677.8 17148.7 17243.7 17342.8 17372.7 17780.9 13958.2 14009.1 14131.2 14255.4 14296.3 3363.6 3448.8 3454.4 3454.6 3459.6 118164.4 118950.0 119088.2 119575.0 120304.0 12293.9 12344.8 12358.5 12376.7 12417.2 20789.6 20924.0 20962.2 21099.0 21125.5 7670.4 7892.3 8356.9 8736.8 8826.2 4878.4 4923.8 4985.6 4990.1 4998.0 3843.4 4339.9 4392.9 4442.6 4517.7 791.6 827.4 901.1 954.8 955.9 660.2 661.6 667.5 673.1 677.9 10703.9 10935.8 11965.2 11994.0 12019.2 666.9 675.5 681.7 683.4 691.6 5525.1 5657.0 5706.2 5726.8 5828.1 100848.5 100975.5 101167.5 104701.0 105213.0 85600.6 92938.1 93043.0 95252.0 95459.0 66457.7 80183.0 81627.2 82191.8 82377.8 8975.4 10103.7 11465.0 11476.3 11554.5 40463.4 40710.0 40710.8 40831.0 40970.4 53213.5 53362.7 53737.5 53963.7 54456.0 11889.6 14062.8 14109.9 14120.0 14339.0 15489.0 15631.9 15890.4 15920.9 15964.4 14384.4 14492.3 14715.0 14799.6 14804.2 14674.4 14692.1 14694.3 14768.9 14847.9 14315.9 14333.6 14511.6 14619.9 14653.3 10795.6 10817.0 10943.3 11084.9 11162.8 11660.5 11747.7 11820.5 11894.4 11922.5 15:50:46 INFO - PID 1642 | -------- Summary: end -------- 15:50:46 INFO - PID 1642 | 15:50:47 INFO - TEST-INFO | 1642: exit 0 15:50:47 INFO - TEST-OK | dromaeo_css | took 1115007ms 15:50:47 INFO - TEST-START | kraken 15:50:47 INFO - operating with platform_type : mac_ 15:50:47 INFO - Initialising browser for kraken test... 15:50:47 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpfDNHyy/profile http://localhost:49235/getInfo.html) 15:50:50 INFO - PID 1650 | 2017-04-08 15:50:50.367 plugin-container[1651:10638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 15:50:50 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:50:50 INFO - PID 1650 | 2017-04-08 15:50:50.372 plugin-container[1651:10638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8953, name = 'com.apple.CFPasteboardClient' 15:50:50 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:50:50 INFO - PID 1650 | 2017-04-08 15:50:50.372 plugin-container[1651:10638] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:50:50 INFO - PID 1650 | __metrics Screen width/height:1600/1200 15:50:50 INFO - PID 1650 | colorDepth:24 15:50:50 INFO - PID 1650 | Browser inner width/height: 1024/689 15:50:50 INFO - PID 1650 | __metrics 15:50:50 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 15:50:51 INFO - TEST-INFO | 1650: exit 0 15:50:51 INFO - Browser initialized. 15:50:51 INFO - Running cycle 1/1 for kraken test... 15:50:51 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpfDNHyy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:54 INFO - PID 1652 | 2017-04-08 15:50:54.164 plugin-container[1653:10765] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 15:50:54 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:50:54 INFO - PID 1652 | 2017-04-08 15:50:54.165 plugin-container[1653:10765] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.CFPasteboardClient' 15:50:54 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:50:54 INFO - PID 1652 | 2017-04-08 15:50:54.165 plugin-container[1653:10765] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:51:03 INFO - PID 1652 | RSS: Main: 234459136 15:51:03 INFO - PID 1652 | 15:51:06 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:07 INFO - PID 1652 | RSS: Main: 248840192 15:51:07 INFO - PID 1652 | 15:51:10 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 15:51:11 INFO - PID 1652 | RSS: Main: 256983040 15:51:11 INFO - PID 1652 | 15:51:15 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 15:51:15 INFO - PID 1652 | RSS: Main: 259727360 15:51:15 INFO - PID 1652 | 15:51:17 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 15:51:18 INFO - PID 1652 | RSS: Main: 261693440 15:51:18 INFO - PID 1652 | 15:51:20 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:21 INFO - PID 1652 | RSS: Main: 262103040 15:51:21 INFO - PID 1652 | 15:51:24 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:25 INFO - PID 1652 | RSS: Main: 267276288 15:51:25 INFO - PID 1652 | 15:51:28 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:28 INFO - PID 1652 | RSS: Main: 268464128 15:51:28 INFO - PID 1652 | 15:51:32 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 15:51:32 INFO - PID 1652 | RSS: Main: 268292096 15:51:32 INFO - PID 1652 | 15:51:34 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:34 INFO - PID 1652 | RSS: Main: 267698176 15:51:34 INFO - PID 1652 | 15:51:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:37 INFO - PID 1652 | RSS: Main: 267669504 15:51:37 INFO - PID 1652 | 15:51:39 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:40 INFO - PID 1652 | RSS: Main: 267644928 15:51:40 INFO - PID 1652 | 15:51:43 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:44 INFO - PID 1652 | RSS: Main: 267972608 15:51:44 INFO - PID 1652 | 15:51:47 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:47 INFO - PID 1652 | RSS: Main: 267821056 15:51:47 INFO - PID 1652 | 15:51:49 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 15:51:50 INFO - PID 1652 | RSS: Main: 270950400 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | __start_tp_report 15:51:50 INFO - PID 1652 | _x_x_mozilla_page_load 15:51:50 INFO - PID 1652 | _x_x_mozilla_page_load_details 15:51:50 INFO - PID 1652 | |i|pagename|runs| 15:51:50 INFO - PID 1652 | |0;ai-astar;110;122;123;123;123;125;126;122;123;105 15:51:50 INFO - PID 1652 | |1;audio-beat-detection;150;146;144;197;97;95;150;155;121;142 15:51:50 INFO - PID 1652 | |2;audio-dft;211;279;286;264;194;271;303;231;228;302 15:51:50 INFO - PID 1652 | |3;audio-fft;91;90;89;84;71;51;68;87;102;51 15:51:50 INFO - PID 1652 | |4;audio-oscillator;89;99;126;73;74;73;87;70;72;88 15:51:50 INFO - PID 1652 | |5;imaging-gaussian-blur;92;93;89;141;102;87;142;143;92;90 15:51:50 INFO - PID 1652 | |6;imaging-darkroom;101;100;100;106;101;99;136;101;101;112 15:51:50 INFO - PID 1652 | |7;imaging-desaturate;105;106;123;103;104;101;106;123;102;104 15:51:50 INFO - PID 1652 | |8;json-parse-financial;52;52;53;54;53;55;52;55;73;45 15:51:50 INFO - PID 1652 | |9;json-stringify-tinderbox;60;59;65;61;67;66;60;60;61;62 15:51:50 INFO - PID 1652 | |10;stanford-crypto-aes;86;90;89;86;89;90;88;89;78;88 15:51:50 INFO - PID 1652 | |11;stanford-crypto-ccm;170;151;139;152;150;136;171;173;236;169 15:51:50 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;198;195;196;198;200;200;194;191;196;194 15:51:50 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;73;73;77;70;71;63;108;101;99;101 15:51:50 INFO - PID 1652 | __end_tp_report 15:51:50 INFO - PID 1652 | __start_cc_report 15:51:50 INFO - PID 1652 | _x_x_mozilla_cycle_collect,1017 15:51:50 INFO - PID 1652 | __end_cc_report 15:51:50 INFO - PID 1652 | __startTimestamp1491691910064__endTimestamp 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | ------- Summary: start ------- 15:51:50 INFO - PID 1652 | Number of tests: 14 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:120.20 Median:123.00 stddev:6.91 (5.6%) stddev-sans-first:6.26 15:51:50 INFO - PID 1652 | Values: 110.0 122.0 123.0 123.0 123.0 125.0 126.0 122.0 123.0 105.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:152.50 stddev:29.75 (19.5%) stddev-sans-first:31.32 15:51:50 INFO - PID 1652 | Values: 150.0 146.0 144.0 197.0 97.0 95.0 150.0 155.0 121.0 142.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:256.90 Median:275.00 stddev:38.46 (14.0%) stddev-sans-first:37.03 15:51:50 INFO - PID 1652 | Values: 211.0 279.0 286.0 264.0 194.0 271.0 303.0 231.0 228.0 302.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:78.40 Median:85.50 stddev:17.42 (20.4%) stddev-sans-first:17.87 15:51:50 INFO - PID 1652 | Values: 91.0 90.0 89.0 84.0 71.0 51.0 68.0 87.0 102.0 51.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:80.50 stddev:17.35 (21.6%) stddev-sans-first:18.34 15:51:50 INFO - PID 1652 | Values: 89.0 99.0 126.0 73.0 74.0 73.0 87.0 70.0 72.0 88.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:89.50 stddev:24.41 (27.3%) stddev-sans-first:25.27 15:51:50 INFO - PID 1652 | Values: 92.0 93.0 89.0 141.0 102.0 87.0 142.0 143.0 92.0 90.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:103.50 stddev:11.33 (11.0%) stddev-sans-first:11.89 15:51:50 INFO - PID 1652 | Values: 101.0 100.0 100.0 106.0 101.0 99.0 136.0 101.0 101.0 112.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:105.50 stddev:8.22 (7.8%) stddev-sans-first:8.66 15:51:50 INFO - PID 1652 | Values: 105.0 106.0 123.0 103.0 104.0 101.0 106.0 123.0 102.0 104.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:7.12 (13.3%) stddev-sans-first:7.50 15:51:50 INFO - PID 1652 | Values: 52.0 52.0 53.0 54.0 53.0 55.0 52.0 55.0 73.0 45.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:61.50 stddev:2.85 (4.6%) stddev-sans-first:2.92 15:51:50 INFO - PID 1652 | Values: 60.0 59.0 65.0 61.0 67.0 66.0 60.0 60.0 61.0 62.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:89.00 stddev:3.56 (4.0%) stddev-sans-first:3.75 15:51:50 INFO - PID 1652 | Values: 86.0 90.0 89.0 86.0 89.0 90.0 88.0 89.0 78.0 88.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:164.70 Median:169.50 stddev:28.46 (16.8%) stddev-sans-first:30.12 15:51:50 INFO - PID 1652 | Values: 170.0 151.0 139.0 152.0 150.0 136.0 171.0 173.0 236.0 169.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:197.00 stddev:2.86 (1.5%) stddev-sans-first:2.96 15:51:50 INFO - PID 1652 | Values: 198.0 195.0 196.0 198.0 200.0 200.0 194.0 191.0 196.0 194.0 15:51:50 INFO - PID 1652 | 15:51:50 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.60 Median:72.00 stddev:16.58 (23.0%) stddev-sans-first:17.14 15:51:50 INFO - PID 1652 | Values: 73.0 73.0 77.0 70.0 71.0 63.0 108.0 101.0 99.0 101.0 15:51:50 INFO - PID 1652 | -------- Summary: end -------- 15:51:50 INFO - PID 1652 | 15:51:51 INFO - TEST-INFO | 1652: exit 0 15:51:51 INFO - TEST-OK | kraken | took 63679ms 15:51:51 INFO - SUITE-END | took 1178s 15:51:51 INFO - Completed test suite (00:19:38) 15:51:51 INFO - javascript benchmark 15:51:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7803.679756370945, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2990.9850450747745, 3161.2571045804234, 3483.9303213935705, 3515.753897227195, 3517.665821746933, 4647.837325693601, 5595.41248168942, 5957.761689532419, 5985.4014598540125, 6032.457078862902, 6067.666278354689, 6069.908951365733, 6090.969545152279, 6098.522998457013, 6120.843333897677, 5255.106631872591, 5284.9958507883575, 5329.653572517794, 5337.412884582693, 5373.247745315659, 5341.839744807662, 5386.622936394454, 5401.27082843817, 5434.103372943459, 5474.72626368682, 5222.895542089175, 5284.682919024871, 5311.787528498855, 5319.20211968204, 5331.840044798623, 5304.734763261821, 5311.362636483646, 5312.92030619541, 5315.548178404841, 5322.121849894763, 5152.845414637567, 5267.0, 5270.710110943896, 5284.762185701653, 5286.841394758163, 5679.971600142014, 5700.173474846124, 5916.792912248094, 5992.0712289595185, 6065.0, 6458.2895881453005, 6461.967690161566, 6476.6114033158165, 6487.7080531376205, 6488.28628850826, 6547.279799222082, 6551.737930482775, 6559.245686746038, 6560.606363618198, 6596.373344532261, 4999.625028122905, 6037.034074548052, 6096.359882212304, 6191.783287584913, 6228.252609686867, 6508.446782023581, 6598.505112116611, 6648.767293144813, 6650.70071846768, 6668.83327916806, 5264.842054738364, 6046.909296360558, 6229.750809967551, 6285.277193122758, 6301.495880329563, 4900.26496025599, 6509.0, 6546.312637173029, 6547.476201903836, 6549.476041916635, 6225.066240064027, 6435.581687190318, 6455.903161452582, 6469.708863101172, 6498.252700939453, 5338.973305133527, 6300.527460440394, 6349.936500634934, 6431.678416079178, 6471.385218404244, 5158.484151584887, 5186.896262074737, 5206.088934436534, 5211.530962213419, 5227.947720522822, 4159.7920103994675, 4653.60444362233, 4658.790354434059, 4660.860174194711, 4673.556012178838, 4726.503717109723, 6059.697015149225, 6108.908366374508, 6111.9694401528595, 6241.812745617639, 5974.193483879708, 6105.748321594063, 6320.0, 6425.164728585348, 6543.247526534415, 6194.008958566607, 6233.096201050913, 6242.75028998844, 6243.375662433811, 6254.15568898202, 5668.744906479218, 5701.828945131652, 5714.200011998323, 5730.865072984161, 5759.683217423082, 6430.3891130342545, 6517.837054073591, 6597.967010164918, 6667.966660166668, 6684.097646817618, 5609.663420194802, 6504.121943537752, 6531.934680653133, 6542.149520562487, 6562.737490500326, 6585.539012269095, 6677.69950352245, 6697.732090716317, 6708.060871477899, 6710.496712746662, 6287.2140982377205, 6320.462760665395, 6336.778212762531, 6353.809385718436, 6429.903551446826, 5447.972760136174, 5451.781928722965, 6510.316416776171, 6533.216014078341, 6550.246721627074, 5461.453854614507, 6113.506711826804, 6276.560640755103, 6294.779682711083, 6360.745570177326, 6245.500359971283, 6353.332900045613, 6375.394337537927, 6383.904241436289, 6397.680115994089, 5314.388845282842, 5961.165436838759, 6126.203593532812, 6169.9691501544, 6208.720607572761, 6274.121622972696, 6320.747170113144, 6379.553431259767, 6401.071844582416, 6401.327860574573, 6237.906431403442, 6268.373162683695, 6293.496520278275, 6294.905576416266, 6296.212973378328], "value": 5858.34013868304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.749907528666, 831.3889291370843, 1022.5143057047903, 1071.3036526257936, 1144.4907016377715, 36702.63297367029, 37554.8733537994, 37587.24825503488, 37641.435378469345, 37682.81158594203, 37913.62086379135, 38307.0, 38385.04037399066, 38398.0, 38757.22485550287, 8057.113717491056, 8219.095899451055, 8225.588720563977, 8641.179087986631, 8793.384463087586, 8793.03276639569, 8910.732678019669, 8918.821623567525, 8928.642854285821, 8939.731808045737, 8841.646334146626, 8856.601452934634, 8937.821243575125, 8948.194662480375, 8954.462732236054, 8849.601767920427, 8893.155150260714, 8896.288296936229, 8898.911010889939, 8915.910840891573, 8613.267872230868, 8622.223999839982, 8670.219680228747, 8682.26200772935, 8693.347998900108, 38066.0, 38225.426618600744, 38360.23279534394, 38393.040173995876, 38395.04012399684, 3612.096975756061, 3652.726045546568, 3661.5972243053243, 3665.816709164558, 3672.8714494992814, 30864.074077777703, 31062.757489700383, 31207.907723229804, 31244.0, 31267.530987035214, 3199.984000080008, 3209.117492689529, 3222.677732226782, 3237.53055806909, 3244.497102949023, 234173.0, 296619.0, 297332.0, 300539.0, 301644.4917775397, 39595.0, 40536.391954120714, 47162.0, 49378.75310623424, 49608.75195623999, 50151.0, 50203.0, 50318.0, 50513.74743126261, 50546.49453505492, 14788.0, 14897.0, 14899.404023839143, 14903.627409314637, 14908.478203262834, 12045.156839021185, 12051.879481205251, 12058.216215945935, 12058.819117713241, 12064.819027714591, 13540.796888046687, 13645.863541364657, 13700.794488082687, 13754.005669177914, 13902.652433689036, 5176.559992400613, 6062.302835174011, 6093.451589356979, 6101.725422355916, 6135.693215339215, 1020.7805321855836, 1021.7496713305139, 1023.8720159980003, 1051.9263651544472, 1063.7393838509615, 23265.767342326697, 23454.413639659146, 24323.932465740258, 24453.755462445504, 24682.629760553245, 1079.7367080515814, 1136.0286954653818, 1146.5643055638805, 1169.6140273709655, 1189.4766302826729, 9806.509674516246, 11917.702057448632, 12530.874691252971, 12533.623991280276, 12539.811902821464, 381563.0, 381693.0, 383101.0, 383213.0, 384406.0, 44840.77579612081, 46857.765711171225, 51455.0, 53586.19620705693, 53677.1948420774, 1376.717772856562, 1459.4818839312316, 1487.7396455620224, 1518.4457672949293, 1558.1508078097463, 20133.798662013778, 24139.396515087265, 24320.513589727754, 24344.147954821496, 24805.50388992246, 38565.22869542537, 38635.42046869243, 38668.0, 38704.61295387123, 38767.418488723255, 315870.0, 334306.0, 334878.0, 335117.0, 335869.0, 35229.0, 35239.29521409506, 35249.0, 35959.0, 36088.81955590205, 45021.099578007605, 45409.77295113636, 45919.93360298728, 45961.540384595726, 45976.0, 25270.49459010846, 29902.850485747433, 30526.542101868046, 31275.84362078175, 31544.0, 30457.933972310864, 31000.534991974688, 31052.844735776176, 31168.753249870657, 31493.52759708652, 36019.0, 36742.44886326654, 36862.8156859214, 36948.815255923546, 37090.81454592818, 31460.528092079094, 31473.370532589677, 31711.04866853998, 31830.68169318277, 31899.84050079735, 20339.0, 22625.660615091118, 23825.0, 24247.362895565806, 24424.511509770062], "value": 17835.762514692666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.6994593946419, 432.8593207207658, 445.85064003558807, 446.2302528138961, 461.6514531528696, 19854.801451985477, 21475.355739327806, 22141.225057123003, 22345.0, 22354.329370118903, 22350.994205260762, 22930.197443089495, 23337.533249335003, 23719.76280237197, 23922.76077239227, 6036.0, 6093.598472351351, 6277.560570760049, 6281.0, 6296.496280297565, 6032.728527216286, 6174.84562885927, 6180.536459765513, 6185.134081228632, 6193.0, 5969.611975221618, 6146.323904370515, 6148.938510614881, 6167.444929956303, 6205.9379406206035, 6157.907631385533, 6170.413810687977, 6214.440700336969, 6221.191245138149, 6232.563720539564, 5453.809116680937, 5474.808381706621, 5499.450054994509, 5558.194061861008, 5561.694106824123, 22645.886770566205, 26963.1911042669, 27321.043763468184, 28000.159995200178, 28150.155495335173, 2225.354647152324, 2282.6804247405375, 2286.0627142871344, 2286.1084177170915, 2287.2337766848127, 17781.822181778145, 17843.73234401485, 17946.0, 18496.35262765797, 18721.0, 1734.6010417604023, 1982.157583027222, 2007.5984803039305, 2034.1761586557468, 2040.8877511736848, 144554.0, 144812.0, 144896.0, 145825.0, 164608.07007194086, 12201.68168048068, 12869.806952895715, 12904.935475322563, 12942.935285323512, 12992.805107923388, 16504.587385315463, 16593.170341482877, 16667.24997375121, 16667.83332166663, 16668.416605418995, 7340.37606803417, 7661.731839385595, 9224.354295199406, 9276.7680807979, 9306.906930930603, 8671.393002489891, 8728.607212675444, 8757.69348072827, 8902.955485222532, 8908.821823563621, 6385.904211436832, 7013.193482749447, 7380.077490313711, 7774.65014074368, 7806.687732490636, 1682.7812384389952, 2163.913443462244, 2194.626913424722, 2201.317591546626, 2204.151401710353, 934.0612684252283, 947.1664934857281, 975.8048390321964, 996.5913975270105, 1021.443313394187, 21084.0, 21517.462063448227, 21689.13243470275, 21690.34928952134, 21813.345599632037, 1008.1581879130861, 1030.907218350352, 1036.233187441288, 1050.6742909698019, 1051.831706926888, 10515.42165180907, 10997.680278366648, 11088.501017454233, 11107.722306942229, 11161.609343672932, 599063.0, 701757.0, 712215.6335309949, 722749.0, 730404.0, 151607.24196378948, 156072.0, 160383.0, 162317.0, 163161.0, 1104.5913012185542, 1181.421103659218, 1194.1044216837372, 1202.1164444133556, 1205.6443349212004, 21333.040013199752, 21361.25235616746, 22530.5493890118, 22728.545429090995, 22837.657435138153, 57181.42818571928, 64168.0, 64676.059718208526, 64994.70010599856, 65275.67362163159, 90343.74140646274, 90347.54826225826, 90557.54721226351, 90951.0, 90993.18013639822, 8703.086175951687, 8935.776605584912, 8957.641694332153, 8987.46075235488, 9087.818243635222, 11464.796196399258, 12547.372631368578, 13367.532136375181, 13556.186628802303, 13719.45122195101, 11896.0, 11944.581939632071, 12047.096467764777, 12149.939250303692, 12169.087318450975, 10859.402732849769, 10948.397838118979, 11096.778064438828, 11214.55141794319, 11469.426528673366, 9281.257499400166, 11491.482883270106, 11660.30038197711, 11689.006434453167, 11890.762184756084, 8444.113368096261, 8559.657613695383, 8845.115488451103, 8909.37634365614, 8944.910550894409, 11788.646340609796, 11797.587084452003, 11975.64073077809, 12058.03535717158, 12096.939515302367], "value": 10655.726283765225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.8270883430737, 1463.9926800366004, 1467.2443691498872, 1467.9266036698161, 1482.9184394858278, 11525.36610486423, 11976.940115299432, 11980.101492388063, 11988.64034078978, 12352.011839052877, 11747.060235181187, 11771.587994420197, 11812.17314787963, 11956.701082472942, 11977.640670779869, 2536.5180615683007, 2574.7940164786864, 2578.8968441262327, 2583.8191326607143, 2585.043533892453, 2482.40754603983, 2508.6613307203565, 2553.502067096917, 2555.2589748972778, 2558.0535201975295, 2470.308313672175, 2516.55960206964, 2531.6455696202547, 2544.3639090227443, 2551.081610620175, 2456.742042085591, 2523.3187039499326, 2532.2909585316143, 2534.1383929463977, 2537.175417989161, 2461.4953934443397, 2492.264781889347, 2513.3842208658994, 2563.2054063240457, 2571.3443072016516, 11975.0, 11991.0, 12106.970907472876, 12109.697257568543, 12122.636320910387, 6593.307702691196, 6831.897521537181, 6851.1778586569435, 6851.212110607295, 6854.794356169323, 4075.7350772200007, 4288.421063156465, 4298.861830863456, 4371.693981421302, 4383.298672212431, 1215.1918973882357, 1241.962741117768, 1267.5436842736608, 1287.182639024217, 1289.5293217975466, 15244.23778811066, 15765.0, 16301.755473667905, 16399.508014759576, 16566.751498727528, 4646.465656449552, 5259.815906443333, 5884.146798714248, 5886.6173698709445, 5915.615484993462, 12349.259044457362, 12444.0, 12457.252564846138, 12458.563950261878, 12463.065270104778, 6241.687915604201, 6322.557420980579, 6322.873542529215, 6327.367263273636, 6333.145025421509, 5882.470577648032, 5922.970385148046, 6052.273727152769, 6197.25632924052, 6286.717097730613, 3788.6400791924725, 4423.977880110579, 4532.5694059064335, 4584.0, 4606.815727370935, 1323.9007074469453, 1326.2559733949824, 1327.3164320375015, 1340.1958824705098, 1345.9192448453125, 776.1539921485607, 796.3310818912141, 816.1512027491461, 816.31429599137, 837.1544739812712, 6097.390260973867, 6156.907646385308, 6216.720247588869, 6330.936690633035, 6373.362663733589, 502.9823956161517, 599.5413508665874, 602.8040886711836, 604.1360853978765, 612.2469362683923, 3890.7471014383973, 3990.6408423242046, 4210.810513526899, 4260.765657888784, 4289.313709806416, 14761.926190369195, 15557.988730732466, 15580.766288505682, 15588.298526566332, 15591.766123508156, 12297.877021229851, 14911.03078299907, 15272.930894837255, 15442.305096270695, 15491.993020453634, 10917.344959302467, 10970.341779493096, 11153.0, 11219.495122719334, 11229.3262404256, 6062.848428789139, 6793.286704895915, 7030.894536581853, 7105.82235444118, 7130.215676275502, 12795.93602031984, 12945.223286602833, 12969.157004794659, 12991.15557488798, 13209.405576748877, 13463.663408414475, 13611.183329000292, 13624.182549046693, 13710.862891371358, 13714.0400171987, 9674.22606191489, 9788.265880058882, 9845.163161131384, 9879.0, 9900.257480688833, 10768.0, 10781.9460902695, 10986.01125898673, 10990.945045274722, 10993.61522346714, 9232.307576931622, 9322.627094916128, 9376.953115234654, 9416.05839416053, 9505.66730164441, 7823.491473054233, 8880.1563851434, 9053.502057386908, 9106.134917182857, 9196.172344489029, 8167.509949403055, 8268.338532917232, 8304.0, 8364.916350836656, 8382.455140415854, 6094.238220222473, 6127.437503436773, 6146.170267014075, 6192.690365481798, 6287.654179020198, 6132.969335153474, 6233.875322493434, 6276.748930042747, 6340.809775706736, 6459.709313081016], "value": 5406.934271721564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.4249087541129, 407.3441460463218, 410.5094412177449, 412.13246116923875, 418.2909967604907, 5549.1676248562735, 5961.374055724152, 5970.79102231422, 6095.085737139431, 6153.969230153854, 5340.798320377923, 5488.670679759217, 5801.216835727176, 5927.792527261547, 5989.3112292086425, 3266.395716792401, 3974.3442332015184, 4288.270993931039, 4366.476022877259, 4403.625691816192, 4269.124829409979, 4426.734395936254, 4436.578525040132, 4472.284434490482, 4485.484169320521, 3577.427611582147, 4383.0, 4390.9242235652155, 4425.889352766175, 4448.729219948853, 3913.3151698452943, 4355.8457008892665, 4395.230834603932, 4435.068635586531, 4441.933370999438, 3298.795939482096, 3712.867575389505, 3813.504244448232, 3819.1216020315205, 3827.961720382816, 5011.348524691767, 5466.387415712375, 5815.447532484407, 5830.4169583041785, 5863.413658634145, 3949.8617548385955, 5021.799128034874, 5267.0, 5282.0, 5308.73456327186, 6321.683915804238, 6349.650769207692, 6350.682465876687, 6359.36406359365, 6379.425851673372, 3759.887203383903, 3864.2657895000143, 4280.9143817123795, 4296.5059018213, 4337.609615134622, 5215.6349055566125, 5593.244911936918, 6177.567570270083, 6382.87234255317, 6741.123653925008, 4399.9660079881205, 4404.757738324359, 4420.248557745191, 4438.733675979452, 4443.755593442327, 3951.92096158081, 4106.630403263721, 4473.217186992263, 4501.257292546693, 4538.387317712132, 4316.827326906951, 5017.598592112622, 5250.606204534599, 5274.419813820554, 5295.311609490818, 5658.801941932013, 6154.98442756949, 6469.126667899774, 6476.740930362827, 6554.557997240599, 1518.6051626577168, 1523.3449616664718, 1525.4965861265755, 1525.7024880148265, 1530.6453788397125, 931.3713243560569, 960.5917485068818, 963.494165563085, 1010.9494525273707, 1015.4212099103588, 6045.274567051982, 6049.578349087961, 6080.540670239111, 6099.634021958696, 6109.358517355702, 5144.948550514447, 6528.347165283433, 6563.671816409161, 6572.277573850706, 6584.6378449184795, 5118.564921981599, 5128.230765385148, 5728.398518155534, 6000.819975400745, 6044.123602077674, 3328.833558322074, 3419.0, 3419.794812311269, 3422.3155368926314, 3430.7134824440836, 6229.595076320024, 6457.903131453032, 6518.543701940914, 6736.46108311334, 6747.797566073025, 5222.451642577551, 5875.794347197828, 6836.487263455261, 6878.7248510060035, 6898.034275201476, 5627.6904770237215, 6751.56114852533, 6854.383105520527, 6861.622610756356, 6874.243833178346, 5525.696086715108, 6212.285587157535, 6331.556791024768, 6663.300353462817, 6671.099401580725, 5086.415062267886, 6189.597676151036, 6260.311365749672, 6556.246031706415, 6633.469322454289, 4943.060818444484, 5639.718014099197, 6285.088662144055, 6399.7440102395385, 6855.211650660238, 4004.599540045972, 4196.454460920061, 4340.459137006444, 4371.475422949266, 4405.449318835145, 6494.642794646151, 6574.572652777554, 6598.406143447113, 6608.372204640552, 6655.733770649314, 5747.683877386784, 5838.182654428469, 6343.397377249154, 6434.774782882577, 6442.194725659293, 4778.116048531033, 5278.656887302467, 6149.754009839735, 6400.615963042233, 6459.160309159967, 4720.622350212044, 5413.431589683027, 6259.436650701458, 6267.46726528232, 6279.0, 5631.802886898939, 6249.843753906189, 6326.873462530815, 6427.935720642734, 6430.549861509837, 5445.292112025411, 6219.533534984985, 6244.718987645658, 6268.52986026059, 6284.685765711604], "value": 4591.315391914305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.5951305321237, 841.3143288220105, 858.4463021351229, 865.4763867859945, 875.2560323724832, 14307.57077287683, 15025.32386042628, 15616.141112238822, 16686.0, 17123.82876171238, 17185.82814171858, 17809.73285400717, 17878.374256900977, 17942.551436214068, 18164.909175454137, 975.8682577851988, 1000.6997900629818, 1009.7172791618359, 1015.9390436573792, 1018.5416562546847, 1004.7237009822285, 1007.6775431861807, 1021.0249212002519, 1024.7182024943163, 1026.009900446073, 1065.984010239847, 1072.1155047086147, 1075.1184029096144, 1084.7993121272589, 1085.4138765066893, 1056.873175218971, 1061.9044286014218, 1064.2443864855961, 1072.3512275073624, 1073.8013467508536, 781.8514482248355, 786.2844811221761, 786.9016372953381, 791.9981223751959, 793.7261644732615, 14882.181480018595, 16966.830331696772, 17278.395256165975, 17513.562160945952, 17677.823221767747, 17148.657026859393, 17243.74134387985, 17342.826571734247, 17372.739408908878, 17780.91109544444, 13958.232297223649, 14009.13834860561, 14131.222782746945, 14255.429782808675, 14296.285185740671, 3363.596368435779, 3448.77582957107, 3454.447288433864, 3454.602720687128, 3459.584849818038, 118164.40917795357, 118950.0, 119088.21367679579, 119575.0, 120304.0, 12293.877061229452, 12344.81482777759, 12358.50565977351, 12376.690582735324, 12417.19288246261, 20789.584208316053, 20924.0, 20962.16151353959, 21099.0, 21125.471863203235, 7670.4247181461615, 7892.250236227549, 8356.874646880302, 8736.78158046054, 8826.205641492168, 4878.390201224847, 4923.75381230937, 4985.5762260208285, 4990.076835785391, 4998.000399920031, 3843.36584463566, 4339.913201735948, 4392.857856957214, 4442.622377097983, 4517.661175411858, 791.6318911706085, 827.4166712467696, 901.1484147480699, 954.8281309364381, 955.8566215067796, 660.2209392916309, 661.6460193796296, 667.5393978155057, 673.0711617967174, 677.8779819632514, 10703.946480267548, 10935.781284374269, 11965.162438629386, 11994.0, 12019.21875078117, 666.9266380698119, 675.4596322941627, 681.7477533312706, 683.4122654517112, 691.5815931361453, 5525.143602741581, 5657.0, 5706.17402431218, 5726.77092916287, 5828.125781132864, 100848.49575752074, 100975.49512252392, 101167.49416253019, 104700.95938966965, 105213.0, 85600.57199713962, 92938.07061929429, 93043.0, 95252.0, 95459.0, 66457.66771166114, 80183.0, 81627.18372816315, 82191.76712349319, 82377.76433353504, 8975.416597921114, 10103.696889093339, 11465.025472834903, 11476.254043487146, 11554.480048397674, 40463.393049104874, 40710.0, 40710.79644601758, 40831.0, 40970.38544421776, 53213.4678653224, 53362.73318633382, 53737.46262537324, 53963.730181348845, 54456.0, 11889.643310700692, 14062.78905816434, 14109.858901411266, 14120.011599188369, 14339.0, 15489.0, 15631.92184039118, 15890.364385424453, 15920.920395398412, 15964.441244556385, 14384.35270412813, 14492.275386230856, 14715.043522171025, 14799.630009249855, 14804.185769782334, 14674.41302347894, 14692.118472891661, 14694.338754755849, 14768.926155369154, 14847.851521484647, 14315.856841431869, 14333.56999290023, 14511.564653060424, 14619.853801462275, 14653.267336633338, 10795.6221532246, 10817.026467617952, 10943.343399396063, 11084.944575277072, 11162.832557511481, 11660.475278612314, 11747.706307342043, 11820.527178913091, 11894.405279736151, 11922.463489142836], "value": 8170.068731603455, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1649.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 123.0, 123.0, 123.0, 125.0, 126.0, 122.0, 123.0, 105.0], "value": 120.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 144.0, 197.0, 97.0, 95.0, 150.0, 155.0, 121.0, 142.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 279.0, 286.0, 264.0, 194.0, 271.0, 303.0, 231.0, 228.0, 302.0], "value": 256.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 89.0, 84.0, 71.0, 51.0, 68.0, 87.0, 102.0, 51.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 99.0, 126.0, 73.0, 74.0, 73.0, 87.0, 70.0, 72.0, 88.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 89.0, 141.0, 102.0, 87.0, 142.0, 143.0, 92.0, 90.0], "value": 107.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 100.0, 106.0, 101.0, 99.0, 136.0, 101.0, 101.0, 112.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 123.0, 103.0, 104.0, 101.0, 106.0, 123.0, 102.0, 104.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 54.0, 53.0, 55.0, 52.0, 55.0, 73.0, 45.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 65.0, 61.0, 67.0, 66.0, 60.0, 60.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 89.0, 86.0, 89.0, 90.0, 88.0, 89.0, 78.0, 88.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 151.0, 139.0, 152.0, 150.0, 136.0, 171.0, 173.0, 236.0, 169.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 196.0, 198.0, 200.0, 200.0, 194.0, 191.0, 196.0, 194.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 77.0, 70.0, 71.0, 63.0, 108.0, 101.0, 99.0, 101.0], "value": 83.6, "unit": "score"}]}]} 15:51:51 INFO - Return code: 0 15:51:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:51 ERROR - # TBPL SUCCESS # 15:51:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:51:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:51:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:51:51 INFO - 2017-04-08 15:51:51.380 screenresolution[1657:11154] starting screenresolution argv=screenresolution get 15:51:51 INFO - 2017-04-08 15:51:51.383 screenresolution[1657:11154] Display 0: 1600x1200x32@60 15:51:51 INFO - 2017-04-08 15:51:51.389 screenresolution[1658:11157] starting screenresolution argv=screenresolution list 15:51:51 INFO - Available Modes on Display 0 15:51:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:51:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:51:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:51:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:51:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:51:51 INFO - Intel Iris: 15:51:51 INFO - Chipset Model: Intel Iris 15:51:51 INFO - Type: GPU 15:51:51 INFO - Bus: Built-In 15:51:51 INFO - VRAM (Dynamic, Max): 1536 MB 15:51:51 INFO - Vendor: Intel (0x8086) 15:51:51 INFO - Device ID: 0x0a2e 15:51:51 INFO - Revision ID: 0x0009 15:51:51 INFO - Displays: 15:51:51 INFO - Display: 15:51:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:51:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:51:51 INFO - Display Serial Number: 1600x1200 60 15:51:51 INFO - Main Display: Yes 15:51:51 INFO - Mirror: Off 15:51:51 INFO - Online: Yes 15:51:51 INFO - Rotation: Supported 15:51:51 INFO - Return code: 0 15:51:51 INFO - Running post-action listener: _resource_record_post_action 15:51:51 INFO - [mozharness: 2017-04-08 22:51:51.632126Z] Finished run-tests step (success) 15:51:51 INFO - Running post-run listener: _resource_record_post_run 15:51:51 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 33939968; Write bytes: 524387328; Read time: 204; Write time: 1724 15:51:51 INFO - TinderboxPrint: CPU usage
54.0% 15:51:51 INFO - TinderboxPrint: I/O read bytes / time
33,939,968 / 204 15:51:51 INFO - TinderboxPrint: I/O write bytes / time
524,387,328 / 1,724 15:51:51 INFO - TinderboxPrint: CPU idle
2,205.8 (46.0%) 15:51:51 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 15:51:51 INFO - TinderboxPrint: CPU user
1,632.6 (34.0%) 15:51:51 INFO - TinderboxPrint: Swap in / out
237,608,960 / 0 15:51:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193108480; Write bytes: 193566720; Read time: 14872; Write time: 424 15:51:51 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 32977408; Write bytes: 313973760; Read time: 193; Write time: 1247 15:51:52 INFO - Running post-run listener: _upload_blobber_files 15:51:52 INFO - Blob upload gear active. 15:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:52 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 15:51:52 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'] 15:51:52 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 15:51:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:53 INFO - (blobuploader) - INFO - Done attempting. 15:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:54 INFO - (blobuploader) - INFO - Done attempting. 15:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:55 INFO - (blobuploader) - INFO - Done attempting. 15:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:57 INFO - (blobuploader) - INFO - Done attempting. 15:51:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:57 INFO - Return code: 0 15:51:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369f2829f0a048f8cd66bc7d96a2829dc1f96a1851db05ed3157ed383ef642efede519bdeeb428093dcfa360c7c10d131f33f417301e5a721cef7e314920e828", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35895691fc8fb6b431c5f2f6efd6132306ce8a19bf897e09c2c947852aa7a598ddcff9778d9cdf64ac996c771f94301908c468c5f586499818049c25d922472e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/577ae01c164fdfbdb387b3e8cccde612bfdd0b5c7721a1b5e51a8fce7f0ab9282d0e07909f7e515263619d98df860b692b4dea6f2587caa9c101ac2d76d21f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0c75b593387680660393818fe5b41661be78ec25780f8c38f681c853146e7f5bd0ec7f5ea3bac8b31ecc0edf85249647e74ceb0f6a141e1a0a534c5a75561"} 15:51:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:57 INFO - Contents: 15:51:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369f2829f0a048f8cd66bc7d96a2829dc1f96a1851db05ed3157ed383ef642efede519bdeeb428093dcfa360c7c10d131f33f417301e5a721cef7e314920e828", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35895691fc8fb6b431c5f2f6efd6132306ce8a19bf897e09c2c947852aa7a598ddcff9778d9cdf64ac996c771f94301908c468c5f586499818049c25d922472e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/577ae01c164fdfbdb387b3e8cccde612bfdd0b5c7721a1b5e51a8fce7f0ab9282d0e07909f7e515263619d98df860b692b4dea6f2587caa9c101ac2d76d21f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0c75b593387680660393818fe5b41661be78ec25780f8c38f681c853146e7f5bd0ec7f5ea3bac8b31ecc0edf85249647e74ceb0f6a141e1a0a534c5a75561"} 15:51:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:57 INFO - Copying logs to upload dir... 15:51:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.559168 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-08 15:51:57.842053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 15:51:57.846175) ========= 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.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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/369f2829f0a048f8cd66bc7d96a2829dc1f96a1851db05ed3157ed383ef642efede519bdeeb428093dcfa360c7c10d131f33f417301e5a721cef7e314920e828", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35895691fc8fb6b431c5f2f6efd6132306ce8a19bf897e09c2c947852aa7a598ddcff9778d9cdf64ac996c771f94301908c468c5f586499818049c25d922472e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/577ae01c164fdfbdb387b3e8cccde612bfdd0b5c7721a1b5e51a8fce7f0ab9282d0e07909f7e515263619d98df860b692b4dea6f2587caa9c101ac2d76d21f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0c75b593387680660393818fe5b41661be78ec25780f8c38f681c853146e7f5bd0ec7f5ea3bac8b31ecc0edf85249647e74ceb0f6a141e1a0a534c5a75561"} build_url:https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/N_EhvBdaRamM5hvKZe6haw/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/369f2829f0a048f8cd66bc7d96a2829dc1f96a1851db05ed3157ed383ef642efede519bdeeb428093dcfa360c7c10d131f33f417301e5a721cef7e314920e828", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35895691fc8fb6b431c5f2f6efd6132306ce8a19bf897e09c2c947852aa7a598ddcff9778d9cdf64ac996c771f94301908c468c5f586499818049c25d922472e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/577ae01c164fdfbdb387b3e8cccde612bfdd0b5c7721a1b5e51a8fce7f0ab9282d0e07909f7e515263619d98df860b692b4dea6f2587caa9c101ac2d76d21f31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e0c75b593387680660393818fe5b41661be78ec25780f8c38f681c853146e7f5bd0ec7f5ea3bac8b31ecc0edf85249647e74ceb0f6a141e1a0a534c5a75561"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 15:51:57.885752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:51:57.886105) ========= 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.yTDOxofe3L/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.YdUgqnNzla/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.005190 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:51:57.935732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 15:51:57.936058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 15:51:57.936424) ========= ========= Total master_lag: 0.19 =========