builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0096 starttime: 1492556277.77 results: success (0) buildid: 20170418142421 builduid: e7434123ac41488f9037f65a3a2aeb7f revision: 1a81aadc2510f227792cd4d789c8333329468351 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:57.770194) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:57.770639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:57.770914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:57.799109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:57.799499) ========= 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.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-18 15:57:57-- 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% 27.7M=0s 2017-04-18 15:57:58 (27.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.320065 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:58.145710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:58.146227) ========= 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.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.037562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:57:58.209431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 15:57:58.210029) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a81aadc2510f227792cd4d789c8333329468351 --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 1a81aadc2510f227792cd4d789c8333329468351 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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-18 15:57:58,333 truncating revision to first 12 chars 2017-04-18 15:57:58,333 Setting DEBUG logging. 2017-04-18 15:57:58,333 attempt 1/10 2017-04-18 15:57:58,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a81aadc2510?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 15:58:00,355 unpacking tar archive at: mozilla-central-1a81aadc2510/testing/mozharness/ program finished with exit code 0 elapsedTime=2.290023 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 15:58:00.526724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:00.527044) ========= script_repo_revision: 1a81aadc2510f227792cd4d789c8333329468351 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:00.527762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:00.528346) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:00.550482) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-18 15:58:00.551243) ========= /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.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:58:00 INFO - MultiFileLogger online at 20170418 15:58:00 in /builds/slave/test 15:58:00 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:58:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:00 INFO - {'append_to_log': False, 15:58:00 INFO - 'base_work_dir': '/builds/slave/test', 15:58:00 INFO - 'blob_upload_branch': 'Firefox', 15:58:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:00 INFO - 'branch': 'Firefox', 15:58:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:00 INFO - 'config_files': ('talos/mac_config.py',), 15:58:00 INFO - 'default_actions': ('clobber', 15:58:00 INFO - 'read-buildbot-config', 15:58:00 INFO - 'download-and-extract', 15:58:00 INFO - 'populate-webroot', 15:58:00 INFO - 'create-virtualenv', 15:58:00 INFO - 'install', 15:58:00 INFO - 'run-tests'), 15:58:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:00 INFO - 'download_minidump_stackwalk': True, 15:58:00 INFO - 'download_symbols': 'ondemand', 15:58:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:00 INFO - 'gecko_profile': False, 15:58:00 INFO - 'gecko_profile_interval': 0, 15:58:00 INFO - 'installer_path': 'installer.exe', 15:58:00 INFO - 'log_level': 'info', 15:58:00 INFO - 'log_name': 'talos', 15:58:00 INFO - 'log_to_console': True, 15:58:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:58:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:58:00 INFO - 'opt_config_files': (), 15:58:00 INFO - 'pip_index': False, 15:58:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:00 INFO - 'cmd': ('bash', 15:58:00 INFO - '-c', 15:58:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:00 INFO - 'enabled': True, 15:58:00 INFO - 'halt_on_failure': False, 15:58:00 INFO - 'name': 'check_screen_resolution'},), 15:58:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:00 INFO - 'cmd': ('bash', 15:58:00 INFO - '-c', 15:58:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:00 INFO - 'enabled': True, 15:58:00 INFO - 'halt_on_failure': False, 15:58:00 INFO - 'name': 'check_screen_resolution'},), 15:58:00 INFO - 'run_cmd_checks_enabled': True, 15:58:00 INFO - 'suite': 'dromaeojs-e10s', 15:58:00 INFO - 'system_bits': '32', 15:58:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:00 INFO - 'title': 't-yosemite-r7-0096', 15:58:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:00 INFO - 'use_talos_json': True, 15:58:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:00 INFO - 'work_dir': 'build'} 15:58:00 INFO - [mozharness: 2017-04-18 22:58:00.784162Z] Running clobber step. 15:58:00 INFO - Running pre-action listener: _resource_record_pre_action 15:58:00 INFO - Running main action method: clobber 15:58:00 INFO - rmtree: /builds/slave/test/build 15:58:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:03 INFO - Running post-action listener: _resource_record_post_action 15:58:03 INFO - [mozharness: 2017-04-18 22:58:03.291024Z] Finished clobber step (success) 15:58:03 INFO - [mozharness: 2017-04-18 22:58:03.291172Z] Running read-buildbot-config step. 15:58:03 INFO - Running pre-action listener: _resource_record_pre_action 15:58:03 INFO - Running main action method: read_buildbot_config 15:58:03 INFO - Using buildbot properties: 15:58:03 INFO - { 15:58:03 INFO - "project": "", 15:58:03 INFO - "product": "firefox", 15:58:03 INFO - "script_repo_revision": "production", 15:58:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:58:03 INFO - "repository": "", 15:58:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:58:03 INFO - "buildid": "20170418142421", 15:58:03 INFO - "pgo_build": "False", 15:58:03 INFO - "basedir": "/builds/slave/test", 15:58:03 INFO - "buildnumber": 124, 15:58:03 INFO - "slavename": "t-yosemite-r7-0096", 15:58:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:58:03 INFO - "platform": "yosemite_r7", 15:58:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:58:03 INFO - "branch": "mozilla-central", 15:58:03 INFO - "repo_path": "mozilla-central", 15:58:03 INFO - "revision": "1a81aadc2510f227792cd4d789c8333329468351", 15:58:03 INFO - "stage_platform": "macosx64", 15:58:03 INFO - "builduid": "e7434123ac41488f9037f65a3a2aeb7f", 15:58:03 INFO - "slavebuilddir": "test" 15:58:03 INFO - } 15:58:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:58:03 INFO - Running post-action listener: _resource_record_post_action 15:58:03 INFO - [mozharness: 2017-04-18 22:58:03.294325Z] Finished read-buildbot-config step (success) 15:58:03 INFO - [mozharness: 2017-04-18 22:58:03.294436Z] Running download-and-extract step. 15:58:03 INFO - Running pre-action listener: _resource_record_pre_action 15:58:03 INFO - Running main action method: download_and_extract 15:58:03 INFO - mkdir: /builds/slave/test/build/tests 15:58:03 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:58:03 INFO - trying https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:58:03 INFO - Downloading https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/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:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/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:58:04 INFO - Downloaded 1325 bytes. 15:58:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:58:04 INFO - Using the following test package requirements: 15:58:04 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:58:04 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:58:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:58:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:58:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'jsshell-mac.zip'], 15:58:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:58:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:58:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:58:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:58:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:58:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:58:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:58:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:58:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:04 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:58:06 INFO - Expected file size: 52632879 15:58:06 INFO - Obtained file size: 52632879 15:58:23 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:58:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:58:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:23 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:58:24 INFO - Expected file size: 52632879 15:58:24 INFO - Obtained file size: 52632879 15:58:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:58:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:58:40 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:58:41 INFO - Expected file size: 14408802 15:58:41 INFO - Obtained file size: 14408802 15:58: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:58:41 INFO - trying https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:58:41 INFO - Downloading https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/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:58:44 INFO - Downloaded 71428224 bytes. 15:58:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:58:44 INFO - mkdir: /builds/slave/test/properties 15:58:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:44 INFO - Contents: 15:58:44 INFO - build_url:https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:58:44 INFO - Running post-action listener: _resource_record_post_action 15:58:44 INFO - Running post-action listener: set_extra_try_arguments 15:58:44 INFO - [mozharness: 2017-04-18 22:58:44.691468Z] Finished download-and-extract step (success) 15:58:44 INFO - [mozharness: 2017-04-18 22:58:44.691604Z] Running populate-webroot step. 15:58:44 INFO - Running pre-action listener: _resource_record_pre_action 15:58:44 INFO - Running main action method: populate_webroot 15:58:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:44 INFO - '--tppagecycles', 15:58:44 INFO - '7'], 15:58:44 INFO - 'tests': ['tsvgm']}}, 15:58:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['damp', 'tps']}, 15:58:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'tests': ['damp', 'tps']}, 15:58:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['dromaeo_dom']}, 15:58:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:58:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:58:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['a11yr', 15:58:44 INFO - 'ts_paint', 15:58:44 INFO - 'tpaint', 15:58:44 INFO - 'sessionrestore', 15:58:44 INFO - 'sessionrestore_no_auto_restore', 15:58:44 INFO - 'tabpaint']}, 15:58:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:58:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:58:44 INFO - 'bloom_basic_ref']}, 15:58:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['tsvgx', 15:58:44 INFO - 'tsvgr_opacity', 15:58:44 INFO - 'tart', 15:58:44 INFO - 'tscrollx', 15:58:44 INFO - 'cart', 15:58:44 INFO - 'tsvg_static']}, 15:58:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:44 INFO - 'tsvgr_opacity', 15:58:44 INFO - 'tart', 15:58:44 INFO - 'tscrollx', 15:58:44 INFO - 'cart', 15:58:44 INFO - 'tsvg_static']}, 15:58:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'talos_options': ['--disable-e10s'], 15:58:44 INFO - 'tests': ['tp5o']}, 15:58:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:58:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'talos_options': ['--disable-e10s', 15:58:44 INFO - '--xperf_path', 15:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:44 INFO - 'tests': ['tp5n']}, 15:58:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:58:44 INFO - 'talos_options': ['--xperf_path', 15:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:44 INFO - 'tests': ['tp5n']}}, 15:58:44 INFO - 'talos.zip': {'path': '', 15:58:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:44 INFO - Running post-action listener: _resource_record_post_action 15:58:44 INFO - [mozharness: 2017-04-18 22:58:44.710953Z] Finished populate-webroot step (success) 15:58:44 INFO - [mozharness: 2017-04-18 22:58:44.711088Z] Running create-virtualenv step. 15:58:44 INFO - Running pre-action listener: _resource_record_pre_action 15:58:44 INFO - Running main action method: create_virtualenv 15:58:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:44 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:58:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:44 INFO - Using real prefix '/tools/python27' 15:58:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:48 INFO - Installing pip.................done. 15:58:48 INFO - Return code: 0 15:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:48 INFO - Reading from file tmpfile_stdout 15:58:48 INFO - Output received: 15:58:48 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:58:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:48 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:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:48 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:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:48 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:58:48 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:58:48 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:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:48 INFO - 'HOME': '/Users/cltbld', 15:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:48 INFO - 'LOGNAME': 'cltbld', 15:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:48 INFO - 'MOZ_NO_REMOTE': '1', 15:58:48 INFO - 'NO_EM_RESTART': '1', 15:58:48 INFO - 'PAGER': '/bin/cat', 15:58:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:48 INFO - 'PWD': '/builds/slave/test', 15:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:48 INFO - 'SHELL': '/bin/bash', 15:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:58:48 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:48 INFO - 'USER': 'cltbld', 15:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:48 INFO - 'XPC_FLAGS': '0x0', 15:58:48 INFO - 'XPC_SERVICE_NAME': '0', 15:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:49 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:58:49 INFO - Cleaning up... 15:58:49 INFO - Return code: 0 15:58:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:58:49 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:58:49 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:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:49 INFO - 'HOME': '/Users/cltbld', 15:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:49 INFO - 'LOGNAME': 'cltbld', 15:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:49 INFO - 'MOZ_NO_REMOTE': '1', 15:58:49 INFO - 'NO_EM_RESTART': '1', 15:58:49 INFO - 'PAGER': '/bin/cat', 15:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:49 INFO - 'PWD': '/builds/slave/test', 15:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:49 INFO - 'SHELL': '/bin/bash', 15:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:58:49 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:49 INFO - 'USER': 'cltbld', 15:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:49 INFO - 'XPC_FLAGS': '0x0', 15:58:49 INFO - 'XPC_SERVICE_NAME': '0', 15:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:49 INFO - Downloading/unpacking psutil>=3.1.1 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:53 INFO - Installing collected packages: psutil 15:58:53 INFO - Running setup.py install for psutil 15:58:53 INFO - building 'psutil._psutil_osx' extension 15:58:53 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:58:53 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:58:53 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:58:53 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:58:53 INFO - building 'psutil._psutil_posix' extension 15:58:53 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:58:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:58:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:58:54 INFO - ^ 15:58:54 INFO - 1 warning generated. 15:58:54 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:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:54 INFO - Successfully installed psutil 15:58:54 INFO - Cleaning up... 15:58:54 INFO - Return code: 0 15:58:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:55 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:58:55 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:58:55 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:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:55 INFO - 'HOME': '/Users/cltbld', 15:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:55 INFO - 'LOGNAME': 'cltbld', 15:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:55 INFO - 'MOZ_NO_REMOTE': '1', 15:58:55 INFO - 'NO_EM_RESTART': '1', 15:58:55 INFO - 'PAGER': '/bin/cat', 15:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:55 INFO - 'PWD': '/builds/slave/test', 15:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:55 INFO - 'SHELL': '/bin/bash', 15:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:58:55 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:55 INFO - 'USER': 'cltbld', 15:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:55 INFO - 'XPC_FLAGS': '0x0', 15:58:55 INFO - 'XPC_SERVICE_NAME': '0', 15:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:55 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:58:55 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:58:55 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:58:55 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:58:55 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:58:55 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:58:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:58 INFO - Installing collected packages: mozsystemmonitor 15:58:58 INFO - Running setup.py install for mozsystemmonitor 15:58:58 INFO - Successfully installed mozsystemmonitor 15:58:58 INFO - Cleaning up... 15:58:58 INFO - Return code: 0 15:58:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58:58 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:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:58 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:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:58 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:58:58 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:58:58 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:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:58 INFO - 'HOME': '/Users/cltbld', 15:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:58 INFO - 'LOGNAME': 'cltbld', 15:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:58 INFO - 'MOZ_NO_REMOTE': '1', 15:58:58 INFO - 'NO_EM_RESTART': '1', 15:58:58 INFO - 'PAGER': '/bin/cat', 15:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:58 INFO - 'PWD': '/builds/slave/test', 15:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:58 INFO - 'SHELL': '/bin/bash', 15:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:58:58 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:58 INFO - 'USER': 'cltbld', 15:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:58 INFO - 'XPC_FLAGS': '0x0', 15:58:58 INFO - 'XPC_SERVICE_NAME': '0', 15:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:58 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:58 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:58:58 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:58:58 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:58:58 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:58:58 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:58:58 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:59:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:01 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:01 INFO - warning: no files found matching '*.txt' 15:59:01 INFO - no previously-included directories found matching 'build' 15:59:01 INFO - no previously-included directories found matching 'dist' 15:59:01 INFO - no previously-included directories found matching '.git*' 15:59:01 INFO - Installing collected packages: jsonschema, functools32 15:59:01 INFO - Running setup.py install for functools32 15:59:02 INFO - warning: no files found matching '*.txt' 15:59:02 INFO - no previously-included directories found matching 'build' 15:59:02 INFO - no previously-included directories found matching 'dist' 15:59:02 INFO - no previously-included directories found matching '.git*' 15:59:02 INFO - Successfully installed jsonschema functools32 15:59:02 INFO - Cleaning up... 15:59:02 INFO - Return code: 0 15:59:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:59:02 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:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:02 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:59:02 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:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:02 INFO - 'HOME': '/Users/cltbld', 15:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:02 INFO - 'LOGNAME': 'cltbld', 15:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:02 INFO - 'MOZ_NO_REMOTE': '1', 15:59:02 INFO - 'NO_EM_RESTART': '1', 15:59:02 INFO - 'PAGER': '/bin/cat', 15:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:02 INFO - 'PWD': '/builds/slave/test', 15:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:02 INFO - 'SHELL': '/bin/bash', 15:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:02 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:02 INFO - 'USER': 'cltbld', 15:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:02 INFO - 'XPC_FLAGS': '0x0', 15:59:02 INFO - 'XPC_SERVICE_NAME': '0', 15:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:59:02 INFO - Cleaning up... 15:59:02 INFO - Return code: 0 15:59:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:02 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:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:02 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:02 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:59:02 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:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:02 INFO - 'HOME': '/Users/cltbld', 15:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:02 INFO - 'LOGNAME': 'cltbld', 15:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:02 INFO - 'MOZ_NO_REMOTE': '1', 15:59:02 INFO - 'NO_EM_RESTART': '1', 15:59:02 INFO - 'PAGER': '/bin/cat', 15:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:02 INFO - 'PWD': '/builds/slave/test', 15:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:02 INFO - 'SHELL': '/bin/bash', 15:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:02 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:02 INFO - 'USER': 'cltbld', 15:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:02 INFO - 'XPC_FLAGS': '0x0', 15:59:02 INFO - 'XPC_SERVICE_NAME': '0', 15:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:02 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:02 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:59:02 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:59:02 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:59:02 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:59:02 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:59:02 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:59:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:06 INFO - Downloading docopt-0.6.1.tar.gz 15:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:06 INFO - Running setup.py install for blobuploader 15:59:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:06 INFO - Running setup.py install for requests 15:59:07 INFO - Running setup.py install for docopt 15:59:07 INFO - Successfully installed blobuploader requests docopt 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:07 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:59:07 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:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:07 INFO - 'HOME': '/Users/cltbld', 15:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PAGER': '/bin/cat', 15:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test', 15:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:07 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - 'XPC_FLAGS': '0x0', 15:59:07 INFO - 'XPC_SERVICE_NAME': '0', 15:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:07 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-k_U2Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:07 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-tEtiLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-o80xWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-SQB2Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-wwPjO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-_CjG4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-0NxDwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-Kk9EEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-QTxO09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-VDfOd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-pqk3wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-0wPzdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-gZqHeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-GXrFnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-9Bw2Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-MT9UX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:09 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-XF9i6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:09 INFO - Running setup.py install for manifestparser 15:59:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:09 INFO - Running setup.py install for mozcrash 15:59:09 INFO - Running setup.py install for mozdebug 15:59:10 INFO - Running setup.py install for mozdevice 15:59:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Running setup.py install for mozfile 15:59:10 INFO - Running setup.py install for mozhttpd 15:59:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Running setup.py install for mozinfo 15:59:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Running setup.py install for mozInstall 15:59:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:10 INFO - Running setup.py install for mozleak 15:59:10 INFO - Running setup.py install for mozlog 15:59:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Running setup.py install for moznetwork 15:59:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Running setup.py install for mozprocess 15:59:11 INFO - Running setup.py install for mozprofile 15:59:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Running setup.py install for mozrunner 15:59:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:11 INFO - Running setup.py install for mozscreenshot 15:59:11 INFO - Running setup.py install for moztest 15:59:12 INFO - Running setup.py install for mozversion 15:59:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:12 INFO - Cleaning up... 15:59:12 INFO - Return code: 0 15:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:12 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:12 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:59:12 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:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:12 INFO - 'HOME': '/Users/cltbld', 15:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:12 INFO - 'LOGNAME': 'cltbld', 15:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:12 INFO - 'MOZ_NO_REMOTE': '1', 15:59:12 INFO - 'NO_EM_RESTART': '1', 15:59:12 INFO - 'PAGER': '/bin/cat', 15:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:12 INFO - 'PWD': '/builds/slave/test', 15:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:12 INFO - 'SHELL': '/bin/bash', 15:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:12 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:12 INFO - 'USER': 'cltbld', 15:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:12 INFO - 'XPC_FLAGS': '0x0', 15:59:12 INFO - 'XPC_SERVICE_NAME': '0', 15:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-lxoQ0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:12 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:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-1w9j2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:12 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:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-qLmUIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:12 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:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-giMw65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:12 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:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-2x0X_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:12 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:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:12 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-pmnqHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-a8_kJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-la0z_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-AyI9Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-V_CJhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-fVlcvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-MscekJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-pgz3WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-SgOmvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:13 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:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:13 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-kpxONS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:14 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:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-eZSCaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:14 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:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:14 INFO - Running setup.py (path:/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/pip-CQT6cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:16 INFO - Downloading blessings-1.6.tar.gz 15:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:16 INFO - Installing collected packages: blessings 15:59:16 INFO - Running setup.py install for blessings 15:59:17 INFO - Successfully installed blessings 15:59:17 INFO - Cleaning up... 15:59:17 INFO - Return code: 0 15:59:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:17 INFO - Reading from file tmpfile_stdout 15:59:17 INFO - Current package versions: 15:59:17 INFO - blessings == 1.6 15:59:17 INFO - blobuploader == 1.2.4 15:59:17 INFO - docopt == 0.6.1 15:59:17 INFO - functools32 == 3.2.3-2 15:59:17 INFO - jsonschema == 2.5.1 15:59:17 INFO - manifestparser == 1.1 15:59:17 INFO - mozInstall == 1.12 15:59:17 INFO - mozcrash == 1.0 15:59:17 INFO - mozdebug == 0.1 15:59:17 INFO - mozdevice == 0.50 15:59:17 INFO - mozfile == 1.2 15:59:17 INFO - mozhttpd == 0.7 15:59:17 INFO - mozinfo == 0.9 15:59:17 INFO - mozleak == 0.1 15:59:17 INFO - mozlog == 3.4 15:59:17 INFO - moznetwork == 0.27 15:59:17 INFO - mozprocess == 0.25 15:59:17 INFO - mozprofile == 0.28 15:59:17 INFO - mozrunner == 6.13 15:59:17 INFO - mozscreenshot == 0.1 15:59:17 INFO - mozsystemmonitor == 0.3 15:59:17 INFO - moztest == 0.8 15:59:17 INFO - mozversion == 1.4 15:59:17 INFO - psutil == 3.1.1 15:59:17 INFO - requests == 1.2.3 15:59:17 INFO - wsgiref == 0.1.2 15:59:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:17 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:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:17 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:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:17 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:17 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:59:17 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:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:17 INFO - 'HOME': '/Users/cltbld', 15:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:17 INFO - 'LOGNAME': 'cltbld', 15:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:17 INFO - 'MOZ_NO_REMOTE': '1', 15:59:17 INFO - 'NO_EM_RESTART': '1', 15:59:17 INFO - 'PAGER': '/bin/cat', 15:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:17 INFO - 'PWD': '/builds/slave/test', 15:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:17 INFO - 'SHELL': '/bin/bash', 15:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:17 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:17 INFO - 'USER': 'cltbld', 15:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:17 INFO - 'XPC_FLAGS': '0x0', 15:59:17 INFO - 'XPC_SERVICE_NAME': '0', 15:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 INFO - Cleaning up... 15:59:17 INFO - Return code: 0 15:59:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:17 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:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:17 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:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:17 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 0x105f7cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f7f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba42490510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, '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.xkal9xescL/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.U9I3NY2n92/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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:59:17 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:59:17 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:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:17 INFO - 'HOME': '/Users/cltbld', 15:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:17 INFO - 'LOGNAME': 'cltbld', 15:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:17 INFO - 'MOZ_NO_REMOTE': '1', 15:59:17 INFO - 'NO_EM_RESTART': '1', 15:59:17 INFO - 'PAGER': '/bin/cat', 15:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:17 INFO - 'PWD': '/builds/slave/test', 15:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:17 INFO - 'SHELL': '/bin/bash', 15:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:17 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:17 INFO - 'USER': 'cltbld', 15:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:17 INFO - 'XPC_FLAGS': '0x0', 15:59:17 INFO - 'XPC_SERVICE_NAME': '0', 15:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:18 INFO - Cleaning up... 15:59:18 INFO - Return code: 0 15:59:18 INFO - Running post-action listener: _resource_record_post_action 15:59:18 INFO - Running post-action listener: _start_resource_monitoring 15:59:18 INFO - Starting resource monitoring. 15:59:18 INFO - [mozharness: 2017-04-18 22:59:18.114450Z] Finished create-virtualenv step (success) 15:59:18 INFO - [mozharness: 2017-04-18 22:59:18.115571Z] Running install step. 15:59:18 INFO - Running pre-action listener: _resource_record_pre_action 15:59:18 INFO - Running main action method: install 15:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:18 INFO - Reading from file tmpfile_stdout 15:59:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:18 INFO - Reading from file tmpfile_stdout 15:59:18 INFO - Output received: 15:59:18 INFO - Usage: mozinstall [options] installer 15:59:18 INFO - Options: 15:59:18 INFO - -h, --help show this help message and exit 15:59:18 INFO - -d DEST, --destination=DEST 15:59:18 INFO - Directory to install application into. [default: 15:59:18 INFO - "/builds/slave/test"] 15:59:18 INFO - --app=APP Application being installed. [default: firefox] 15:59:18 INFO - mkdir: /builds/slave/test/build/application 15:59:18 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:59:18 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:59:38 INFO - Reading from file tmpfile_stdout 15:59:38 INFO - Output received: 15:59:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:59:38 INFO - Running post-action listener: _resource_record_post_action 15:59:38 INFO - [mozharness: 2017-04-18 22:59:38.286287Z] Finished install step (success) 15:59:38 INFO - [mozharness: 2017-04-18 22:59:38.286463Z] Running run-tests step. 15:59:38 INFO - Running pre-action listener: _resource_record_pre_action 15:59:38 INFO - Running main action method: run_tests 15:59:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:59:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:59:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:59:38 INFO - 2017-04-18 15:59:38.301 screenresolution[1626:7326] starting screenresolution argv=screenresolution get 15:59:38 INFO - 2017-04-18 15:59:38.304 screenresolution[1626:7326] Display 0: 1600x1200x32@60 15:59:38 INFO - 2017-04-18 15:59:38.309 screenresolution[1627:7329] starting screenresolution argv=screenresolution list 15:59:38 INFO - Available Modes on Display 0 15:59:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:59:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:59:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:59:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:59:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:59:38 INFO - Intel Iris: 15:59:38 INFO - Chipset Model: Intel Iris 15:59:38 INFO - Type: GPU 15:59:38 INFO - Bus: Built-In 15:59:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:59:38 INFO - Vendor: Intel (0x8086) 15:59:38 INFO - Device ID: 0x0a2e 15:59:38 INFO - Revision ID: 0x0009 15:59:38 INFO - Displays: 15:59:38 INFO - Display: 15:59:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:59:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:59:38 INFO - Display Serial Number: 1600x1200 60 15:59:38 INFO - Main Display: Yes 15:59:38 INFO - Mirror: Off 15:59:38 INFO - Online: Yes 15:59:38 INFO - Rotation: Supported 15:59:38 INFO - Return code: 0 15:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:38 INFO - Python 2.7.3 15:59:38 INFO - Return code: 0 15:59:38 INFO - grabbing minidump binary from tooltool 15:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:38 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 0x105d5ad30>, '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 0x105c80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d4fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:38 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:59:38 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:59:38 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:59:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:38 INFO - Return code: 0 15:59:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:59:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:38 INFO - ENV: RUST_BACKTRACE is now 1 15:59:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:59:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:38 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/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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:59:38 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/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0096 --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:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xkal9xescL/Render', 15:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:38 INFO - 'HOME': '/Users/cltbld', 15:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:38 INFO - 'LOGNAME': 'cltbld', 15:59:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:38 INFO - 'MOZ_NO_REMOTE': '1', 15:59:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:38 INFO - 'NO_EM_RESTART': '1', 15:59:38 INFO - 'PAGER': '/bin/cat', 15:59:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:38 INFO - 'PWD': '/builds/slave/test', 15:59:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:38 INFO - 'RUST_BACKTRACE': '1', 15:59:38 INFO - 'SHELL': '/bin/bash', 15:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U9I3NY2n92/Listeners', 15:59:38 INFO - 'TMPDIR': '/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/', 15:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:38 INFO - 'USER': 'cltbld', 15:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:38 INFO - 'XPC_FLAGS': '0x0', 15:59:38 INFO - 'XPC_SERVICE_NAME': '0', 15:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:38 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/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0096', '--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:59:38 INFO - mozversion application_buildid: 20170418142421 15:59:38 INFO - mozversion application_changeset: 1a81aadc2510f227792cd4d789c8333329468351 15:59:38 INFO - mozversion application_display_name: Nightly 15:59:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:38 INFO - mozversion application_name: Firefox 15:59:38 INFO - mozversion application_remotingname: firefox 15:59:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:59:38 INFO - mozversion application_vendor: Mozilla 15:59:38 INFO - mozversion application_version: 55.0a1 15:59:38 INFO - mozversion platform_buildid: 20170418142421 15:59:38 INFO - mozversion platform_changeset: 1a81aadc2510f227792cd4d789c8333329468351 15:59:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:59:38 INFO - mozversion platform_version: 55.0a1 15:59:38 INFO - using testdate: 1492556378 15:59:38 INFO - actual date: 1492556378 15:59:38 INFO - starting webserver on 'localhost:49240' 15:59:38 INFO - SUITE-START | Running 2 tests 15:59:38 INFO - TEST-START | dromaeo_css 15:59:38 INFO - operating with platform_type : mac_ 15:59:38 INFO - Initialising browser for dromaeo_css test... 15:59:38 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp9qFPsQ/profile http://localhost:49240/getInfo.html) 15:59:41 INFO - PID 1637 | 2017-04-18 15:59:41.704 plugin-container[1639:7510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 15:59:41 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:59:41 INFO - PID 1637 | 2017-04-18 15:59:41.709 plugin-container[1639:7510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 15:59:41 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:59:41 INFO - PID 1637 | 2017-04-18 15:59:41.709 plugin-container[1639:7510] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:59:41 INFO - PID 1637 | __metrics Screen width/height:1600/1200 15:59:41 INFO - PID 1637 | colorDepth:24 15:59:41 INFO - PID 1637 | Browser inner width/height: 1024/689 15:59:41 INFO - PID 1637 | __metrics 15:59:41 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 15:59:42 INFO - TEST-INFO | 1637: exit 0 15:59:42 INFO - Browser initialized. 15:59:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:42 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmp9qFPsQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:45 INFO - PID 1640 | 2017-04-18 15:59:45.424 plugin-container[1641:7654] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882b, name = 'com.apple.tsm.portname' 15:59:45 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:59:45 INFO - PID 1640 | 2017-04-18 15:59:45.424 plugin-container[1641:7654] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 15:59:45 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:59:45 INFO - PID 1640 | 2017-04-18 15:59:45.424 plugin-container[1641:7654] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:59:55 INFO - PID 1640 | RSS: Main: 235790336 15:59:55 INFO - PID 1640 | 16:02:59 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 16:03:01 INFO - PID 1640 | RSS: Main: 251314176 16:03:01 INFO - PID 1640 | 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:04:43 INFO - PID 1640 | 16:04:43 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:04:43 INFO - PID 1640 | Full stack: 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:04:43 INFO - PID 1640 | 16:04:43 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:04:43 INFO - PID 1640 | Full stack: 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:04:43 INFO - PID 1640 | 16:04:43 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:04:43 INFO - PID 1640 | Full stack: 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | ************************* 16:04:43 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 16:04:43 INFO - PID 1640 | 16:04:43 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:04:43 INFO - PID 1640 | Full stack: 16:04:43 INFO - PID 1640 | ************************* 16:06:03 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 16:06:03 INFO - PID 1640 | RSS: Main: 256733184 16:06:03 INFO - PID 1640 | 16:09:05 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 16:09:06 INFO - PID 1640 | RSS: Main: 266108928 16:09:06 INFO - PID 1640 | 16:12:07 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 16:12:08 INFO - PID 1640 | RSS: Main: 259215360 16:12:08 INFO - PID 1640 | 16:15:11 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 16:15:11 INFO - PID 1640 | RSS: Main: 268480512 16:15:11 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 16:18:13 INFO - PID 1640 | RSS: Main: 263467008 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | __start_tp_report 16:18:13 INFO - PID 1640 | _x_x_mozilla_page_load 16:18:13 INFO - PID 1640 | _x_x_mozilla_page_load_details 16:18:13 INFO - PID 1640 | |i|pagename|runs| 16:18:13 INFO - PID 1640 | |0;dojo.html;3630.16506203573;3640.2173532690467;3693.741438099334;3693.9445908311372;3696.0390298522393;5025.874353141164;5856.121581762733;6146.924288249561;6316.5262605304615;6405.19935008124;5165.845024649267;6207.596506227103;6231.626102433857;6348.650824204667;6381.712822922968;5528.143137813645;5545.279113715222;5569.832905012856;5589.189567512708;5676.801311954083;5445.292112025431;5577.330720313568;5659.292588426447;5698.857528561798;5720;5382.354117505885;5462.481064298885;5493.560515158818;5509.696966666832;5586.6368686035485;5444.754986025599;5470.398256191816;5491.450854914517;5565.0817615093465;5613.943860561383;5438.184272359138;5470.890582188374;5478.260434841325;5513.917291240635;5552.139418390156;5361.383440904307;5660.235868157787;6268.529860260499;6304.306526282106;6398.616083035033;5652.434756524356;6522.706478208492;6622.86754264912;6701.631410272433;6807.625580593065;6821.147356580427;6869.072675188835;6897.862042759117;6908.101946746941;6926.688299026506;6353.5870168438905;6382.297947225801;6407.962983320478;6429.421352078241;6430.742770289229;6706.295838936939;6851.383375496229;6866.519343645897;7018.649067546602;7050.506464547535;5361.973190134025;6318.210223722035;6442.645654488954;6518.380753828379;6629.972354285093;6419.261784894797;6836.623985680835;6853.554518956252;6864.38220560152;6895.689693963784;5689.691370984614;6636.800895973129;6772.2211945625895;6785.9321406786285;6800.217974932946;6408.775692850728;6642.402183803384;6654.633995130217;6808.523403361717;6813.557118787263;4585.426821647294;5395.217693434509;5443.673379597237;5459.235707001023;5466.125419932871;4810.182269014206;4820.903581928342;4824.903501929942;4830.637702172281;4846.854594362175;6282.874342513124;6371.39471750183;6448.709808058648;6478.578892371981;6496.058071579594;6671.933280667228;6763.966180169067;6793.320667933266;6796.796096117125;6882.449404047664;6436.613803171825;6464.159659244362;6475.902861457082;6476.838079047967;6480.51396145291;5985.042393217064;6019.277686677539;6047.879042419127;6068.059450785136;6072.544559158081;6757.290484499057;6837.145356830396;6924.238333783381;6986.54587451814;7028.508004439743;6871.347222013901;6879.346462086094;6879.7248110077035;6898.1377327834025;6922.342377474132;6964.164300283998;6971.44228461732;7000.50996430245;7023.22744498115;7024.824379390556;6511.21865376139;6635.668216589248;6701.430378417889;6760.425363844129;6796.35434633709;6864.313568643096;6875.346842049998;6884.896726549206;6892.207396149507;6907.758228461979;6354.555181137276;6626.4367528760595;6652.800415987528;6679.799606011828;6700.329967003261;6461.935380646133;6585.308542603149;6665.0335701322065;6681.33186681328;6692.732290708512;5299.258103865385;6267.749290028348;6559.278479367361;6574.572652777554;6581.07864898905;6688.598684078971;6704.966475167788;6711.3288671132495;6730.899036514358;6744.763933262312;6207.534434917489;6364.395382438661;6376.298607153302;6435.163428754232;6465.90079686445 16:18:13 INFO - PID 1640 | |1;ext.html;701.7613911446294;766.5937053361719;793.6269953122035;1256.5413624027233;1264.8166015927698;36342.273154536895;37090.07274818131;37187.62812371879;37235.25529489412;37266.627333726654;37021.44467832985;37302.253954920954;37307.81346093266;37387.81306093473;37412.251754964884;8060.153683863183;8230.09468958414;8625.784355391103;8894.066123057082;8912.108789121101;8748.081451447602;8901.554922253894;8902.955485222565;8905.821883562325;8910.554472276393;7920.405969552277;8457.788555286137;8848.823023539526;8888.288936885034;8920.643174273022;7515.774526764206;8825;8880.378373513857;8895.510746908918;8921.732348029602;8506.106858779802;8554.101819308946;8603.053664096944;8606.784830379229;8625.482471051757;38140.42789358162;38148.80925595354;38257.426138607945;38279.85160445191;38344.61655383466;3364.310316385135;3388.983305008512;3423.4864770284657;3436.7937923724658;3667.853285868562;24649.137280195107;31488;31578.210544736336;31738.841305793554;31739.841300793578;2616.751408616178;3146.197719581492;3191.4574522331027;3195.249116457654;3196.840157992114;242633;245322;250899;280574;306258;48678.26982595264;48703.512964870606;49047.754761225966;49064.50935490671;49222;51729.48270517322;51907.48092519026;51998.740006299726;52024.73987630037;52031.57731592781;11371.431428428545;11499.597514087134;14370.856291437161;14381.209033503048;14391.78412323816;9716.951415242878;11602.70993225176;11657.533698652129;11772.88227117735;11775;13764.449422023006;13778.517751878637;13801.51694690681;13829.10110842792;13959.162450253018;5967.329147838612;5990.191324171268;6009.278886533644;6018.398160183947;6037;1020.7193021919031;1045.9320144190604;1053.7102296868422;1068.4817863336275;1079.6760971708457;23242.65136022961;24391.024359025796;24467.265982020566;24529.386765331008;24598.508029839304;1118.496676495564;1122.4163435013747;1159.7738441003924;1162.6744511536783;1171.308927732642;12575.371231438392;12608.243505389706;12642.683932901751;12699.619011429671;12711.68220794469;327711;328344;328410;329013.8084810669;331689;55455.72272138613;55584.44415555873;55759.72120139373;55795;55843;1339.9933000334936;1472.7938088667595;1496.3939604459993;1536.201175388814;1537.938482460689;24267.39331516726;24362;24387.90254438519;24463;24584;40273.798631006655;40289.395659065725;40342.79828600838;40402.39396408998;40443;284917.5754121216;286033;286756.5662171759;287171.56414217793;287251;25968.09111681082;35191;35419.46870796889;35663.28673426465;35763.82118089497;45412.77293613643;46079.76960115178;46259.537404625524;46325.61023169311;46640.367587134286;26732.599011014463;29529.26176845596;31284.217894552818;31914.36171276608;31917;30778.846105769328;31108.533371999893;31872;31906.6809331913;32086.358272833946;35414.468782967764;38224.42663360108;38448.80775596216;38456.615433846426;38539.036524086;30536.7785288586;31525.684743153193;32180;32401.865934692174;32531;22272.109115635194;23004.654930175726;24479.755202447748;24496.65268410183;24927.875360623082 16:18:13 INFO - PID 1640 | |2;jquery.html;428.0646786770908;439.1765439800374;441.64006334837103;450.74082402618495;463.5503561545302;20734.170633174654;21114.788852111473;21376.679349809765;21398.786012139914;21970.340889773313;21625.45936351588;21806.018729157186;21936.89031554844;22364.664530032023;22684.88657556714;5988.161657367972;6145.4161854623735;6186.164867742842;6188.164597779287;6205;6075.544334174932;6343.33394993526;6346.619202847821;6359.491240700756;6391.041343798421;6045.6674882881425;6165.32181460039;6301.6219026858535;6310.305866354697;6328.683565821713;5301.125314323132;6288.213973253343;6289.1824062871765;6341.492680585542;6359.300476947532;4830.903381932377;5522.889542209174;5535.059039963216;5621.213030175779;5625.493705566478;18857.90571047136;21858.672119918214;23806.285811425685;26171.869140654177;28005.71994280072;1972.2308299763104;2215.745189303235;2279.11114665279;2294.4608017115966;2299.2872209614907;18044.819551804445;18067.27730890763;18091.638167236582;18674.62650746991;18801.059947002734;2160.7839216078264;2184.486645638274;2198.2525941179915;2205.217147912484;2210.049678638185;121627;143693.2815335927;146473;153766;154353;10379.532921018572;11343.262687925258;12258.877411225953;12451.252924824359;13079.084464087613;16402.589935251475;16405.261763220446;16454.917725411535;16461.094639794686;16472.67054658924;7729.613519324012;8592.312614990911;8763.649454021896;8909.599068041955;8952.194302512806;6714;8428.704995325133;8454.61954212062;8480.491170529787;8601.784955376166;8020.879686804703;8107.55408452529;8116.472429292077;8215.178482151738;8294.668213271521;2214.977850221477;2226.109556177542;2226.9310730849284;2231.359950436428;2378.571857065745;913.9543022848964;929.419113054341;969.8496733006396;996.2021037561324;1000.3047881722133;20342.389728308175;20528.692069618966;20898.791012089685;20933.581328373348;20964;1004.6333088422673;1010.5755582655303;1030.7629245273479;1035.891231420705;1042.2443728297076;10476.580936762444;10849.620263290904;10851;10880.966308200708;10890.673279801618;560735;568665.47001795;575409;581955;585573;126596;130274;132703;133777.3311133438;134512.63718406923;1079.5250089960234;1116.7771290436958;1162.2445410483085;1202.0984261803646;1207.3118322556234;16758.497245082668;17878.927264364178;18163.54591135232;18196.45410637683;18261.54346141357;42254.577454225066;54629;55900;56595.434045660666;56713.716431417575;78513;79927.20072799198;80186;81148;83625.58187209269;8776.736697899074;8778.122187781171;8780.604872780612;8900.109989001048;9199.632014719336;13794;14163.291835408394;14267.785983210053;14369;14475.565733027604;11748.29510229389;11763.823542646696;12027.398630068286;12141.210821296587;12184.147109702235;8249.83500329978;10238.948805255926;11158.55365785392;11238.494267758135;11306.660800176009;9413.48225847585;10561.366318020944;11693.473793679135;12022.819657704966;12240.877591223974;8346.290565302017;8674.918019675359;8860.715196296629;8875.467471951704;9053.139951704577;11738.471768770254;11790.823137653113;12038.75922481528;12048.698782530508;12102.394880256128 16:18:13 INFO - PID 1640 | |3;mootools.html;1219.6158210163799;1460.6786506968463;1468.9485867994622;1484.1466156959748;1491.4034386245507;11391.316521008735;11609.303441793498;11872.7625447491;11886.702832429182;11899;11535.538578456852;11726.648200553997;11790.17468777186;11852.525898964032;11853.051755859533;2500.6874140732452;2541.4027703489664;2545.7199708032103;2552.2726023083424;2557.9104731334405;2452.1294940296207;2490.489449662824;2522.4702812409414;2538.6065159900245;2541.8474891506567;2464.839785413951;2520.206135067457;2527.4313279512053;2527.4692314613862;2529.9241022769256;2433.902643894251;2494.164454907608;2507.912223072193;2508.523380557688;2514.823962322638;2274.533720587292;2495.427880435314;2506.962395564068;2517.332906779705;2526.5452218600644;11867.109966752529;11965.10261730365;11975.820362694567;11977.820332695017;11997.64007079789;6616.801495955129;6818.522703410763;6872.484563657696;6878.7248510059535;6882.380585747257;4041.474608300902;4280.657547396201;4317;4344.587264209927;4400.383946247528;1221.7556488702296;1227.7789997800392;1268.9746205075846;1270.5870592057618;1271.987280127196;16169.19154042305;16728.414505492372;16795.496135115965;16817.243224054946;16830.821842471032;5538.086215774432;5655.208270842086;5809.331926828384;5824.271966004249;5826.329972053183;12490.188137771016;12544.372781361079;12596.992240620728;12599.937000315123;12609.684757881127;6666.166729158856;6674.933250667528;6675.632840193739;6680.498962577826;6681.33186681328;5965.55258355625;6181.196444462281;6207.317195108534;6261.092141639528;6277.681686845723;4342.153280110411;4456.309272062771;4490.528494508095;4493.573110554492;4539.818407263672;1285.5564830133776;1304.478208716502;1313.0480401708685;1317.6508225320297;1328.973420531584;802.6668932393109;824.9546274954815;834.8664213725896;846.3229416466802;872.2978002707754;6207;6209.565330426827;6351.5871468355335;6397.552171347961;6459.741610335534;562.9577781666392;588.2206076948061;616.0666590115978;624.1293395713045;627.1126356205917;3911.530616326059;4407.352210630899;4481.619062379669;4536.206163921301;4579.931301030487;10579.788404231873;15162.090274583561;15240.466583669519;15360.385584576716;15392.923035384976;14694.926525367518;15248.475152484663;15253.16107614092;15299.235038248265;15352.232388380537;7281.381082608038;8543.829123417498;8679.392442528962;8749.868751968726;8780.956095219482;6242.625442473284;6850.314968503109;7162.498625096193;7171.282871712787;7182;13119.344032798132;13536.932315338361;13597.728045439233;13713.794293085411;13887.30563471802;13907;13963.30183490801;13970.790438143233;14107.153570785786;14178;9576.904230957602;9648.469334186406;9715.27135464857;9735.123838854537;9807.55865986018;10610.89389106099;10832.079273261546;10841.241113122005;10861.34831910088;10895.073918716998;6820.488463365366;7504;9258.675946341846;9315.673951411669;9344.065593440602;9030.277577793891;9066.909330906607;9081.955575108947;9183;9239.538023098683;8147.476096948347;8197.959010204911;8246;8344.165583441607;8357.871687322133;5066.670666406671;5231.633785634969;6066.3023752269055;6157.72290246931;6204.441600255998;5947.613405128825;6171.691415429301;6293.181886354744;6331.810045698637;6356.110144579855 16:18:13 INFO - PID 1640 | |4;prototype.html;342.3341600586858;347.9617242103368;358.8241761536848;396.56377984217346;406.06807377069623;4519.005818719885;5977.2528433945645;6190.195274614305;6206.689665516723;6223.502119830408;5140.408852981908;5582.944170558293;6025.397460253972;6034.758609655609;6046.12331211974;3626.34725749365;4324.891877703051;4388.407564978719;4422.535633758441;4490.236659767847;3262.2822978944714;3638.8726394576197;4079.796010199493;4444.488883778358;4479.260921947891;4419.668524860632;4426.358178064179;4442.155990361837;4444.466664000324;4465.620422264095;4280.3151495760685;4362.716423432498;4396.626286765629;4407.531782201977;4420.938974646094;3791.165943492455;3801.486799282089;3803.5055442792536;3813.122981714221;3845.1925095729653;5900.586958912878;5902.911456328158;5906.675132867691;5923.348431672513;5946.821595352147;4876.756162191876;5217.982493413786;5263.368395792491;5263.763130659129;5322.680639161663;5307.310049693515;6095.6952152392205;6130.17242672238;6371.745130194787;6486.135398451162;3501.562304711911;3957.8324394303463;4083.224187404384;4122.876313710593;4178.435911151986;4955.876103097416;5618.213240362434;6371.553991220617;6660.9000864987065;6933.479989000845;4027.81874815634;4049.9392509112386;4417.4036505072045;4445.17764213615;4460.28635418338;4033.69747268956;4460.706395145371;4515.751633660115;4522.140793249272;4549.7497637629585;4254.638355739735;4387.27609944362;5084.796608135707;5315.883664430513;5360.705161216092;5761.337446193657;5943.197668314722;6479.157709497735;6509.609423434609;6523.902141467882;1522.3682171898758;1538.9307481163376;1540.4993377152246;1543.984560154384;1547.2341191110472;960.3613596958085;1019.6838979916249;1025.2823023883311;1025.917926565873;1028.5422986770964;6137.772445510826;6155.861165684362;6176.938230617726;6202;6212.875742485216;5595.517187945198;5877.647341159544;6508.121403610547;6811.93188068113;6844.1444819397575;5831.591788574759;5867.911981320283;6132.62016046386;6138.232720909887;6161.291451483047;3485.9258741049034;3515.648435156464;3523.964760352415;3526.4886591444097;3538.522299489536;6001.849953751103;6556.967215163989;6717.316270310974;6754.5947243165565;6828.951314605599;6243.906341404882;6895.827604309932;6914.55055421396;6941.375276225164;6948.096747422803;6238.3685623053125;6338.619682818953;6576.2766095730385;6827.726890924506;6888.173419189729;4949.802007919643;5688.630239034615;6625.701843416961;6677.43241824431;6712.549919279525;6040.879182416239;6247.2199871058765;6585.147688602221;6600.537962342782;6637.4690024798865;6581.716565269727;6766.289539598271;6932.61870597122;6951.6871740770775;6977.79066628002;3457.014750796011;3906.4140378943384;4378.277584198699;4473.2842745160615;4556.066006468733;6492.38322359394;6713.496487763339;6791.758719622611;6806.78779396708;6813.8977915330315;6417.93582064192;6525.119108920235;6532.216134063943;6533.509986751108;6662;5962.493188078888;6140.355262697352;6277.874442511215;6554.442872355903;6565.868682626417;5128.486986414318;6138.539609529393;6459.773907913201;6463.903041454288;6486.767514172292;5730.885382292247;6339.175907132043;6617.7683781067435;6629.403353698191;6641.203055633355;6132.78535251264;6362.650054246876;6398.776042838478;6401.119496226624;6412.711427985659 16:18:13 INFO - PID 1640 | |5;yui.html;727.3490226247509;843.59085843366;861.3798065392918;884.5930871798975;886.9179600886915;14423.5672929812;15051.172185529791;16474.50576482706;16939.83060169398;16988.320467181315;17235.74146387805;17563.91218043911;17817.109144542785;18059.187336569852;18085.457436276934;966.2125367825236;1000.7948370584013;1007.5919252702668;1008.838585826268;1009.9091081802636;992.8758905136858;1001.4492029383846;1001.8246806808816;1005.4218824176091;1008.7982403519326;1051.6529545250048;1063.415121683075;1064.4890452582765;1067.4929408530925;1068.4230515521608;1039.8908114647966;1053.210092430677;1053.3890343600692;1053.4258828938248;1055.0504545908666;645.2353960556709;772.5557804262571;782.9804254893617;783.142459007386;784.4508843809356;16842.66314673712;17226.138693065295;17430.56423589408;17438.47684569465;17496.825031749646;16592.83407165925;16777.916110419494;16989;17242.396516121877;17272.82727172725;13791.793123103162;13884.166949983033;14116.50592229267;14129.929350353284;14163.645908852259;3025;3399.711024562915;3456.5679290088738;3461.3077384523194;3464.7401444891734;82160.58919705423;97058;122274;123241.38379308136;124246;10538.57845686164;11947.103967202494;12175.817362739566;12227.755444891052;12404.379781010914;17807.910960445115;20913.47716307074;20946;21191.258305959218;21198;7477.4391920605085;7748.7675369739;7772.45592808498;7780.260875216845;7791.142974272825;3727.3849814780256;3798.734088613826;3805.9048523786573;3809.447630093621;3811.5807261201244;4290.656747460196;4421.29259318514;4456.197884380843;4457.175422546839;4459.420275364182;934.3506263147184;967.2407160379069;969.1181025266973;974.2985050763439;977.4330888084894;618.2611778924232;624.0701354981046;653.4054010850103;664.8005598320581;666.8896287680957;11393.316401015965;11748.58879939198;11964.222325548986;13051.934740326238;13293.06948513614;659.8911179655399;668.7425341243559;673.5888313982199;674.750342373325;706.1385110165693;4941.579965702884;5366.463353664681;5630.211770352154;5659.179418984224;5709.885802283931;96408;99730;99853;99946.001079978;102122;87710.56144719236;88407;89163;89272.5536372314;91368;80047.7992830108;80625.59687201526;80940.33417660707;81066.59466702747;81721.18278817135;11101.611443599435;11151.386673733023;11535.711607209887;12501.06242031833;12966.09237353414;39501.60498395094;40080.59717909859;40107;40140.79929600333;41378.37932430956;58704.53238669068;60768;73544.16139596552;73876.52246954924;75787;16583.50249492517;16791.91604041972;16954.74567881458;16999.235034423233;17122.058286793846;18065;18326.633467330845;18370.1733421999;18636.534086647942;18730.250789968795;16875.24061417264;17207.795454318577;17368;17468.388606398716;17509;16724.916375418044;16931.91534042322;17006;17062;17124.914375428045;16095.839041609903;16344.509664710078;16575.751363729312;16625.334986600883;16721.832781672514;8697.695580654647;10960.28758130719;11241.325520468798;11304.886951130713;11410.258333208314;11982.340971246666;12789.232646041268;12801.29592872401;12824.358782061046;12871.22772633645 16:18:13 INFO - PID 1640 | __end_tp_report 16:18:13 INFO - PID 1640 | __start_cc_report 16:18:13 INFO - PID 1640 | _x_x_mozilla_cycle_collect,419 16:18:13 INFO - PID 1640 | __end_cc_report 16:18:13 INFO - PID 1640 | __startTimestamp1492557493947__endTimestamp 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | ------- Summary: start ------- 16:18:13 INFO - PID 1640 | Number of tests: 6 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6211.54 Median:6448.71 stddev:747.50 (11.6%) stddev-sans-first:721.84 16:18:13 INFO - PID 1640 | Values: 3630.2 3640.2 3693.7 3693.9 3696.0 5025.9 5856.1 6146.9 6316.5 6405.2 5165.8 6207.6 6231.6 6348.7 6381.7 5528.1 5545.3 5569.8 5589.2 5676.8 5445.3 5577.3 5659.3 5698.9 5720.0 5382.4 5462.5 5493.6 5509.7 5586.6 5444.8 5470.4 5491.5 5565.1 5613.9 5438.2 5470.9 5478.3 5513.9 5552.1 5361.4 5660.2 6268.5 6304.3 6398.6 5652.4 6522.7 6622.9 6701.6 6807.6 6821.1 6869.1 6897.9 6908.1 6926.7 6353.6 6382.3 6408.0 6429.4 6430.7 6706.3 6851.4 6866.5 7018.6 7050.5 5362.0 6318.2 6442.6 6518.4 6630.0 6419.3 6836.6 6853.6 6864.4 6895.7 5689.7 6636.8 6772.2 6785.9 6800.2 6408.8 6642.4 6654.6 6808.5 6813.6 4585.4 5395.2 5443.7 5459.2 5466.1 4810.2 4820.9 4824.9 4830.6 4846.9 6282.9 6371.4 6448.7 6478.6 6496.1 6671.9 6764.0 6793.3 6796.8 6882.4 6436.6 6464.2 6475.9 6476.8 6480.5 5985.0 6019.3 6047.9 6068.1 6072.5 6757.3 6837.1 6924.2 6986.5 7028.5 6871.3 6879.3 6879.7 6898.1 6922.3 6964.2 6971.4 7000.5 7023.2 7024.8 6511.2 6635.7 6701.4 6760.4 6796.4 6864.3 6875.3 6884.9 6892.2 6907.8 6354.6 6626.4 6652.8 6679.8 6700.3 6461.9 6585.3 6665.0 6681.3 6692.7 5299.3 6267.7 6559.3 6574.6 6581.1 6688.6 6705.0 6711.3 6730.9 6744.8 6207.5 6364.4 6376.3 6435.2 6465.9 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:44871.54 Median:330351.40 stddev:77346.73 (23.4%) stddev-sans-first:77492.61 16:18:13 INFO - PID 1640 | Values: 701.8 766.6 793.6 1256.5 1264.8 36342.3 37090.1 37187.6 37235.3 37266.6 37021.4 37302.3 37307.8 37387.8 37412.3 8060.2 8230.1 8625.8 8894.1 8912.1 8748.1 8901.6 8903.0 8905.8 8910.6 7920.4 8457.8 8848.8 8888.3 8920.6 7515.8 8825.0 8880.4 8895.5 8921.7 8506.1 8554.1 8603.1 8606.8 8625.5 38140.4 38148.8 38257.4 38279.9 38344.6 3364.3 3389.0 3423.5 3436.8 3667.9 24649.1 31488.0 31578.2 31738.8 31739.8 2616.8 3146.2 3191.5 3195.2 3196.8 242633.0 245322.0 250899.0 280574.0 306258.0 48678.3 48703.5 49047.8 49064.5 49222.0 51729.5 51907.5 51998.7 52024.7 52031.6 11371.4 11499.6 14370.9 14381.2 14391.8 9717.0 11602.7 11657.5 11772.9 11775.0 13764.4 13778.5 13801.5 13829.1 13959.2 5967.3 5990.2 6009.3 6018.4 6037.0 1020.7 1045.9 1053.7 1068.5 1079.7 23242.7 24391.0 24467.3 24529.4 24598.5 1118.5 1122.4 1159.8 1162.7 1171.3 12575.4 12608.2 12642.7 12699.6 12711.7 327711.0 328344.0 328410.0 329013.8 331689.0 55455.7 55584.4 55759.7 55795.0 55843.0 1340.0 1472.8 1496.4 1536.2 1537.9 24267.4 24362.0 24387.9 24463.0 24584.0 40273.8 40289.4 40342.8 40402.4 40443.0 284917.6 286033.0 286756.6 287171.6 287251.0 25968.1 35191.0 35419.5 35663.3 35763.8 45412.8 46079.8 46259.5 46325.6 46640.4 26732.6 29529.3 31284.2 31914.4 31917.0 30778.8 31108.5 31872.0 31906.7 32086.4 35414.5 38224.4 38448.8 38456.6 38539.0 30536.8 31525.7 32180.0 32401.9 32531.0 22272.1 23004.7 24479.8 24496.7 24927.9 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:35829.47 Median:2215.36 stddev:96859.35 (4372.2%) stddev-sans-first:97094.59 16:18:13 INFO - PID 1640 | Values: 428.1 439.2 441.6 450.7 463.6 20734.2 21114.8 21376.7 21398.8 21970.3 21625.5 21806.0 21936.9 22364.7 22684.9 5988.2 6145.4 6186.2 6188.2 6205.0 6075.5 6343.3 6346.6 6359.5 6391.0 6045.7 6165.3 6301.6 6310.3 6328.7 5301.1 6288.2 6289.2 6341.5 6359.3 4830.9 5522.9 5535.1 5621.2 5625.5 18857.9 21858.7 23806.3 26171.9 28005.7 1972.2 2215.7 2279.1 2294.5 2299.3 18044.8 18067.3 18091.6 18674.6 18801.1 2160.8 2184.5 2198.3 2205.2 2210.0 121627.0 143693.3 146473.0 153766.0 154353.0 10379.5 11343.3 12258.9 12451.3 13079.1 16402.6 16405.3 16454.9 16461.1 16472.7 7729.6 8592.3 8763.6 8909.6 8952.2 6714.0 8428.7 8454.6 8480.5 8601.8 8020.9 8107.6 8116.5 8215.2 8294.7 2215.0 2226.1 2226.9 2231.4 2378.6 914.0 929.4 969.8 996.2 1000.3 20342.4 20528.7 20898.8 20933.6 20964.0 1004.6 1010.6 1030.8 1035.9 1042.2 10476.6 10849.6 10851.0 10881.0 10890.7 560735.0 568665.5 575409.0 581955.0 585573.0 126596.0 130274.0 132703.0 133777.3 134512.6 1079.5 1116.8 1162.2 1202.1 1207.3 16758.5 17878.9 18163.5 18196.5 18261.5 42254.6 54629.0 55900.0 56595.4 56713.7 78513.0 79927.2 80186.0 81148.0 83625.6 8776.7 8778.1 8780.6 8900.1 9199.6 13794.0 14163.3 14267.8 14369.0 14475.6 11748.3 11763.8 12027.4 12141.2 12184.1 8249.8 10238.9 11158.6 11238.5 11306.7 9413.5 10561.4 11693.5 12022.8 12240.9 8346.3 8674.9 8860.7 8875.5 9053.1 11738.5 11790.8 12038.8 12048.7 12102.4 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7172.51 Median:3976.50 stddev:4565.59 (114.8%) stddev-sans-first:4556.48 16:18:13 INFO - PID 1640 | Values: 1219.6 1460.7 1468.9 1484.1 1491.4 11391.3 11609.3 11872.8 11886.7 11899.0 11535.5 11726.6 11790.2 11852.5 11853.1 2500.7 2541.4 2545.7 2552.3 2557.9 2452.1 2490.5 2522.5 2538.6 2541.8 2464.8 2520.2 2527.4 2527.5 2529.9 2433.9 2494.2 2507.9 2508.5 2514.8 2274.5 2495.4 2507.0 2517.3 2526.5 11867.1 11965.1 11975.8 11977.8 11997.6 6616.8 6818.5 6872.5 6878.7 6882.4 4041.5 4280.7 4317.0 4344.6 4400.4 1221.8 1227.8 1269.0 1270.6 1272.0 16169.2 16728.4 16795.5 16817.2 16830.8 5538.1 5655.2 5809.3 5824.3 5826.3 12490.2 12544.4 12597.0 12599.9 12609.7 6666.2 6674.9 6675.6 6680.5 6681.3 5965.6 6181.2 6207.3 6261.1 6277.7 4342.2 4456.3 4490.5 4493.6 4539.8 1285.6 1304.5 1313.0 1317.7 1329.0 802.7 825.0 834.9 846.3 872.3 6207.0 6209.6 6351.6 6397.6 6459.7 563.0 588.2 616.1 624.1 627.1 3911.5 4407.4 4481.6 4536.2 4579.9 10579.8 15162.1 15240.5 15360.4 15392.9 14694.9 15248.5 15253.2 15299.2 15352.2 7281.4 8543.8 8679.4 8749.9 8781.0 6242.6 6850.3 7162.5 7171.3 7182.0 13119.3 13536.9 13597.7 13713.8 13887.3 13907.0 13963.3 13970.8 14107.2 14178.0 9576.9 9648.5 9715.3 9735.1 9807.6 10610.9 10832.1 10841.2 10861.3 10895.1 6820.5 7504.0 9258.7 9315.7 9344.1 9030.3 9066.9 9082.0 9183.0 9239.5 8147.5 8198.0 8246.0 8344.2 8357.9 5066.7 5231.6 6066.3 6157.7 6204.4 5947.6 6171.7 6293.2 6331.8 6356.1 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5177.95 Median:5904.79 stddev:1652.06 (28.0%) stddev-sans-first:1616.33 16:18:13 INFO - PID 1640 | Values: 342.3 348.0 358.8 396.6 406.1 4519.0 5977.3 6190.2 6206.7 6223.5 5140.4 5582.9 6025.4 6034.8 6046.1 3626.3 4324.9 4388.4 4422.5 4490.2 3262.3 3638.9 4079.8 4444.5 4479.3 4419.7 4426.4 4442.2 4444.5 4465.6 4280.3 4362.7 4396.6 4407.5 4420.9 3791.2 3801.5 3803.5 3813.1 3845.2 5900.6 5902.9 5906.7 5923.3 5946.8 4876.8 5218.0 5263.4 5263.8 5322.7 5307.3 6095.7 6130.2 6371.7 6486.1 3501.6 3957.8 4083.2 4122.9 4178.4 4955.9 5618.2 6371.6 6660.9 6933.5 4027.8 4049.9 4417.4 4445.2 4460.3 4033.7 4460.7 4515.8 4522.1 4549.7 4254.6 4387.3 5084.8 5315.9 5360.7 5761.3 5943.2 6479.2 6509.6 6523.9 1522.4 1538.9 1540.5 1544.0 1547.2 960.4 1019.7 1025.3 1025.9 1028.5 6137.8 6155.9 6176.9 6202.0 6212.9 5595.5 5877.6 6508.1 6811.9 6844.1 5831.6 5867.9 6132.6 6138.2 6161.3 3485.9 3515.6 3524.0 3526.5 3538.5 6001.8 6557.0 6717.3 6754.6 6829.0 6243.9 6895.8 6914.6 6941.4 6948.1 6238.4 6338.6 6576.3 6827.7 6888.2 4949.8 5688.6 6625.7 6677.4 6712.5 6040.9 6247.2 6585.1 6600.5 6637.5 6581.7 6766.3 6932.6 6951.7 6977.8 3457.0 3906.4 4378.3 4473.3 4556.1 6492.4 6713.5 6791.8 6806.8 6813.9 6417.9 6525.1 6532.2 6533.5 6662.0 5962.5 6140.4 6277.9 6554.4 6565.9 5128.5 6138.5 6459.8 6463.9 6486.8 5730.9 6339.2 6617.8 6629.4 6641.2 6132.8 6362.7 6398.8 6401.1 6412.7 16:18:13 INFO - PID 1640 | 16:18:13 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:21356.38 Median:18062.09 stddev:29346.36 (162.5%) stddev-sans-first:29387.80 16:18:13 INFO - PID 1640 | Values: 727.3 843.6 861.4 884.6 886.9 14423.6 15051.2 16474.5 16939.8 16988.3 17235.7 17563.9 17817.1 18059.2 18085.5 966.2 1000.8 1007.6 1008.8 1009.9 992.9 1001.4 1001.8 1005.4 1008.8 1051.7 1063.4 1064.5 1067.5 1068.4 1039.9 1053.2 1053.4 1053.4 1055.1 645.2 772.6 783.0 783.1 784.5 16842.7 17226.1 17430.6 17438.5 17496.8 16592.8 16777.9 16989.0 17242.4 17272.8 13791.8 13884.2 14116.5 14129.9 14163.6 3025.0 3399.7 3456.6 3461.3 3464.7 82160.6 97058.0 122274.0 123241.4 124246.0 10538.6 11947.1 12175.8 12227.8 12404.4 17807.9 20913.5 20946.0 21191.3 21198.0 7477.4 7748.8 7772.5 7780.3 7791.1 3727.4 3798.7 3805.9 3809.4 3811.6 4290.7 4421.3 4456.2 4457.2 4459.4 934.4 967.2 969.1 974.3 977.4 618.3 624.1 653.4 664.8 666.9 11393.3 11748.6 11964.2 13051.9 13293.1 659.9 668.7 673.6 674.8 706.1 4941.6 5366.5 5630.2 5659.2 5709.9 96408.0 99730.0 99853.0 99946.0 102122.0 87710.6 88407.0 89163.0 89272.6 91368.0 80047.8 80625.6 80940.3 81066.6 81721.2 11101.6 11151.4 11535.7 12501.1 12966.1 39501.6 40080.6 40107.0 40140.8 41378.4 58704.5 60768.0 73544.2 73876.5 75787.0 16583.5 16791.9 16954.7 16999.2 17122.1 18065.0 18326.6 18370.2 18636.5 18730.3 16875.2 17207.8 17368.0 17468.4 17509.0 16724.9 16931.9 17006.0 17062.0 17124.9 16095.8 16344.5 16575.8 16625.3 16721.8 8697.7 10960.3 11241.3 11304.9 11410.3 11982.3 12789.2 12801.3 12824.4 12871.2 16:18:13 INFO - PID 1640 | -------- Summary: end -------- 16:18:13 INFO - PID 1640 | 16:18:14 INFO - TEST-INFO | 1640: exit 0 16:18:14 INFO - TEST-OK | dromaeo_css | took 1115886ms 16:18:14 INFO - TEST-START | kraken 16:18:14 INFO - operating with platform_type : mac_ 16:18:14 INFO - Initialising browser for kraken test... 16:18:14 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpDebP_I/profile http://localhost:49240/getInfo.html) 16:18:17 INFO - PID 1653 | 2017-04-18 16:18:17.802 plugin-container[1654:10116] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 16:18:17 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:18:17 INFO - PID 1653 | 2017-04-18 16:18:17.805 plugin-container[1654:10116] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 16:18:17 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:18:17 INFO - PID 1653 | 2017-04-18 16:18:17.805 plugin-container[1654:10116] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:18:17 INFO - PID 1653 | __metrics Screen width/height:1600/1200 16:18:17 INFO - PID 1653 | colorDepth:24 16:18:17 INFO - PID 1653 | Browser inner width/height: 1024/689 16:18:17 INFO - PID 1653 | __metrics 16:18:17 ERROR - PID 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 16:18:18 INFO - TEST-INFO | 1653: exit 0 16:18:18 INFO - Browser initialized. 16:18:18 INFO - Running cycle 1/1 for kraken test... 16:18:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/T/tmpDebP_I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:21 INFO - PID 1655 | 2017-04-18 16:18:21.306 plugin-container[1656:10253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 16:18:21 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:18:21 INFO - PID 1655 | 2017-04-18 16:18:21.307 plugin-container[1656:10253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 16:18:21 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:18:21 INFO - PID 1655 | 2017-04-18 16:18:21.307 plugin-container[1656:10253] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:18:31 INFO - PID 1655 | RSS: Main: 236548096 16:18:31 INFO - PID 1655 | 16:18:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:35 INFO - PID 1655 | RSS: Main: 248643584 16:18:35 INFO - PID 1655 | 16:18:37 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 16:18:38 INFO - PID 1655 | RSS: Main: 257052672 16:18:38 INFO - PID 1655 | 16:18:42 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 16:18:42 INFO - PID 1655 | RSS: Main: 259686400 16:18:42 INFO - PID 1655 | 16:18:44 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 16:18:45 INFO - PID 1655 | RSS: Main: 261447680 16:18:45 INFO - PID 1655 | 16:18:47 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:47 INFO - PID 1655 | RSS: Main: 261779456 16:18:47 INFO - PID 1655 | 16:18:50 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:51 INFO - PID 1655 | RSS: Main: 267202560 16:18:51 INFO - PID 1655 | 16:18:54 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:55 INFO - PID 1655 | RSS: Main: 268271616 16:18:55 INFO - PID 1655 | 16:18:58 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 16:18:58 INFO - PID 1655 | RSS: Main: 268369920 16:18:58 INFO - PID 1655 | 16:19:00 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:00 INFO - PID 1655 | RSS: Main: 268427264 16:19:00 INFO - PID 1655 | 16:19:02 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:03 INFO - PID 1655 | RSS: Main: 268468224 16:19:03 INFO - PID 1655 | 16:19:05 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:06 INFO - PID 1655 | RSS: Main: 268132352 16:19:06 INFO - PID 1655 | 16:19:09 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:10 INFO - PID 1655 | RSS: Main: 268713984 16:19:10 INFO - PID 1655 | 16:19:13 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:13 INFO - PID 1655 | RSS: Main: 268328960 16:19:13 INFO - PID 1655 | 16:19:15 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 16:19:16 INFO - PID 1655 | RSS: Main: 270090240 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | __start_tp_report 16:19:16 INFO - PID 1655 | _x_x_mozilla_page_load 16:19:16 INFO - PID 1655 | _x_x_mozilla_page_load_details 16:19:16 INFO - PID 1655 | |i|pagename|runs| 16:19:16 INFO - PID 1655 | |0;ai-astar;109;156;156;116;97;96;172;167;157;131 16:19:16 INFO - PID 1655 | |1;audio-beat-detection;182;148;140;134;146;157;148;116;139;117 16:19:16 INFO - PID 1655 | |2;audio-dft;223;279;245;201;198;200;198;204;198;200 16:19:16 INFO - PID 1655 | |3;audio-fft;84;57;59;84;63;64;50;66;93;50 16:19:16 INFO - PID 1655 | |4;audio-oscillator;99;101;108;70;72;72;94;58;75;97 16:19:16 INFO - PID 1655 | |5;imaging-gaussian-blur;90;90;89;122;134;99;132;90;89;89 16:19:16 INFO - PID 1655 | |6;imaging-darkroom;97;105;97;96;97;96;149;97;98;99 16:19:16 INFO - PID 1655 | |7;imaging-desaturate;147;90;91;92;104;90;90;89;90;112 16:19:16 INFO - PID 1655 | |8;json-parse-financial;52;52;53;53;53;52;53;54;53;52 16:19:16 INFO - PID 1655 | |9;json-stringify-tinderbox;71;56;80;89;89;90;82;59;59;74 16:19:16 INFO - PID 1655 | |10;stanford-crypto-aes;84;82;86;85;87;85;81;112;104;85 16:19:16 INFO - PID 1655 | |11;stanford-crypto-ccm;139;146;138;137;152;151;164;144;219;155 16:19:16 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;182;187;190;184;193;184;209;243;195;184 16:19:16 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;70;67;74;102;98;98;69;84;99;101 16:19:16 INFO - PID 1655 | __end_tp_report 16:19:16 INFO - PID 1655 | __start_cc_report 16:19:16 INFO - PID 1655 | _x_x_mozilla_cycle_collect,1009 16:19:16 INFO - PID 1655 | __end_cc_report 16:19:16 INFO - PID 1655 | __startTimestamp1492557556099__endTimestamp 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | ------- Summary: start ------- 16:19:16 INFO - PID 1655 | Number of tests: 14 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:135.70 Median:162.00 stddev:29.39 (18.1%) stddev-sans-first:29.54 16:19:16 INFO - PID 1655 | Values: 109.0 156.0 156.0 116.0 97.0 96.0 172.0 167.0 157.0 131.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:147.00 stddev:19.11 (13.0%) stddev-sans-first:14.01 16:19:16 INFO - PID 1655 | Values: 182.0 148.0 140.0 134.0 146.0 157.0 148.0 116.0 139.0 117.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:214.60 Median:202.50 stddev:27.27 (13.5%) stddev-sans-first:28.75 16:19:16 INFO - PID 1655 | Values: 223.0 279.0 245.0 201.0 198.0 200.0 198.0 204.0 198.0 200.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:67.00 Median:65.00 stddev:14.99 (23.1%) stddev-sans-first:14.58 16:19:16 INFO - PID 1655 | Values: 84.0 57.0 59.0 84.0 63.0 64.0 50.0 66.0 93.0 50.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:84.60 Median:73.50 stddev:16.98 (23.1%) stddev-sans-first:17.20 16:19:16 INFO - PID 1655 | Values: 99.0 101.0 108.0 70.0 72.0 72.0 94.0 58.0 75.0 97.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:102.40 Median:89.50 stddev:19.06 (21.3%) stddev-sans-first:19.68 16:19:16 INFO - PID 1655 | Values: 90.0 90.0 89.0 122.0 134.0 99.0 132.0 90.0 89.0 89.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:97.00 stddev:16.34 (16.8%) stddev-sans-first:17.18 16:19:16 INFO - PID 1655 | Values: 97.0 105.0 97.0 96.0 97.0 96.0 149.0 97.0 98.0 99.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:90.00 stddev:18.36 (20.4%) stddev-sans-first:8.11 16:19:16 INFO - PID 1655 | Values: 147.0 90.0 91.0 92.0 104.0 90.0 90.0 89.0 90.0 112.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.67 16:19:16 INFO - PID 1655 | Values: 52.0 52.0 53.0 53.0 53.0 52.0 53.0 54.0 53.0 52.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:81.00 stddev:13.25 (16.4%) stddev-sans-first:13.98 16:19:16 INFO - PID 1655 | Values: 71.0 56.0 80.0 89.0 89.0 90.0 82.0 59.0 59.0 74.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:85.00 stddev:10.29 (12.1%) stddev-sans-first:10.75 16:19:16 INFO - PID 1655 | Values: 84.0 82.0 86.0 85.0 87.0 85.0 81.0 112.0 104.0 85.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:151.50 stddev:24.20 (16.0%) stddev-sans-first:25.01 16:19:16 INFO - PID 1655 | Values: 139.0 146.0 138.0 137.0 152.0 151.0 164.0 144.0 219.0 155.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:191.50 stddev:18.63 (9.7%) stddev-sans-first:19.15 16:19:16 INFO - PID 1655 | Values: 182.0 187.0 190.0 184.0 193.0 184.0 209.0 243.0 195.0 184.0 16:19:16 INFO - PID 1655 | 16:19:16 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.20 Median:79.00 stddev:14.88 (18.8%) stddev-sans-first:14.58 16:19:16 INFO - PID 1655 | Values: 70.0 67.0 74.0 102.0 98.0 98.0 69.0 84.0 99.0 101.0 16:19:16 INFO - PID 1655 | -------- Summary: end -------- 16:19:16 INFO - PID 1655 | 16:19:17 INFO - TEST-INFO | 1655: exit 0 16:19:17 INFO - TEST-OK | kraken | took 62426ms 16:19:17 INFO - SUITE-END | took 1178s 16:19:17 INFO - Completed test suite (00:19:38) 16:19:17 INFO - javascript benchmark 16:19:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7855.780779722497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3630.16506203573, 3640.2173532690467, 3693.741438099334, 3693.9445908311372, 3696.0390298522393, 5025.874353141164, 5856.121581762733, 6146.924288249561, 6316.5262605304615, 6405.19935008124, 5165.845024649267, 6207.596506227103, 6231.626102433857, 6348.650824204667, 6381.712822922968, 5528.143137813645, 5545.279113715222, 5569.832905012856, 5589.189567512708, 5676.801311954083, 5445.292112025431, 5577.330720313568, 5659.292588426447, 5698.857528561798, 5720.0, 5382.354117505885, 5462.481064298885, 5493.560515158818, 5509.696966666832, 5586.6368686035485, 5444.754986025599, 5470.398256191816, 5491.450854914517, 5565.0817615093465, 5613.943860561383, 5438.184272359138, 5470.890582188374, 5478.260434841325, 5513.917291240635, 5552.139418390156, 5361.383440904307, 5660.235868157787, 6268.529860260499, 6304.306526282106, 6398.616083035033, 5652.434756524356, 6522.706478208492, 6622.86754264912, 6701.631410272433, 6807.625580593065, 6821.147356580427, 6869.072675188835, 6897.862042759117, 6908.101946746941, 6926.688299026506, 6353.5870168438905, 6382.297947225801, 6407.962983320478, 6429.421352078241, 6430.742770289229, 6706.295838936939, 6851.383375496229, 6866.519343645897, 7018.649067546602, 7050.506464547535, 5361.973190134025, 6318.210223722035, 6442.645654488954, 6518.380753828379, 6629.972354285093, 6419.261784894797, 6836.623985680835, 6853.554518956252, 6864.38220560152, 6895.689693963784, 5689.691370984614, 6636.800895973129, 6772.2211945625895, 6785.9321406786285, 6800.217974932946, 6408.775692850728, 6642.402183803384, 6654.633995130217, 6808.523403361717, 6813.557118787263, 4585.426821647294, 5395.217693434509, 5443.673379597237, 5459.235707001023, 5466.125419932871, 4810.182269014206, 4820.903581928342, 4824.903501929942, 4830.637702172281, 4846.854594362175, 6282.874342513124, 6371.39471750183, 6448.709808058648, 6478.578892371981, 6496.058071579594, 6671.933280667228, 6763.966180169067, 6793.320667933266, 6796.796096117125, 6882.449404047664, 6436.613803171825, 6464.159659244362, 6475.902861457082, 6476.838079047967, 6480.51396145291, 5985.042393217064, 6019.277686677539, 6047.879042419127, 6068.059450785136, 6072.544559158081, 6757.290484499057, 6837.145356830396, 6924.238333783381, 6986.54587451814, 7028.508004439743, 6871.347222013901, 6879.346462086094, 6879.7248110077035, 6898.1377327834025, 6922.342377474132, 6964.164300283998, 6971.44228461732, 7000.50996430245, 7023.22744498115, 7024.824379390556, 6511.21865376139, 6635.668216589248, 6701.430378417889, 6760.425363844129, 6796.35434633709, 6864.313568643096, 6875.346842049998, 6884.896726549206, 6892.207396149507, 6907.758228461979, 6354.555181137276, 6626.4367528760595, 6652.800415987528, 6679.799606011828, 6700.329967003261, 6461.935380646133, 6585.308542603149, 6665.0335701322065, 6681.33186681328, 6692.732290708512, 5299.258103865385, 6267.749290028348, 6559.278479367361, 6574.572652777554, 6581.07864898905, 6688.598684078971, 6704.966475167788, 6711.3288671132495, 6730.899036514358, 6744.763933262312, 6207.534434917489, 6364.395382438661, 6376.298607153302, 6435.163428754232, 6465.90079686445], "value": 6164.119753257767, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.7613911446294, 766.5937053361719, 793.6269953122035, 1256.5413624027233, 1264.8166015927698, 36342.273154536895, 37090.07274818131, 37187.62812371879, 37235.25529489412, 37266.627333726654, 37021.44467832985, 37302.253954920954, 37307.81346093266, 37387.81306093473, 37412.251754964884, 8060.153683863183, 8230.09468958414, 8625.784355391103, 8894.066123057082, 8912.108789121101, 8748.081451447602, 8901.554922253894, 8902.955485222565, 8905.821883562325, 8910.554472276393, 7920.405969552277, 8457.788555286137, 8848.823023539526, 8888.288936885034, 8920.643174273022, 7515.774526764206, 8825.0, 8880.378373513857, 8895.510746908918, 8921.732348029602, 8506.106858779802, 8554.101819308946, 8603.053664096944, 8606.784830379229, 8625.482471051757, 38140.42789358162, 38148.80925595354, 38257.426138607945, 38279.85160445191, 38344.61655383466, 3364.310316385135, 3388.983305008512, 3423.4864770284657, 3436.7937923724658, 3667.853285868562, 24649.137280195107, 31488.0, 31578.210544736336, 31738.841305793554, 31739.841300793578, 2616.751408616178, 3146.197719581492, 3191.4574522331027, 3195.249116457654, 3196.840157992114, 242633.0, 245322.0, 250899.0, 280574.0, 306258.0, 48678.26982595264, 48703.512964870606, 49047.754761225966, 49064.50935490671, 49222.0, 51729.48270517322, 51907.48092519026, 51998.740006299726, 52024.73987630037, 52031.57731592781, 11371.431428428545, 11499.597514087134, 14370.856291437161, 14381.209033503048, 14391.78412323816, 9716.951415242878, 11602.70993225176, 11657.533698652129, 11772.88227117735, 11775.0, 13764.449422023006, 13778.517751878637, 13801.51694690681, 13829.10110842792, 13959.162450253018, 5967.329147838612, 5990.191324171268, 6009.278886533644, 6018.398160183947, 6037.0, 1020.7193021919031, 1045.9320144190604, 1053.7102296868422, 1068.4817863336275, 1079.6760971708457, 23242.65136022961, 24391.024359025796, 24467.265982020566, 24529.386765331008, 24598.508029839304, 1118.496676495564, 1122.4163435013747, 1159.7738441003924, 1162.6744511536783, 1171.308927732642, 12575.371231438392, 12608.243505389706, 12642.683932901751, 12699.619011429671, 12711.68220794469, 327711.0, 328344.0, 328410.0, 329013.8084810669, 331689.0, 55455.72272138613, 55584.44415555873, 55759.72120139373, 55795.0, 55843.0, 1339.9933000334936, 1472.7938088667595, 1496.3939604459993, 1536.201175388814, 1537.938482460689, 24267.39331516726, 24362.0, 24387.90254438519, 24463.0, 24584.0, 40273.798631006655, 40289.395659065725, 40342.79828600838, 40402.39396408998, 40443.0, 284917.5754121216, 286033.0, 286756.5662171759, 287171.56414217793, 287251.0, 25968.09111681082, 35191.0, 35419.46870796889, 35663.28673426465, 35763.82118089497, 45412.77293613643, 46079.76960115178, 46259.537404625524, 46325.61023169311, 46640.367587134286, 26732.599011014463, 29529.26176845596, 31284.217894552818, 31914.36171276608, 31917.0, 30778.846105769328, 31108.533371999893, 31872.0, 31906.6809331913, 32086.358272833946, 35414.468782967764, 38224.42663360108, 38448.80775596216, 38456.615433846426, 38539.036524086, 30536.7785288586, 31525.684743153193, 32180.0, 32401.865934692174, 32531.0, 22272.109115635194, 23004.654930175726, 24479.755202447748, 24496.65268410183, 24927.875360623082], "value": 17664.752980377812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.0646786770908, 439.1765439800374, 441.64006334837103, 450.74082402618495, 463.5503561545302, 20734.170633174654, 21114.788852111473, 21376.679349809765, 21398.786012139914, 21970.340889773313, 21625.45936351588, 21806.018729157186, 21936.89031554844, 22364.664530032023, 22684.88657556714, 5988.161657367972, 6145.4161854623735, 6186.164867742842, 6188.164597779287, 6205.0, 6075.544334174932, 6343.33394993526, 6346.619202847821, 6359.491240700756, 6391.041343798421, 6045.6674882881425, 6165.32181460039, 6301.6219026858535, 6310.305866354697, 6328.683565821713, 5301.125314323132, 6288.213973253343, 6289.1824062871765, 6341.492680585542, 6359.300476947532, 4830.903381932377, 5522.889542209174, 5535.059039963216, 5621.213030175779, 5625.493705566478, 18857.90571047136, 21858.672119918214, 23806.285811425685, 26171.869140654177, 28005.71994280072, 1972.2308299763104, 2215.745189303235, 2279.11114665279, 2294.4608017115966, 2299.2872209614907, 18044.819551804445, 18067.27730890763, 18091.638167236582, 18674.62650746991, 18801.059947002734, 2160.7839216078264, 2184.486645638274, 2198.2525941179915, 2205.217147912484, 2210.049678638185, 121627.0, 143693.2815335927, 146473.0, 153766.0, 154353.0, 10379.532921018572, 11343.262687925258, 12258.877411225953, 12451.252924824359, 13079.084464087613, 16402.589935251475, 16405.261763220446, 16454.917725411535, 16461.094639794686, 16472.67054658924, 7729.613519324012, 8592.312614990911, 8763.649454021896, 8909.599068041955, 8952.194302512806, 6714.0, 8428.704995325133, 8454.61954212062, 8480.491170529787, 8601.784955376166, 8020.879686804703, 8107.55408452529, 8116.472429292077, 8215.178482151738, 8294.668213271521, 2214.977850221477, 2226.109556177542, 2226.9310730849284, 2231.359950436428, 2378.571857065745, 913.9543022848964, 929.419113054341, 969.8496733006396, 996.2021037561324, 1000.3047881722133, 20342.389728308175, 20528.692069618966, 20898.791012089685, 20933.581328373348, 20964.0, 1004.6333088422673, 1010.5755582655303, 1030.7629245273479, 1035.891231420705, 1042.2443728297076, 10476.580936762444, 10849.620263290904, 10851.0, 10880.966308200708, 10890.673279801618, 560735.0, 568665.47001795, 575409.0, 581955.0, 585573.0, 126596.0, 130274.0, 132703.0, 133777.3311133438, 134512.63718406923, 1079.5250089960234, 1116.7771290436958, 1162.2445410483085, 1202.0984261803646, 1207.3118322556234, 16758.497245082668, 17878.927264364178, 18163.54591135232, 18196.45410637683, 18261.54346141357, 42254.577454225066, 54629.0, 55900.0, 56595.434045660666, 56713.716431417575, 78513.0, 79927.20072799198, 80186.0, 81148.0, 83625.58187209269, 8776.736697899074, 8778.122187781171, 8780.604872780612, 8900.109989001048, 9199.632014719336, 13794.0, 14163.291835408394, 14267.785983210053, 14369.0, 14475.565733027604, 11748.29510229389, 11763.823542646696, 12027.398630068286, 12141.210821296587, 12184.147109702235, 8249.83500329978, 10238.948805255926, 11158.55365785392, 11238.494267758135, 11306.660800176009, 9413.48225847585, 10561.366318020944, 11693.473793679135, 12022.819657704966, 12240.877591223974, 8346.290565302017, 8674.918019675359, 8860.715196296629, 8875.467471951704, 9053.139951704577, 11738.471768770254, 11790.823137653113, 12038.75922481528, 12048.698782530508, 12102.394880256128], "value": 10354.69111596297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.6158210163799, 1460.6786506968463, 1468.9485867994622, 1484.1466156959748, 1491.4034386245507, 11391.316521008735, 11609.303441793498, 11872.7625447491, 11886.702832429182, 11899.0, 11535.538578456852, 11726.648200553997, 11790.17468777186, 11852.525898964032, 11853.051755859533, 2500.6874140732452, 2541.4027703489664, 2545.7199708032103, 2552.2726023083424, 2557.9104731334405, 2452.1294940296207, 2490.489449662824, 2522.4702812409414, 2538.6065159900245, 2541.8474891506567, 2464.839785413951, 2520.206135067457, 2527.4313279512053, 2527.4692314613862, 2529.9241022769256, 2433.902643894251, 2494.164454907608, 2507.912223072193, 2508.523380557688, 2514.823962322638, 2274.533720587292, 2495.427880435314, 2506.962395564068, 2517.332906779705, 2526.5452218600644, 11867.109966752529, 11965.10261730365, 11975.820362694567, 11977.820332695017, 11997.64007079789, 6616.801495955129, 6818.522703410763, 6872.484563657696, 6878.7248510059535, 6882.380585747257, 4041.474608300902, 4280.657547396201, 4317.0, 4344.587264209927, 4400.383946247528, 1221.7556488702296, 1227.7789997800392, 1268.9746205075846, 1270.5870592057618, 1271.987280127196, 16169.19154042305, 16728.414505492372, 16795.496135115965, 16817.243224054946, 16830.821842471032, 5538.086215774432, 5655.208270842086, 5809.331926828384, 5824.271966004249, 5826.329972053183, 12490.188137771016, 12544.372781361079, 12596.992240620728, 12599.937000315123, 12609.684757881127, 6666.166729158856, 6674.933250667528, 6675.632840193739, 6680.498962577826, 6681.33186681328, 5965.55258355625, 6181.196444462281, 6207.317195108534, 6261.092141639528, 6277.681686845723, 4342.153280110411, 4456.309272062771, 4490.528494508095, 4493.573110554492, 4539.818407263672, 1285.5564830133776, 1304.478208716502, 1313.0480401708685, 1317.6508225320297, 1328.973420531584, 802.6668932393109, 824.9546274954815, 834.8664213725896, 846.3229416466802, 872.2978002707754, 6207.0, 6209.565330426827, 6351.5871468355335, 6397.552171347961, 6459.741610335534, 562.9577781666392, 588.2206076948061, 616.0666590115978, 624.1293395713045, 627.1126356205917, 3911.530616326059, 4407.352210630899, 4481.619062379669, 4536.206163921301, 4579.931301030487, 10579.788404231873, 15162.090274583561, 15240.466583669519, 15360.385584576716, 15392.923035384976, 14694.926525367518, 15248.475152484663, 15253.16107614092, 15299.235038248265, 15352.232388380537, 7281.381082608038, 8543.829123417498, 8679.392442528962, 8749.868751968726, 8780.956095219482, 6242.625442473284, 6850.314968503109, 7162.498625096193, 7171.282871712787, 7182.0, 13119.344032798132, 13536.932315338361, 13597.728045439233, 13713.794293085411, 13887.30563471802, 13907.0, 13963.30183490801, 13970.790438143233, 14107.153570785786, 14178.0, 9576.904230957602, 9648.469334186406, 9715.27135464857, 9735.123838854537, 9807.55865986018, 10610.89389106099, 10832.079273261546, 10841.241113122005, 10861.34831910088, 10895.073918716998, 6820.488463365366, 7504.0, 9258.675946341846, 9315.673951411669, 9344.065593440602, 9030.277577793891, 9066.909330906607, 9081.955575108947, 9183.0, 9239.538023098683, 8147.476096948347, 8197.959010204911, 8246.0, 8344.165583441607, 8357.871687322133, 5066.670666406671, 5231.633785634969, 6066.3023752269055, 6157.72290246931, 6204.441600255998, 5947.613405128825, 6171.691415429301, 6293.181886354744, 6331.810045698637, 6356.110144579855], "value": 5375.340408665395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3341600586858, 347.9617242103368, 358.8241761536848, 396.56377984217346, 406.06807377069623, 4519.005818719885, 5977.2528433945645, 6190.195274614305, 6206.689665516723, 6223.502119830408, 5140.408852981908, 5582.944170558293, 6025.397460253972, 6034.758609655609, 6046.12331211974, 3626.34725749365, 4324.891877703051, 4388.407564978719, 4422.535633758441, 4490.236659767847, 3262.2822978944714, 3638.8726394576197, 4079.796010199493, 4444.488883778358, 4479.260921947891, 4419.668524860632, 4426.358178064179, 4442.155990361837, 4444.466664000324, 4465.620422264095, 4280.3151495760685, 4362.716423432498, 4396.626286765629, 4407.531782201977, 4420.938974646094, 3791.165943492455, 3801.486799282089, 3803.5055442792536, 3813.122981714221, 3845.1925095729653, 5900.586958912878, 5902.911456328158, 5906.675132867691, 5923.348431672513, 5946.821595352147, 4876.756162191876, 5217.982493413786, 5263.368395792491, 5263.763130659129, 5322.680639161663, 5307.310049693515, 6095.6952152392205, 6130.17242672238, 6371.745130194787, 6486.135398451162, 3501.562304711911, 3957.8324394303463, 4083.224187404384, 4122.876313710593, 4178.435911151986, 4955.876103097416, 5618.213240362434, 6371.553991220617, 6660.9000864987065, 6933.479989000845, 4027.81874815634, 4049.9392509112386, 4417.4036505072045, 4445.17764213615, 4460.28635418338, 4033.69747268956, 4460.706395145371, 4515.751633660115, 4522.140793249272, 4549.7497637629585, 4254.638355739735, 4387.27609944362, 5084.796608135707, 5315.883664430513, 5360.705161216092, 5761.337446193657, 5943.197668314722, 6479.157709497735, 6509.609423434609, 6523.902141467882, 1522.3682171898758, 1538.9307481163376, 1540.4993377152246, 1543.984560154384, 1547.2341191110472, 960.3613596958085, 1019.6838979916249, 1025.2823023883311, 1025.917926565873, 1028.5422986770964, 6137.772445510826, 6155.861165684362, 6176.938230617726, 6202.0, 6212.875742485216, 5595.517187945198, 5877.647341159544, 6508.121403610547, 6811.93188068113, 6844.1444819397575, 5831.591788574759, 5867.911981320283, 6132.62016046386, 6138.232720909887, 6161.291451483047, 3485.9258741049034, 3515.648435156464, 3523.964760352415, 3526.4886591444097, 3538.522299489536, 6001.849953751103, 6556.967215163989, 6717.316270310974, 6754.5947243165565, 6828.951314605599, 6243.906341404882, 6895.827604309932, 6914.55055421396, 6941.375276225164, 6948.096747422803, 6238.3685623053125, 6338.619682818953, 6576.2766095730385, 6827.726890924506, 6888.173419189729, 4949.802007919643, 5688.630239034615, 6625.701843416961, 6677.43241824431, 6712.549919279525, 6040.879182416239, 6247.2199871058765, 6585.147688602221, 6600.537962342782, 6637.4690024798865, 6581.716565269727, 6766.289539598271, 6932.61870597122, 6951.6871740770775, 6977.79066628002, 3457.014750796011, 3906.4140378943384, 4378.277584198699, 4473.2842745160615, 4556.066006468733, 6492.38322359394, 6713.496487763339, 6791.758719622611, 6806.78779396708, 6813.8977915330315, 6417.93582064192, 6525.119108920235, 6532.216134063943, 6533.509986751108, 6662.0, 5962.493188078888, 6140.355262697352, 6277.874442511215, 6554.442872355903, 6565.868682626417, 5128.486986414318, 6138.539609529393, 6459.773907913201, 6463.903041454288, 6486.767514172292, 5730.885382292247, 6339.175907132043, 6617.7683781067435, 6629.403353698191, 6641.203055633355, 6132.78535251264, 6362.650054246876, 6398.776042838478, 6401.119496226624, 6412.711427985659], "value": 4663.622056464187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.3490226247509, 843.59085843366, 861.3798065392918, 884.5930871798975, 886.9179600886915, 14423.5672929812, 15051.172185529791, 16474.50576482706, 16939.83060169398, 16988.320467181315, 17235.74146387805, 17563.91218043911, 17817.109144542785, 18059.187336569852, 18085.457436276934, 966.2125367825236, 1000.7948370584013, 1007.5919252702668, 1008.838585826268, 1009.9091081802636, 992.8758905136858, 1001.4492029383846, 1001.8246806808816, 1005.4218824176091, 1008.7982403519326, 1051.6529545250048, 1063.415121683075, 1064.4890452582765, 1067.4929408530925, 1068.4230515521608, 1039.8908114647966, 1053.210092430677, 1053.3890343600692, 1053.4258828938248, 1055.0504545908666, 645.2353960556709, 772.5557804262571, 782.9804254893617, 783.142459007386, 784.4508843809356, 16842.66314673712, 17226.138693065295, 17430.56423589408, 17438.47684569465, 17496.825031749646, 16592.83407165925, 16777.916110419494, 16989.0, 17242.396516121877, 17272.82727172725, 13791.793123103162, 13884.166949983033, 14116.50592229267, 14129.929350353284, 14163.645908852259, 3025.0, 3399.711024562915, 3456.5679290088738, 3461.3077384523194, 3464.7401444891734, 82160.58919705423, 97058.0, 122274.0, 123241.38379308136, 124246.0, 10538.57845686164, 11947.103967202494, 12175.817362739566, 12227.755444891052, 12404.379781010914, 17807.910960445115, 20913.47716307074, 20946.0, 21191.258305959218, 21198.0, 7477.4391920605085, 7748.7675369739, 7772.45592808498, 7780.260875216845, 7791.142974272825, 3727.3849814780256, 3798.734088613826, 3805.9048523786573, 3809.447630093621, 3811.5807261201244, 4290.656747460196, 4421.29259318514, 4456.197884380843, 4457.175422546839, 4459.420275364182, 934.3506263147184, 967.2407160379069, 969.1181025266973, 974.2985050763439, 977.4330888084894, 618.2611778924232, 624.0701354981046, 653.4054010850103, 664.8005598320581, 666.8896287680957, 11393.316401015965, 11748.58879939198, 11964.222325548986, 13051.934740326238, 13293.06948513614, 659.8911179655399, 668.7425341243559, 673.5888313982199, 674.750342373325, 706.1385110165693, 4941.579965702884, 5366.463353664681, 5630.211770352154, 5659.179418984224, 5709.885802283931, 96408.0, 99730.0, 99853.0, 99946.001079978, 102122.0, 87710.56144719236, 88407.0, 89163.0, 89272.5536372314, 91368.0, 80047.7992830108, 80625.59687201526, 80940.33417660707, 81066.59466702747, 81721.18278817135, 11101.611443599435, 11151.386673733023, 11535.711607209887, 12501.06242031833, 12966.09237353414, 39501.60498395094, 40080.59717909859, 40107.0, 40140.79929600333, 41378.37932430956, 58704.53238669068, 60768.0, 73544.16139596552, 73876.52246954924, 75787.0, 16583.50249492517, 16791.91604041972, 16954.74567881458, 16999.235034423233, 17122.058286793846, 18065.0, 18326.633467330845, 18370.1733421999, 18636.534086647942, 18730.250789968795, 16875.24061417264, 17207.795454318577, 17368.0, 17468.388606398716, 17509.0, 16724.916375418044, 16931.91534042322, 17006.0, 17062.0, 17124.914375428045, 16095.839041609903, 16344.509664710078, 16575.751363729312, 16625.334986600883, 16721.832781672514, 8697.695580654647, 10960.28758130719, 11241.325520468798, 11304.886951130713, 11410.258333208314, 11982.340971246666, 12789.232646041268, 12801.29592872401, 12824.358782061046, 12871.22772633645], "value": 8314.949341597478, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 156.0, 156.0, 116.0, 97.0, 96.0, 172.0, 167.0, 157.0, 131.0], "value": 135.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 148.0, 140.0, 134.0, 146.0, 157.0, 148.0, 116.0, 139.0, 117.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 279.0, 245.0, 201.0, 198.0, 200.0, 198.0, 204.0, 198.0, 200.0], "value": 214.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 59.0, 84.0, 63.0, 64.0, 50.0, 66.0, 93.0, 50.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 108.0, 70.0, 72.0, 72.0, 94.0, 58.0, 75.0, 97.0], "value": 84.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 122.0, 134.0, 99.0, 132.0, 90.0, 89.0, 89.0], "value": 102.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 105.0, 97.0, 96.0, 97.0, 96.0, 149.0, 97.0, 98.0, 99.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 90.0, 91.0, 92.0, 104.0, 90.0, 90.0, 89.0, 90.0, 112.0], "value": 99.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 56.0, 80.0, 89.0, 89.0, 90.0, 82.0, 59.0, 59.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 85.0, 87.0, 85.0, 81.0, 112.0, 104.0, 85.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 138.0, 137.0, 152.0, 151.0, 164.0, 144.0, 219.0, 155.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 190.0, 184.0, 193.0, 184.0, 209.0, 243.0, 195.0, 184.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 74.0, 102.0, 98.0, 98.0, 69.0, 84.0, 99.0, 101.0], "value": 86.2, "unit": "score"}]}]} 16:19:17 INFO - Return code: 0 16:19:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:17 ERROR - # TBPL SUCCESS # 16:19:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:17 INFO - 2017-04-18 16:19:17.413 screenresolution[1661:10647] starting screenresolution argv=screenresolution get 16:19:17 INFO - 2017-04-18 16:19:17.415 screenresolution[1661:10647] Display 0: 1600x1200x32@60 16:19:17 INFO - 2017-04-18 16:19:17.422 screenresolution[1662:10650] starting screenresolution argv=screenresolution list 16:19:17 INFO - Available Modes on Display 0 16:19:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:17 INFO - Intel Iris: 16:19:17 INFO - Chipset Model: Intel Iris 16:19:17 INFO - Type: GPU 16:19:17 INFO - Bus: Built-In 16:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:17 INFO - Vendor: Intel (0x8086) 16:19:17 INFO - Device ID: 0x0a2e 16:19:17 INFO - Revision ID: 0x0009 16:19:17 INFO - Displays: 16:19:17 INFO - Display: 16:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:17 INFO - Display Serial Number: 1600x1200 60 16:19:17 INFO - Main Display: Yes 16:19:17 INFO - Mirror: Off 16:19:17 INFO - Online: Yes 16:19:17 INFO - Rotation: Supported 16:19:17 INFO - Return code: 0 16:19:17 INFO - Running post-action listener: _resource_record_post_action 16:19:17 INFO - [mozharness: 2017-04-18 23:19:17.673459Z] Finished run-tests step (success) 16:19:17 INFO - Running post-run listener: _resource_record_post_run 16:19:17 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 40254464; Write bytes: 519105536; Read time: 390; Write time: 1852 16:19:17 INFO - TinderboxPrint: CPU usage
53.9% 16:19:17 INFO - TinderboxPrint: I/O read bytes / time
40,254,464 / 390 16:19:17 INFO - TinderboxPrint: I/O write bytes / time
519,105,536 / 1,852 16:19:17 INFO - TinderboxPrint: CPU idle
2,211.1 (46.1%) 16:19:17 INFO - TinderboxPrint: CPU system
958.7 (20.0%) 16:19:17 INFO - TinderboxPrint: CPU user
1,628.0 (33.9%) 16:19:17 INFO - TinderboxPrint: Swap in / out
249,040,896 / 0 16:19:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207972864; Write bytes: 206071808; Read time: 16287; Write time: 444 16:19:17 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35367936; Write bytes: 305824768; Read time: 356; Write time: 1379 16:19:18 INFO - Running post-run listener: _upload_blobber_files 16:19:18 INFO - Blob upload gear active. 16:19:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:18 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 16:19:18 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'] 16:19:18 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 16:19:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:19 INFO - (blobuploader) - INFO - Done attempting. 16:19:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:20 INFO - (blobuploader) - INFO - Done attempting. 16:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:20 INFO - (blobuploader) - INFO - Done attempting. 16:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:23 INFO - (blobuploader) - INFO - Done attempting. 16:19:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:23 INFO - Return code: 0 16:19:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbae1d363c60f311ba5fcad7a9d8401ce178153a31c8438bc7d1a24fa2119b99d575a61d8c9a3104510b21a5d8b7669d6577801a6282b79aacca4ff1cffcea38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301431701f6cd04a23ca0dff70578e16ffcd04524e8b7eb7bc217299765579ca74a605af17eb5e5c6d171c128714ae9fb950fd1892725c04815314f1a934b03d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7164a2f618ced51e36093f2b1dc29c99298addfc1d42c0a3b5de6c7ae3e3bfd3f5c72b24caa002231da3efbc2c29a96f5908a3d48e036ee9c641bcacbd1c56d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f90809838298c9c52344868780e4bdf4fa1a748b8ed75197b6915457785e50fbf7f263bce1e47c727c9b220d8316f3ac6c0438add4d8ac0f2a9572b4a9ffe6eb"} 16:19:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:23 INFO - Contents: 16:19:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbae1d363c60f311ba5fcad7a9d8401ce178153a31c8438bc7d1a24fa2119b99d575a61d8c9a3104510b21a5d8b7669d6577801a6282b79aacca4ff1cffcea38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301431701f6cd04a23ca0dff70578e16ffcd04524e8b7eb7bc217299765579ca74a605af17eb5e5c6d171c128714ae9fb950fd1892725c04815314f1a934b03d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7164a2f618ced51e36093f2b1dc29c99298addfc1d42c0a3b5de6c7ae3e3bfd3f5c72b24caa002231da3efbc2c29a96f5908a3d48e036ee9c641bcacbd1c56d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f90809838298c9c52344868780e4bdf4fa1a748b8ed75197b6915457785e50fbf7f263bce1e47c727c9b220d8316f3ac6c0438add4d8ac0f2a9572b4a9ffe6eb"} 16:19:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:23 INFO - Copying logs to upload dir... 16:19:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.731897 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-18 16:19:23.330757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:23.333873) ========= 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.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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/fbae1d363c60f311ba5fcad7a9d8401ce178153a31c8438bc7d1a24fa2119b99d575a61d8c9a3104510b21a5d8b7669d6577801a6282b79aacca4ff1cffcea38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301431701f6cd04a23ca0dff70578e16ffcd04524e8b7eb7bc217299765579ca74a605af17eb5e5c6d171c128714ae9fb950fd1892725c04815314f1a934b03d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7164a2f618ced51e36093f2b1dc29c99298addfc1d42c0a3b5de6c7ae3e3bfd3f5c72b24caa002231da3efbc2c29a96f5908a3d48e036ee9c641bcacbd1c56d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f90809838298c9c52344868780e4bdf4fa1a748b8ed75197b6915457785e50fbf7f263bce1e47c727c9b220d8316f3ac6c0438add4d8ac0f2a9572b4a9ffe6eb"} build_url:https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/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/fbae1d363c60f311ba5fcad7a9d8401ce178153a31c8438bc7d1a24fa2119b99d575a61d8c9a3104510b21a5d8b7669d6577801a6282b79aacca4ff1cffcea38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/301431701f6cd04a23ca0dff70578e16ffcd04524e8b7eb7bc217299765579ca74a605af17eb5e5c6d171c128714ae9fb950fd1892725c04815314f1a934b03d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7164a2f618ced51e36093f2b1dc29c99298addfc1d42c0a3b5de6c7ae3e3bfd3f5c72b24caa002231da3efbc2c29a96f5908a3d48e036ee9c641bcacbd1c56d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f90809838298c9c52344868780e4bdf4fa1a748b8ed75197b6915457785e50fbf7f263bce1e47c727c9b220d8316f3ac6c0438add4d8ac0f2a9572b4a9ffe6eb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:23.373496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:23.374102) ========= 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.xkal9xescL/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.U9I3NY2n92/Listeners TMPDIR=/var/folders/yw/zx37twqx21967_ygvr9fd2fr00000w/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.005305 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:23.427238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 16:19:23.427794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 16:19:23.428558) ========= ========= Total master_lag: 0.20 =========