builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0321 starttime: 1481298407.64 results: success (0) buildid: 20161209063524 builduid: abd3b647bf82491f95577e8b21b7e419 revision: 159f68a4533f2f2510a77ed964f8d997f9ba5d06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.641151) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.641645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.641947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.668539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.668952) ========= 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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 --2016-12-09 07:46:47-- 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% 7.93M=0.001s 2016-12-09 07:46:47 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.792778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.793213) ========= 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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.016952 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.840937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:47.841280) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 159f68a4533f2f2510a77ed964f8d997f9ba5d06 --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 159f68a4533f2f2510a77ed964f8d997f9ba5d06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 2016-12-09 07:46:47,908 truncating revision to first 12 chars 2016-12-09 07:46:47,908 Setting DEBUG logging. 2016-12-09 07:46:47,908 attempt 1/10 2016-12-09 07:46:47,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/159f68a4533f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 07:46:48,530 unpacking tar archive at: mozilla-central-159f68a4533f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.869399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:48.733856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:48.734173) ========= script_repo_revision: 159f68a4533f2f2510a77ed964f8d997f9ba5d06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:48.734560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:48.734824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:46:48.754090) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-12-09 07:46:48.754439) ========= /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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:46:48 INFO - MultiFileLogger online at 20161209 07:46:48 in /builds/slave/test 07:46:48 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 07:46:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:48 INFO - {'append_to_log': False, 07:46:48 INFO - 'base_work_dir': '/builds/slave/test', 07:46:48 INFO - 'blob_upload_branch': 'Firefox', 07:46:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:48 INFO - 'branch': 'Firefox', 07:46:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:48 INFO - 'config_files': ('talos/mac_config.py',), 07:46:48 INFO - 'default_actions': ('clobber', 07:46:48 INFO - 'read-buildbot-config', 07:46:48 INFO - 'download-and-extract', 07:46:48 INFO - 'populate-webroot', 07:46:48 INFO - 'create-virtualenv', 07:46:48 INFO - 'install', 07:46:48 INFO - 'run-tests'), 07:46:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:48 INFO - 'download_minidump_stackwalk': True, 07:46:48 INFO - 'download_symbols': 'ondemand', 07:46:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:48 INFO - 'installer_path': 'installer.exe', 07:46:48 INFO - 'log_level': 'info', 07:46:48 INFO - 'log_name': 'talos', 07:46:48 INFO - 'log_to_console': True, 07:46:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:48 INFO - 'opt_config_files': (), 07:46:48 INFO - 'pip_index': False, 07:46:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'run_cmd_checks_enabled': True, 07:46:48 INFO - 'sps_profile': False, 07:46:48 INFO - 'sps_profile_interval': 0, 07:46:48 INFO - 'suite': 'dromaeojs-e10s', 07:46:48 INFO - 'system_bits': '32', 07:46:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:48 INFO - 'title': 't-yosemite-r7-0321', 07:46:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:48 INFO - 'use_talos_json': True, 07:46:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:48 INFO - 'work_dir': 'build'} 07:46:48 INFO - [mozharness: 2016-12-09 15:46:48.953634Z] Running clobber step. 07:46:48 INFO - Running pre-action listener: _resource_record_pre_action 07:46:48 INFO - Running main action method: clobber 07:46:48 INFO - rmtree: /builds/slave/test/build 07:46:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:49 INFO - Running post-action listener: _resource_record_post_action 07:46:49 INFO - [mozharness: 2016-12-09 15:46:49.339532Z] Finished clobber step (success) 07:46:49 INFO - [mozharness: 2016-12-09 15:46:49.339724Z] Running read-buildbot-config step. 07:46:49 INFO - Running pre-action listener: _resource_record_pre_action 07:46:49 INFO - Running main action method: read_buildbot_config 07:46:49 INFO - Using buildbot properties: 07:46:49 INFO - { 07:46:49 INFO - "project": "", 07:46:49 INFO - "product": "firefox", 07:46:49 INFO - "script_repo_revision": "production", 07:46:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:46:49 INFO - "repository": "", 07:46:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:46:49 INFO - "buildid": "20161209063524", 07:46:49 INFO - "pgo_build": "False", 07:46:49 INFO - "basedir": "/builds/slave/test", 07:46:49 INFO - "buildnumber": 18, 07:46:49 INFO - "slavename": "t-yosemite-r7-0321", 07:46:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:46:49 INFO - "platform": "yosemite_r7", 07:46:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:46:49 INFO - "branch": "mozilla-central", 07:46:49 INFO - "repo_path": "mozilla-central", 07:46:49 INFO - "revision": "159f68a4533f2f2510a77ed964f8d997f9ba5d06", 07:46:49 INFO - "stage_platform": "macosx64", 07:46:49 INFO - "builduid": "abd3b647bf82491f95577e8b21b7e419", 07:46:49 INFO - "slavebuilddir": "test" 07:46:49 INFO - } 07:46:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 07:46:49 INFO - Running post-action listener: _resource_record_post_action 07:46:49 INFO - [mozharness: 2016-12-09 15:46:49.343887Z] Finished read-buildbot-config step (success) 07:46:49 INFO - [mozharness: 2016-12-09 15:46:49.344027Z] Running download-and-extract step. 07:46:49 INFO - Running pre-action listener: _resource_record_pre_action 07:46:49 INFO - Running main action method: download_and_extract 07:46:49 INFO - mkdir: /builds/slave/test/build/tests 07:46: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')]} 07:46:49 INFO - trying https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 07:46:49 INFO - Downloaded 1235 bytes. 07:46:49 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:46:49 INFO - Using the following test package requirements: 07:46:49 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 07:46:49 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 07:46:49 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 07:46:49 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'jsshell-mac64.zip'], 07:46:49 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 07:46:49 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 07:46:49 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 07:46:49 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 07:46:49 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 07:46:49 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:49 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 07:46:49 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 07:46:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 07:46:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 07:46:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 07:46:50 INFO - Expected file size: 16287323 07:46:50 INFO - Obtained file size: 16287323 07:46:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 07:46:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 07:46:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 07:46:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 07:46:58 INFO - Expected file size: 16287323 07:46:58 INFO - Obtained file size: 16287323 07:47:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 07:47:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 07:47:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 07:47:05 INFO - Expected file size: 14409734 07:47:05 INFO - Obtained file size: 14409734 07:47:05 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')]} 07:47:05 INFO - trying https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:47:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 07:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 07:47:07 INFO - Downloaded 69680872 bytes. 07:47:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:47:07 INFO - mkdir: /builds/slave/test/properties 07:47:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:07 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:07 INFO - Contents: 07:47:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:47:08 INFO - Running post-action listener: _resource_record_post_action 07:47:08 INFO - Running post-action listener: set_extra_try_arguments 07:47:08 INFO - [mozharness: 2016-12-09 15:47:08.179856Z] Finished download-and-extract step (success) 07:47:08 INFO - [mozharness: 2016-12-09 15:47:08.179961Z] Running populate-webroot step. 07:47:08 INFO - Running pre-action listener: _resource_record_pre_action 07:47:08 INFO - Running main action method: populate_webroot 07:47:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:08 INFO - '--tppagecycles', 07:47:08 INFO - '7'], 07:47:08 INFO - 'tests': ['tsvgm']}}, 07:47:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['damp', 'tps']}, 07:47:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'tests': ['damp', 'tps']}, 07:47:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['dromaeo_dom']}, 07:47:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['basic_compositor_video']}, 07:47:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['a11yr', 07:47:08 INFO - 'ts_paint', 07:47:08 INFO - 'tpaint', 07:47:08 INFO - 'sessionrestore', 07:47:08 INFO - 'sessionrestore_no_auto_restore', 07:47:08 INFO - 'tabpaint']}, 07:47:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['tsvgx', 07:47:08 INFO - 'tsvgr_opacity', 07:47:08 INFO - 'tart', 07:47:08 INFO - 'tscrollx', 07:47:08 INFO - 'cart', 07:47:08 INFO - 'tsvg_static']}, 07:47:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:08 INFO - 'tsvgr_opacity', 07:47:08 INFO - 'tart', 07:47:08 INFO - 'tscrollx', 07:47:08 INFO - 'cart', 07:47:08 INFO - 'tsvg_static']}, 07:47:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'talos_options': ['--disable-e10s'], 07:47:08 INFO - 'tests': ['tp5o']}, 07:47:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:47:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'talos_options': ['--disable-e10s', 07:47:08 INFO - '--xperf_path', 07:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:08 INFO - 'tests': ['tp5n']}, 07:47:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:47:08 INFO - 'talos_options': ['--xperf_path', 07:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:08 INFO - 'tests': ['tp5n']}}, 07:47:08 INFO - 'talos.zip': {'path': '', 07:47:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:08 INFO - Running post-action listener: _resource_record_post_action 07:47:08 INFO - [mozharness: 2016-12-09 15:47:08.198003Z] Finished populate-webroot step (success) 07:47:08 INFO - [mozharness: 2016-12-09 15:47:08.198135Z] Running create-virtualenv step. 07:47:08 INFO - Running pre-action listener: _resource_record_pre_action 07:47:08 INFO - Running main action method: create_virtualenv 07:47:08 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:08 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 07:47:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:08 INFO - Using real prefix '/tools/python27' 07:47:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:09 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:12 INFO - Installing pip.................done. 07:47:12 INFO - Return code: 0 07:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:47:12 INFO - Reading from file tmpfile_stdout 07:47:12 INFO - Output received: 07:47:12 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) 07:47:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:12 INFO - 'HOME': '/Users/cltbld', 07:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:12 INFO - 'LOGNAME': 'cltbld', 07:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:12 INFO - 'MOZ_NO_REMOTE': '1', 07:47:12 INFO - 'NO_EM_RESTART': '1', 07:47:12 INFO - 'PAGER': '/bin/cat', 07:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:12 INFO - 'PWD': '/builds/slave/test', 07:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:12 INFO - 'SHELL': '/bin/bash', 07:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:12 INFO - 'USER': 'cltbld', 07:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:12 INFO - 'XPC_FLAGS': '0x0', 07:47:12 INFO - 'XPC_SERVICE_NAME': '0', 07:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:12 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 07:47:12 INFO - Cleaning up... 07:47:12 INFO - Return code: 0 07:47:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:12 INFO - 'HOME': '/Users/cltbld', 07:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:12 INFO - 'LOGNAME': 'cltbld', 07:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:12 INFO - 'MOZ_NO_REMOTE': '1', 07:47:12 INFO - 'NO_EM_RESTART': '1', 07:47:12 INFO - 'PAGER': '/bin/cat', 07:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:12 INFO - 'PWD': '/builds/slave/test', 07:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:12 INFO - 'SHELL': '/bin/bash', 07:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:12 INFO - 'USER': 'cltbld', 07:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:12 INFO - 'XPC_FLAGS': '0x0', 07:47:12 INFO - 'XPC_SERVICE_NAME': '0', 07:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:12 INFO - Downloading/unpacking psutil>=3.1.1 07:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:16 INFO - Installing collected packages: psutil 07:47:16 INFO - Running setup.py install for psutil 07:47:16 INFO - building 'psutil._psutil_osx' extension 07:47:16 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 07:47:16 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 07:47:16 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 07:47:16 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 07:47:16 INFO - building 'psutil._psutil_posix' extension 07:47:16 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 07:47:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:47:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:47:16 INFO - ^ 07:47:16 INFO - 1 warning generated. 07:47:16 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 07:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:16 INFO - Successfully installed psutil 07:47:16 INFO - Cleaning up... 07:47:17 INFO - Return code: 0 07:47:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:47: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 mozsystemmonitor==0.3 07:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:17 INFO - 'HOME': '/Users/cltbld', 07:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:17 INFO - 'LOGNAME': 'cltbld', 07:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:17 INFO - 'MOZ_NO_REMOTE': '1', 07:47:17 INFO - 'NO_EM_RESTART': '1', 07:47:17 INFO - 'PAGER': '/bin/cat', 07:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:17 INFO - 'PWD': '/builds/slave/test', 07:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:17 INFO - 'SHELL': '/bin/bash', 07:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:17 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:17 INFO - 'USER': 'cltbld', 07:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:17 INFO - 'XPC_FLAGS': '0x0', 07:47:17 INFO - 'XPC_SERVICE_NAME': '0', 07:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:17 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 07:47:17 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 07:47:17 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 07:47:17 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 07:47:17 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 07:47:17 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 07:47:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:19 INFO - Installing collected packages: mozsystemmonitor 07:47:19 INFO - Running setup.py install for mozsystemmonitor 07:47:20 INFO - Successfully installed mozsystemmonitor 07:47:20 INFO - Cleaning up... 07:47:20 INFO - Return code: 0 07:47:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:20 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:20 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 07:47:20 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 07:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:20 INFO - 'HOME': '/Users/cltbld', 07:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:20 INFO - 'LOGNAME': 'cltbld', 07:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:20 INFO - 'MOZ_NO_REMOTE': '1', 07:47:20 INFO - 'NO_EM_RESTART': '1', 07:47:20 INFO - 'PAGER': '/bin/cat', 07:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:20 INFO - 'PWD': '/builds/slave/test', 07:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:20 INFO - 'SHELL': '/bin/bash', 07:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:20 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:20 INFO - 'USER': 'cltbld', 07:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:20 INFO - 'XPC_FLAGS': '0x0', 07:47:20 INFO - 'XPC_SERVICE_NAME': '0', 07:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:20 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:20 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 07:47:20 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 07:47:20 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 07:47:20 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 07:47:20 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 07:47:20 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 07:47:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:22 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 07:47:22 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 07:47:22 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 07:47:22 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 07:47:22 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 07:47:22 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 07:47:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:23 INFO - warning: no files found matching '*.txt' 07:47:23 INFO - no previously-included directories found matching 'build' 07:47:23 INFO - no previously-included directories found matching 'dist' 07:47:23 INFO - no previously-included directories found matching '.git*' 07:47:23 INFO - Installing collected packages: jsonschema, functools32 07:47:23 INFO - Running setup.py install for functools32 07:47:23 INFO - warning: no files found matching '*.txt' 07:47:23 INFO - no previously-included directories found matching 'build' 07:47:23 INFO - no previously-included directories found matching 'dist' 07:47:23 INFO - no previously-included directories found matching '.git*' 07:47:23 INFO - Successfully installed jsonschema functools32 07:47:23 INFO - Cleaning up... 07:47:23 INFO - Return code: 0 07:47:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:23 INFO - 'HOME': '/Users/cltbld', 07:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:23 INFO - 'LOGNAME': 'cltbld', 07:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:23 INFO - 'MOZ_NO_REMOTE': '1', 07:47:23 INFO - 'NO_EM_RESTART': '1', 07:47:23 INFO - 'PAGER': '/bin/cat', 07:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:23 INFO - 'PWD': '/builds/slave/test', 07:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:23 INFO - 'SHELL': '/bin/bash', 07:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:23 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:23 INFO - 'USER': 'cltbld', 07:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:23 INFO - 'XPC_FLAGS': '0x0', 07:47:23 INFO - 'XPC_SERVICE_NAME': '0', 07:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:23 INFO - Cleaning up... 07:47:23 INFO - Return code: 0 07:47:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:24 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')]} 07:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:24 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:24 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 07:47:24 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 07:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:24 INFO - 'HOME': '/Users/cltbld', 07:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:24 INFO - 'LOGNAME': 'cltbld', 07:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:24 INFO - 'MOZ_NO_REMOTE': '1', 07:47:24 INFO - 'NO_EM_RESTART': '1', 07:47:24 INFO - 'PAGER': '/bin/cat', 07:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:24 INFO - 'PWD': '/builds/slave/test', 07:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:24 INFO - 'SHELL': '/bin/bash', 07:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:24 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:24 INFO - 'USER': 'cltbld', 07:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:24 INFO - 'XPC_FLAGS': '0x0', 07:47:24 INFO - 'XPC_SERVICE_NAME': '0', 07:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:24 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 07:47:24 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 07:47:24 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 07:47:24 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 07:47:24 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 07:47:24 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 07:47:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:26 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 07:47:26 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 07:47:26 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 07:47:26 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 07:47:26 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 07:47:26 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 07:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:27 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 07:47:27 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 07:47:27 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 07:47:27 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 07:47:27 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 07:47:27 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 07:47:28 INFO - Downloading docopt-0.6.1.tar.gz 07:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:28 INFO - Running setup.py install for blobuploader 07:47:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:28 INFO - Running setup.py install for requests 07:47:28 INFO - Running setup.py install for docopt 07:47:28 INFO - Successfully installed blobuploader requests docopt 07:47:28 INFO - Cleaning up... 07:47:29 INFO - Return code: 0 07:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:29 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')]} 07:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:29 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')]} 07:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:29 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:29 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 07:47:29 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 07:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:29 INFO - 'HOME': '/Users/cltbld', 07:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:29 INFO - 'LOGNAME': 'cltbld', 07:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:29 INFO - 'MOZ_NO_REMOTE': '1', 07:47:29 INFO - 'NO_EM_RESTART': '1', 07:47:29 INFO - 'PAGER': '/bin/cat', 07:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:29 INFO - 'PWD': '/builds/slave/test', 07:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:29 INFO - 'SHELL': '/bin/bash', 07:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:29 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:29 INFO - 'USER': 'cltbld', 07:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:29 INFO - 'XPC_FLAGS': '0x0', 07:47:29 INFO - 'XPC_SERVICE_NAME': '0', 07:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-LWym6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5DX2QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-z2AVuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-tDdKW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-uqW6QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-vQ7aau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:29 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-g3CE2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fXEOoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-l1qX7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5gRg4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-na1lV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-4IoNo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KKjMle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xuEDNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xppnzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-EYyAOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:30 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-D0XIli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:31 INFO - Running setup.py install for manifestparser 07:47:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:31 INFO - Running setup.py install for mozcrash 07:47:31 INFO - Running setup.py install for mozdebug 07:47:31 INFO - Running setup.py install for mozdevice 07:47:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:31 INFO - Running setup.py install for mozfile 07:47:31 INFO - Running setup.py install for mozhttpd 07:47:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:31 INFO - Running setup.py install for mozinfo 07:47:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Running setup.py install for mozInstall 07:47:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Running setup.py install for mozleak 07:47:32 INFO - Running setup.py install for mozlog 07:47:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Running setup.py install for moznetwork 07:47:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:32 INFO - Running setup.py install for mozprocess 07:47:32 INFO - Running setup.py install for mozprofile 07:47:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:33 INFO - Running setup.py install for mozrunner 07:47:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:33 INFO - Running setup.py install for mozscreenshot 07:47:33 INFO - Running setup.py install for moztest 07:47:33 INFO - Running setup.py install for mozversion 07:47:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:33 INFO - Cleaning up... 07:47:33 INFO - Return code: 0 07:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:33 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')]} 07:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:33 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')]} 07:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:33 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:33 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 07:47:33 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 07:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:33 INFO - 'HOME': '/Users/cltbld', 07:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:33 INFO - 'LOGNAME': 'cltbld', 07:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:33 INFO - 'MOZ_NO_REMOTE': '1', 07:47:33 INFO - 'NO_EM_RESTART': '1', 07:47:33 INFO - 'PAGER': '/bin/cat', 07:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:33 INFO - 'PWD': '/builds/slave/test', 07:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:33 INFO - 'SHELL': '/bin/bash', 07:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:33 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:33 INFO - 'USER': 'cltbld', 07:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:33 INFO - 'XPC_FLAGS': '0x0', 07:47:33 INFO - 'XPC_SERVICE_NAME': '0', 07:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:33 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0ipNBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-gtc7ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jrrIjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-IZwRFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6W03DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NVFpO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-FAfyfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-IMMhEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-tKH6K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-VXAcDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:34 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)) 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:34 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-krkN3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:35 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NCHuxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-nvVKuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:35 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-P9CaAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:35 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-BfAPZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:35 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-U3L5kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:35 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-JYiAS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:35 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)) 07:47:35 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)) 07:47:35 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)) 07:47:35 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)) 07:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:38 INFO - Downloading blessings-1.6.tar.gz 07:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:38 INFO - Installing collected packages: blessings 07:47:38 INFO - Running setup.py install for blessings 07:47:38 INFO - Successfully installed blessings 07:47:38 INFO - Cleaning up... 07:47:38 INFO - Return code: 0 07:47:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:38 INFO - Reading from file tmpfile_stdout 07:47:38 INFO - Current package versions: 07:47:38 INFO - blessings == 1.6 07:47:38 INFO - blobuploader == 1.2.4 07:47:38 INFO - docopt == 0.6.1 07:47:38 INFO - functools32 == 3.2.3-2 07:47:38 INFO - jsonschema == 2.5.1 07:47:38 INFO - manifestparser == 1.1 07:47:38 INFO - mozInstall == 1.12 07:47:38 INFO - mozcrash == 1.0 07:47:38 INFO - mozdebug == 0.1 07:47:38 INFO - mozdevice == 0.49 07:47:38 INFO - mozfile == 1.2 07:47:38 INFO - mozhttpd == 0.7 07:47:38 INFO - mozinfo == 0.9 07:47:38 INFO - mozleak == 0.1 07:47:38 INFO - mozlog == 3.4 07:47:38 INFO - moznetwork == 0.27 07:47:38 INFO - mozprocess == 0.23 07:47:38 INFO - mozprofile == 0.28 07:47:38 INFO - mozrunner == 6.13 07:47:38 INFO - mozscreenshot == 0.1 07:47:38 INFO - mozsystemmonitor == 0.3 07:47:38 INFO - moztest == 0.7 07:47:38 INFO - mozversion == 1.4 07:47:38 INFO - psutil == 3.1.1 07:47:38 INFO - requests == 1.2.3 07:47:38 INFO - wsgiref == 0.1.2 07:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:38 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:38 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 07:47:38 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 07:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:38 INFO - 'HOME': '/Users/cltbld', 07:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:38 INFO - 'LOGNAME': 'cltbld', 07:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:38 INFO - 'MOZ_NO_REMOTE': '1', 07:47:38 INFO - 'NO_EM_RESTART': '1', 07:47:38 INFO - 'PAGER': '/bin/cat', 07:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:38 INFO - 'PWD': '/builds/slave/test', 07:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:38 INFO - 'SHELL': '/bin/bash', 07:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:38 INFO - 'USER': 'cltbld', 07:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:38 INFO - 'XPC_FLAGS': '0x0', 07:47:38 INFO - 'XPC_SERVICE_NAME': '0', 07:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 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)) 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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 0x105ac53f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a3b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f11cc9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, '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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 07:47:39 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 07:47:39 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 07:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:39 INFO - 'HOME': '/Users/cltbld', 07:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:39 INFO - 'LOGNAME': 'cltbld', 07:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:39 INFO - 'MOZ_NO_REMOTE': '1', 07:47:39 INFO - 'NO_EM_RESTART': '1', 07:47:39 INFO - 'PAGER': '/bin/cat', 07:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:39 INFO - 'PWD': '/builds/slave/test', 07:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:39 INFO - 'SHELL': '/bin/bash', 07:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:47:39 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:39 INFO - 'USER': 'cltbld', 07:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:39 INFO - 'XPC_FLAGS': '0x0', 07:47:39 INFO - 'XPC_SERVICE_NAME': '0', 07:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Running post-action listener: _resource_record_post_action 07:47:39 INFO - Running post-action listener: _start_resource_monitoring 07:47:39 INFO - Starting resource monitoring. 07:47:39 INFO - [mozharness: 2016-12-09 15:47:39.495924Z] Finished create-virtualenv step (success) 07:47:39 INFO - [mozharness: 2016-12-09 15:47:39.496902Z] Running install step. 07:47:39 INFO - Running pre-action listener: _resource_record_pre_action 07:47:39 INFO - Running main action method: install 07:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:39 INFO - Reading from file tmpfile_stdout 07:47:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:39 INFO - Reading from file tmpfile_stdout 07:47:39 INFO - Output received: 07:47:39 INFO - Usage: mozinstall [options] installer 07:47:39 INFO - Options: 07:47:39 INFO - -h, --help show this help message and exit 07:47:39 INFO - -d DEST, --destination=DEST 07:47:39 INFO - Directory to install application into. [default: 07:47:39 INFO - "/builds/slave/test"] 07:47:39 INFO - --app=APP Application being installed. [default: firefox] 07:47:39 INFO - mkdir: /builds/slave/test/build/application 07:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 07:48:01 INFO - Reading from file tmpfile_stdout 07:48:01 INFO - Output received: 07:48:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:48:01 INFO - Running post-action listener: _resource_record_post_action 07:48:01 INFO - [mozharness: 2016-12-09 15:48:01.862301Z] Finished install step (success) 07:48:01 INFO - [mozharness: 2016-12-09 15:48:01.862460Z] Running run-tests step. 07:48:01 INFO - Running pre-action listener: _resource_record_pre_action 07:48:01 INFO - Running main action method: run_tests 07:48:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:01 INFO - 2016-12-09 07:48:01.876 screenresolution[1976:279727] starting screenresolution argv=screenresolution get 07:48:01 INFO - 2016-12-09 07:48:01.879 screenresolution[1976:279727] Display 0: 1600x1200x32@60 07:48:01 INFO - 2016-12-09 07:48:01.885 screenresolution[1977:279730] starting screenresolution argv=screenresolution list 07:48:01 INFO - Available Modes on Display 0 07:48:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:02 INFO - Intel Iris: 07:48:02 INFO - Chipset Model: Intel Iris 07:48:02 INFO - Type: GPU 07:48:02 INFO - Bus: Built-In 07:48:02 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:02 INFO - Vendor: Intel (0x8086) 07:48:02 INFO - Device ID: 0x0a2e 07:48:02 INFO - Revision ID: 0x0009 07:48:02 INFO - Displays: 07:48:02 INFO - Display: 07:48:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:02 INFO - Display Serial Number: 1600x1200 60 07:48:02 INFO - Main Display: Yes 07:48:02 INFO - Mirror: Off 07:48:02 INFO - Online: Yes 07:48:02 INFO - Rotation: Supported 07:48:02 INFO - Return code: 0 07:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:02 INFO - Python 2.7.3 07:48:02 INFO - Return code: 0 07:48:02 INFO - grabbing minidump binary from tooltool 07:48: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')]} 07:48:02 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 0x1058dad30>, '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 0x105741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:02 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 07:48:02 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 07:48:02 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 07:48:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:02 INFO - Return code: 0 07:48:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:48:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:48:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:02 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/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 07:48:02 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/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 07:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8ejc43G0a/Render', 07:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:02 INFO - 'HOME': '/Users/cltbld', 07:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:02 INFO - 'LOGNAME': 'cltbld', 07:48:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:02 INFO - 'MOZ_NO_REMOTE': '1', 07:48:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:02 INFO - 'NO_EM_RESTART': '1', 07:48:02 INFO - 'PAGER': '/bin/cat', 07:48:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:02 INFO - 'PWD': '/builds/slave/test', 07:48:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:02 INFO - 'SHELL': '/bin/bash', 07:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaiN5Nm0Q/Listeners', 07:48:02 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 07:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:02 INFO - 'USER': 'cltbld', 07:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:02 INFO - 'XPC_FLAGS': '0x0', 07:48:02 INFO - 'XPC_SERVICE_NAME': '0', 07:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:02 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/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 07:48:02 INFO - mozversion application_buildid: 20161209063524 07:48:02 INFO - mozversion application_changeset: 159f68a4533f2f2510a77ed964f8d997f9ba5d06 07:48:02 INFO - mozversion application_display_name: Nightly 07:48:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:02 INFO - mozversion application_name: Firefox 07:48:02 INFO - mozversion application_remotingname: firefox 07:48:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:48:02 INFO - mozversion application_vendor: Mozilla 07:48:02 INFO - mozversion application_version: 53.0a1 07:48:02 INFO - mozversion platform_buildid: 20161209063524 07:48:02 INFO - mozversion platform_changeset: 159f68a4533f2f2510a77ed964f8d997f9ba5d06 07:48:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:48:02 INFO - mozversion platform_version: 53.0a1 07:48:02 INFO - using testdate: 1481298482 07:48:02 INFO - actual date: 1481298482 07:48:02 INFO - starting webserver on 'localhost:49305' 07:48:02 INFO - SUITE-START | Running 2 tests 07:48:02 INFO - TEST-START | dromaeo_css 07:48:02 INFO - operating with platform_type : mac_ 07:48:02 INFO - Initialising browser for dromaeo_css test... 07:48:02 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpuBsHiM/profile http://localhost:49305/getInfo.html) 07:48:05 INFO - PROCESS | 1987 | 2016-12-09 07:48:05.622 plugin-container[1991:279897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 07:48:05 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:05 INFO - PROCESS | 1987 | 2016-12-09 07:48:05.625 plugin-container[1991:279897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 07:48:05 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:05 INFO - PROCESS | 1987 | 2016-12-09 07:48:05.625 plugin-container[1991:279897] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:05 INFO - PROCESS | 1987 | __metrics Screen width/height:1600/1200 07:48:05 INFO - PROCESS | 1987 | colorDepth:24 07:48:05 INFO - PROCESS | 1987 | Browser inner width/height: 1024/689 07:48:05 INFO - PROCESS | 1987 | __metrics 07:48:05 ERROR - PROCESS | 1987 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 07:48:06 INFO - TEST-INFO | 1987: exit 0 07:48:06 INFO - Browser initialized. 07:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:06 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpuBsHiM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:08 INFO - PROCESS | 1992 | 2016-12-09 07:48:08.945 plugin-container[1993:280015] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:48:08 INFO - PROCESS | 1992 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:08 INFO - PROCESS | 1992 | 2016-12-09 07:48:08.946 plugin-container[1993:280015] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 07:48:08 INFO - PROCESS | 1992 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:08 INFO - PROCESS | 1992 | 2016-12-09 07:48:08.946 plugin-container[1993:280015] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:18 INFO - PROCESS | 1992 | RSS: Main: 236716032 07:48:18 INFO - PROCESS | 1992 | 07:49:08 INFO - PROCESS | 1992 | 1481298548303 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:51:23 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49305/tests/dromaeo/cssquery-ext.html) 07:51:24 INFO - PROCESS | 1992 | RSS: Main: 251781120 07:51:24 INFO - PROCESS | 1992 | 07:54:27 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-ext.html (next: http://localhost:49305/tests/dromaeo/cssquery-jquery.html) 07:54:27 INFO - PROCESS | 1992 | RSS: Main: 264298496 07:54:27 INFO - PROCESS | 1992 | 07:57:29 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49305/tests/dromaeo/cssquery-mootools.html) 07:57:30 INFO - PROCESS | 1992 | RSS: Main: 270807040 07:57:30 INFO - PROCESS | 1992 | 08:00:32 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49305/tests/dromaeo/cssquery-prototype.html) 08:00:33 INFO - PROCESS | 1992 | RSS: Main: 270098432 08:00:33 INFO - PROCESS | 1992 | 08:03:36 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49305/tests/dromaeo/cssquery-yui.html) 08:03:36 INFO - PROCESS | 1992 | RSS: Main: 274071552 08:03:36 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-yui.html (next: http://localhost:49305/tests/dromaeo/cssquery-dojo.html) 08:06:39 INFO - PROCESS | 1992 | RSS: Main: 277229568 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | __start_tp_report 08:06:39 INFO - PROCESS | 1992 | _x_x_mozilla_page_load 08:06:39 INFO - PROCESS | 1992 | _x_x_mozilla_page_load_details 08:06:39 INFO - PROCESS | 1992 | |i|pagename|runs| 08:06:39 INFO - PROCESS | 1992 | |0;dojo.html;3347.9497807532907;3383.813890236037;3417.4019546579343;3419.965800341997;3421.1618153552367;4980.203167493201;5389.056915039867;5593.440655934404;5677.403872593381;5743.827685169441;5572.721363931808;5633.15502674599;5693.715314234292;5706.1726049722765;5733.971330143354;4251.404803327537;5120.487951204868;5220.973895130519;5264.473552644724;5282.2076688496645;5160.716160611165;5239.790408383679;5289.814856480024;5293.073712100387;5324.440933701963;5285.735713214343;5309;5309.256704061435;5311.176767601009;5324.76038578263;5116;5125.84622461323;5131.332926719502;5163.7159956202395;5240.973795131;5190.06578815813;5204.4535323791215;5217.530422261977;5238.423773384925;5257.684538927677;5517.586181036399;5654.575906806965;5660.235868157787;5730.598858079936;5763.4812866842185;6102.237220347457;6144.262688477366;6169.413905678954;6255.374462553708;6257.8748425031245;6204.193454850885;6229.781957631461;6231.501479881644;6233.940230160883;6246.500279977591;5836.854078648068;5840.620359676607;5872.383399743051;5902.6163299385835;5902.852428689274;5917.84602002614;6139.416755408229;6276.623402595859;6281.905771413432;6296.433321001132;6039.63762174271;6043;6105.399096011471;6191.442770150708;6213.96893015532;6141.332587233735;6234.812955611248;6234.844128896723;6273.435390814849;6288.434040936338;5893.705314734246;6107.877842443215;6229.4082062204925;6275.34108918557;6276.780312689034;5830.62100963436;6164.753409863645;6185.195924529872;6276.058591211264;6282.1519094921605;4822.541858523435;4839.2983017462275;4849.199882019428;4913.533214344631;4941.975290123526;3689.3728066228805;4362.17118747437;4372.300431930876;4432.49026361966;4443.37792709021;5888.234529511222;5892.96873047215;5893.381194974551;5904.232449781501;5959.910601340984;5620.690862002547;5776.855578610484;6252.624842509464;6262.279837818618;6293.811185664437;5655.915161272502;5662.5753068520025;5675.82972510817;5840.211571437886;5845.678487683133;4840.34655321527;5051.722155281422;5341.839744807662;5365.946340536545;5436.130219164915;5830.271216097988;5831.096180092092;6326.114343991753;6333.1766870306565;6369.840753981095;6175.876482470236;6278.4035516625845;6306.810795676137;6307.621542707452;6311.400416960381;6206.317305096345;6206.410391012847;6206.658633775186;6235.220597425322;6243.875122497434;6186.597871138541;6197.287311959002;6197.845053873689;6208.906866397098;6214.5960512566535;6211.130441738251;6238.968805155945;6244.500439964701;6249.750009999549;6255.093011513214;5559.44405559457;5594.384617692132;5941.079132734433;5962.55280853929;6033.42682445167;6066.393360663898;6095;6095.420935011167;6136.478399335928;6169.907451388143;5783.508401785895;5816.709164541671;5867.794627188028;5881.235439392852;5974.103884417372;6054.757809687563;6061.121137435135;6080.969595151996;6091;6094.268687757498;5796.478316951326;5876.294844618673;5912.586118971631;5915.142304365757;5937.109433584824 08:06:39 INFO - PROCESS | 1992 | |1;ext.html;434.14473487230157;473.33732774116254;485.2381760635802;488.78982037723785;502.41217775203006;37664.87005389836;39734.801325993365;39839.40240896389;39965.60034399655;40015.599844001554;39963;40281.798591007006;40286.7985660072;40296.79851600738;40401.59598404022;8331.750047498585;8528.744137675849;9226.215771659401;9457.668981585646;9493.288003399739;9089.954550227272;11429.199956003084;11473.139514536444;11600.535978560847;11611.941940290286;11244.550217991271;11312.547498100108;11327.32036077838;11343.489542970545;11361.829572556418;11414.258073225255;11418.371989540572;11466;11476.655700329004;11513.827292590535;11312.94343528277;11364;11365.147613928988;11371;11379.487923043484;38681.80659096715;39066.21867562661;39130.02174945621;39142;39222.80388598067;3366.1752870546875;3383.8646454141804;3405.3189362127428;3427.503012063262;3496.965030349689;24001.51996960051;25289.229753917232;29540.556891646644;30176.54735178974;30323.090307290815;3031.4694928387667;3046.31457921968;3060.8010479318773;3092.58250136231;3104.8602812873473;383638;448676;452224;453432.732836337;453496;55393.44606553963;55558.444415556136;55560.16659750107;55660.44339556633;55792;56758.43241567614;56834.431655683744;56969.7151514248;57211;57346;13164;15556.688866222612;15730.842691573167;15806.68386632261;15904.920475397548;10986.505607247533;11299.039581635489;12071.094667899943;12241.816372754416;12327.753444931051;14797.556073317817;14933.477328293458;14937.25313734309;14940.701185976219;15152.696946061238;5227.373774209776;5500.339959204921;5924.763009479572;6226.62640241587;6231.563790534619;859.6260626627437;962.1436921140051;986.2405947420447;1014.3558840136419;1037.818381783185;27513.587296190573;28229;28498.857505712753;29230.415391692048;29250.561241581392;953.2945620240972;985.1970643925179;987.4568987057233;1037.0770014686934;1049.981517927609;12622.727908976289;12729.55446559366;14840.257987100602;15164.848351516564;15230.238488075553;587360;588343;590303;596644;597480;55176.310013648486;55489;55541.44458555443;55571.166432503545;55580.72209638926;1363.7340718559983;1395.3720825628507;1419.4676996126452;1421.7511935411262;1425.9358328875226;28047.298817529725;28110.08073587155;28197.859010704815;28778.71221287844;28910;47182.528174717816;47358.52641473541;47384.7630761844;47472.2879156806;47631.04737905292;458195.70902145276;459632;460708;461221;461253;22932.770672293063;23720.288391348287;23734;24357.14749983742;37746;38781.6121838778;39174;39303.80348098241;39423.817285481484;39627.45215669751;32675.529601167527;33201.83399082989;33342.833285834386;33677.831610841786;34375;32836.34327313488;33002.51488683063;33661;33759.83120084384;34478.310433790684;29952.101436956928;31235.843820780752;33123.33753324968;33247.335053299284;33264.00207993764;28494;29955.101346959626;30118.007449438475;30140.84929575426;30683.693163068976;21527.35417937402;22627.547449051257;23183.07267709273;23442.882785586644;23524.823758812334 08:06:39 INFO - PROCESS | 1992 | |2;jquery.html;359.4464524632067;369.2670049950849;377.1739889641685;377.20786348667804;401.36984933654173;17687.55781105473;18564.25742970281;19868.90065549674;19984.902340137265;20120.698189527167;11645.825312620296;11742.295462272248;11982.281063136217;11998.82001769972;12024.398780061005;4965.801367945287;5246.554042906358;5300.443453437391;5358.678479291236;5372.811951581676;3839.5008648875605;4056.3509838425857;4554.43069616298;5321.893562128756;5369.865753356178;4029.7783621900785;6473.446372870524;6502.869942601145;6559.9672001640165;6580.473562115043;6540.901886471706;6543.476521878239;6549.574277671936;7262.491625586211;7669.501482403626;7180.7845764627145;7450.627468626547;7539.660715267826;7548.509346892434;7554.131274903347;24302.270931872074;24670.753292467027;24856.3785905352;25092;25293.367665808317;2444.963325550118;2480.8139389545677;2522.798176145904;2878.7553057990094;2990.551417287424;15664.765028524582;16245.756313655305;16402.917985409997;16473.34106635733;16656.50030499087;1566.6631674190103;1916.4250724782648;1959.715841203032;1985.6723640599284;2009.6081264153495;130872;139490;144264.278678607;145008;145695;17303.442690157946;20521.943659585686;20891.37325880226;21355.572888542454;21374.893125534272;34384;34798.13004674904;34947.30105397878;34995.825020874734;35007.124821879144;8553.61508732096;10334.741631459123;10611.893881061245;10742.194335424874;10926.945365273123;7100.46746494015;7467.663955122032;8681.869771953427;8760.539586863153;8961.865572016424;7812.804679883048;9392.906070939203;9511.524423778783;9557.761055973657;9588.37675551087;3197.6322722886703;3715.9442608360355;3825.5600605930676;3834.539855217392;3853.7109716771356;839.5802098950525;885.93798434109;933.8739270198437;960.2222200017868;1019.6227395863579;19173.520661983563;19748.802511974984;19993.300234492013;20024.199032038847;20641;757.874556283918;788.5978151142958;828.2380210206625;886.6320477002101;946.7822400847843;10054.64808731691;10555.63055293061;10591;10648.680539583826;10730.141588672888;548623;585538;588717;595301;602186.9781302131;95826;116382;117218;120005;132588;378.0774909221491;416.7312083705993;447.65754198038525;447.97088189267595;449.1645539296905;10592.89407105919;10962.506687199255;11355.829662554903;11579.610446746445;11713.88286117128;48334.27498587454;49615.75192124161;50457.73855653638;51900.96198076093;52956.73521632367;72360;75456;76226;77575.2242477568;78013.43973120619;7494.5503269803985;7657.115577789483;7914.802129946797;7980.720674776355;8095.635696393559;7731.574763388067;10347.379157250589;10596.576136954436;11760.411979401168;12228.816567751313;8158;10524.842127368249;10613.522391492246;10672.146228301872;10675.46622668879;9991.25065620067;10138.898611013796;10305;10337.534810933375;10597;10252.794944101226;10487.94756026215;10721.678349649523;10788.190885683449;11057.447127643425;7712.958750568826;7943.642536086006;7983.081945576333;8036.196380361917;8105.797355066171;9489.715308540755;10633.308834925705;10672.30630009047;10735.677929662123;10813.67558973232 08:06:39 INFO - PROCESS | 1992 | |3;mootools.html;1271;1500.6698526324208;1669.9248533815985;1864.8787828791128;1868.3647559829656;7457.552546847193;7761.534307941528;8004.559749213791;8438.071812100672;8457.534835584049;7936;8221.506709597428;8231.547264900428;8338.874916876237;8344.91655083449;2267.852589581676;2306.8039216666602;2307.7692230776956;2310.699609050821;2316.918907838226;2307.8384513084093;2325.813934885205;2344.4842134730416;2348.3307257431634;2349.9882500587473;1785.9285628574842;2272.36373815332;2315.4442933695877;2316.085146367184;2317.142657216824;2259.9209027684033;2265.864048157116;2274.3972847195423;2289.6222123349626;2292.2321022457495;1974.2004488182308;2301.6547517872286;2315.386422598013;2325.5348930214027;2331.80179684727;8259.174082591753;8310.958445207796;8312;8318.209770071833;8363.372747043935;4951.900961980777;5140.1518749406305;5148.716820574867;5152.175651895679;5173.76718047685;3132.8120312781307;3254.560634314361;3372.3592517421857;3389.440742277521;3397.8470968806464;1024.774549599087;1047.0471870597796;1062.8671416072991;1062.9946850265776;1068.6259809066842;10369.48152592375;10724.142068634568;10731.302465339806;10740.194485413625;10742.248042637018;4200.075983283673;4296.441462609903;4362.432883725095;4391.824327026947;4405.339199120158;8538.316934645338;8600.268977137013;8615.353848461391;8633.093525179891;8633.352498562634;4980.5019498049905;5044.621653376012;5045.495450454999;5048.722320272347;5064.822731204464;3396.796192228425;3663.5970043295215;3807.5240594925635;4383.364412160219;4709.8351557696005;3017.7887547871437;3562.4656301554974;3605.8197090145914;3666;3700.703943684499;1128.966131016071;1142.3831131189065;1144.1476100305326;1152.1013609384527;1158.8030034894089;707.3421717802493;807.8909347238048;879.2482427524502;889.3330002498126;897.9057198994011;5127.720056355205;5333.173358129496;5456.508914197741;5590.105583106683;5602.915956260659;433.6725772042088;433.9674524410682;436.1821584529008;437;437.4073130907638;3673.779573225615;3729.1050147964834;3770.792606406619;3779.508663873679;3809.2000679857542;9524.809503809885;9981.351212171186;9991;10007.799844003224;10011.79976400468;9944;9949.204063674888;9966.2525310602;9971.601135954626;9986.051325124101;7426;7671.273963358311;7711.151773304932;7861.567613781297;7891.565963871927;4929.950700492949;5263.526282634582;5309.946900530946;5378.5966052547;5484.862878428071;9322.766930826783;9358.81282374335;9366.157045865904;9366.531673416439;9382.296327775308;7795.922040779519;9353;9361.765955851159;9468.763280917756;9581.664641737505;6573.408393244631;6623.437007854193;6674.799756007327;6682.899756503753;6716.361945615159;7652.885206721792;7702.383809295131;7787.338076263354;7800.648970796215;7806.531608103532;7081.964590177016;7121.181064177686;7122.038524799293;7139;7146.3568278855155;6828.624425656438;6922.169339679271;6935.653217339012;6963.025176475398;7039.859202816017;6382.425581697669;6541;6542.411182993554;6553.377429144223;6586.341365863567;4565.406497155349;4640.234361330343;4692.1084993851055;4753.524647535219;4793.161196790478;4593.173228818845;4626.706633339051;4770.022145460103;4771.570558649738;4868.926966095441 08:06:39 INFO - PROCESS | 1992 | |4;prototype.html;352.53289391556194;359.05926472641664;359.5326076101068;362.48527091530025;369.41816638793904;4323.697341186118;4376.49670287917;4493.52817954115;5265.684058956461;5302.469753024696;4580.519045500216;5236.73816309184;5260.868478288045;5336.6531175473565;5337.519623233918;3984.721069525134;4069.552349241581;4102.5897410258885;4179.895502612429;4243.32106862902;3462.688358047775;4184.351425529047;4203.600657937491;4219.810108545107;4223.282042052859;3833.884983450487;3851.345271303885;3926.4699265599206;4152.667786577082;4169.041120542277;3212.518122281653;3464.896053118398;3929.82315795787;4051.7163798534116;4064.4512990746166;3639.508666330038;3645.3620616392027;3672.3389789838084;3697.186618943828;3731.794751288678;5246.186841039645;5247.16045432729;5254.31693879797;5258.474152584749;5284.81503147388;4484.461864576239;4813.831515896927;4851.757412129379;4855.126077306083;4884.438289596706;5049.576203422378;5478.863028424282;5506.834794956118;5699.629524080921;5709.4290570942985;3425;3838.596947320547;4085.673146148301;4100.2414553307435;4107.9178416431505;4696.906061878777;5056.342675452204;5988.814082859768;5995;5997.550183736237;3998.260321840469;4112.424260603518;4140.4617399738445;4168.270552653274;4186.68599855006;3365.5793025871767;4242.469691288589;4248.681348898783;4251.80866860992;4258.084511829971;4825.927611085836;4831.613470922318;4833.975830120827;4853.635977301717;4860.927086093711;5325.786968521294;5427.83716488506;5542.196381524656;5625.184348269478;5753.3958934311295;1360.9180701342457;1368.206440264644;1380.5099189787682;1384.5015794314038;1386.3622733542481;837.5477242289218;925.1997022575558;980.6959842448864;983.4099540275778;989.1740396768635;4468.597826195658;4498.987727761293;4815.518448155157;5078.21287700407;5122.359705036871;4556.498785133633;4926.950730492721;4945.727984960861;5598.104303311532;5618.174093419655;4129.357211384716;4465.6427485801705;4673.462551806586;4777.031886837719;4878.487758785347;2497.825152239362;2558.846469211853;2596.350912271932;2825.8587070646386;2885.994234007345;5026.371703537058;5294.067665302214;5325.041492531304;5663.433656634304;5738.82354117405;4543.137313701367;5165.398726394829;5549.834534747667;5603.719814009283;5637.661740295595;4958.603311734981;5449.455054494598;5629.831105066773;5797.507211886952;5807.274090738658;4560.863174104782;5126.923096153486;5277.630565860353;5426.430224826494;5572.62855972131;4866.464688884149;5241.324753755285;5352.421035794372;5380.650257733235;5387.973060134675;4848.490908454562;4867.926981095357;5215.061288968022;5688.890666320193;5694.743736531783;3568.946465803067;4108.609682080198;4136.400221967858;4173;4183.698965568864;5251.894962100813;5383.111786555174;5594.1608758686525;5773.624714393551;5852.297724273115;4578.5421457853945;4765.927666275061;5163.66436181647;5422.457754224546;5518.751656175562;5541.2796336476;5545.7781688732;5601.411851755507;5611.6352437091455;5633.6619802811965;4794;4814.807407703653;5452.700101494456;5543.752655652446;5553.750081246434;4328.2425575524785;5431.646942948696;5582.692951887523;5657.519110875622;5665.49010589049;5207.817726379559;5419.051665958363;5436.592255580768;5467.015937131196;5493.890122197614 08:06:39 INFO - PROCESS | 1992 | |5;yui.html;709.1525626875886;738.6085374751382;771.3636250093667;775.6276987046218;823.1357075071178;14497;15476.380944762195;15582.844171558281;15634.765478517831;15639.218039098043;14099.647508812284;14210.289485525735;14229.857701422983;14242.786358204608;14251.643708907282;685.266764561919;707.2079271216245;846;848.1433751910569;868.9435186712875;863.9611217495228;873.838339907116;876.9298456123495;877.4910551879926;879.3141349747208;937.1097457415449;938.6198589571235;940.3652534539193;942.5993952570165;942.8350038743226;922.5110691333604;931.5435436636034;932.1470854168496;934.2012579244749;934.63082082577;687.5153017122916;691.2499937567745;692.0829900382014;692.1106378303855;695.405428358751;14060.367283472267;14217.857821421756;14314.284285785774;14784.408623655041;14787.11277323364;14108.153510789385;14429.92785036068;14468.49360272396;14506.564803055926;14539.127652340894;11741.941290293495;11780.882191178065;11795.29228246308;11817.645470635895;11955.282683039046;3650.9269814603826;3674.2651469705897;3686.318031164243;3707.536557930259;3821.9426708599394;78334;106651.46674266578;110000.4499977503;110547.89452105456;111627;10888.346699197915;10903.34579925207;10904.672859814218;10909.890901091047;11356.615110826653;22773.544529109324;23002.53994920126;23027.194048208232;23114.306570802903;23237.76762232356;7615.809604759815;7660.233976602295;7732.342750866239;7813.179616140337;7840.3727701784865;3623.8006909620226;3776.527934008249;4286.464191976003;4392.9121417572105;4473.865784026484;2696.21809675192;3166.857491412892;3295.47272436409;3529.9294014119573;3635.5455568053994;616.9413905678954;631.119588174494;634.4195061518751;645.9289478157399;649.8212991427396;633.2875515045574;655.8032590222914;663.2074670768385;678.6633412494166;687.8796210663114;8814;9118.498482583389;9264.814703705888;9322.906770932339;9329.673461428818;556.6993823335354;569.831899589622;670.4401824476519;679.7722762874394;683.2245401469368;4437.134758722018;4484.68607197493;4512.4133862597655;4519.502854685982;4622.537746225351;90299;93110;94770.52614736882;96182;108334;80869.59565202254;81174;81207.84901887264;86871.56564217138;87270.12729872747;74706.00577497612;77186.2281377179;77410;77538.6123069381;77793.05517361998;9704.320697551386;9828.26288028415;9841.994574964114;9875.555599997873;9922.206223501958;37334.62665373312;48160.27759583679;50432;50499;50875.23687144622;60833.39166608454;64839.67580162069;68481.97277040749;69656.30343696498;70284.29715702777;12188.51245950152;12665.303408312631;12864.356782161041;13015.958723301923;13222.933885330513;13272.402741876831;13426.328683565587;13607.591772246848;13921.025528213333;14075.788863166856;13045.412956416794;13055.151415157985;13253.602391928258;13412.262325572186;13618.455261789417;13183.67040823987;13388.129771565207;13514.05401621877;13756.587302380945;14054.78917816254;13001.934990325366;13128.60614181576;13327.133736307109;13802.723945521235;13856.86143138596;11340.623329653605;11501.482433290355;11526.59656912004;11568.13239007061;11816.70458238551;10750.95990713453;11315.547378104784;11387.259828111146;11487.712807179887;11590.188686791844 08:06:39 INFO - PROCESS | 1992 | __end_tp_report 08:06:39 INFO - PROCESS | 1992 | __start_cc_report 08:06:39 INFO - PROCESS | 1992 | _x_x_mozilla_cycle_collect,368 08:06:39 INFO - PROCESS | 1992 | __end_cc_report 08:06:39 INFO - PROCESS | 1992 | __startTimestamp1481299599901__endTimestamp 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | ------- Summary: start ------- 08:06:39 INFO - PROCESS | 1992 | Number of tests: 6 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#0] dojo.html Cycles:165 Average:5702.08 Median:5892.97 stddev:650.41 (11.0%) stddev-sans-first:625.64 08:06:39 INFO - PROCESS | 1992 | Values: 3347.9 3383.8 3417.4 3420.0 3421.2 4980.2 5389.1 5593.4 5677.4 5743.8 5572.7 5633.2 5693.7 5706.2 5734.0 4251.4 5120.5 5221.0 5264.5 5282.2 5160.7 5239.8 5289.8 5293.1 5324.4 5285.7 5309.0 5309.3 5311.2 5324.8 5116.0 5125.8 5131.3 5163.7 5241.0 5190.1 5204.5 5217.5 5238.4 5257.7 5517.6 5654.6 5660.2 5730.6 5763.5 6102.2 6144.3 6169.4 6255.4 6257.9 6204.2 6229.8 6231.5 6233.9 6246.5 5836.9 5840.6 5872.4 5902.6 5902.9 5917.8 6139.4 6276.6 6281.9 6296.4 6039.6 6043.0 6105.4 6191.4 6214.0 6141.3 6234.8 6234.8 6273.4 6288.4 5893.7 6107.9 6229.4 6275.3 6276.8 5830.6 6164.8 6185.2 6276.1 6282.2 4822.5 4839.3 4849.2 4913.5 4942.0 3689.4 4362.2 4372.3 4432.5 4443.4 5888.2 5893.0 5893.4 5904.2 5959.9 5620.7 5776.9 6252.6 6262.3 6293.8 5655.9 5662.6 5675.8 5840.2 5845.7 4840.3 5051.7 5341.8 5365.9 5436.1 5830.3 5831.1 6326.1 6333.2 6369.8 6175.9 6278.4 6306.8 6307.6 6311.4 6206.3 6206.4 6206.7 6235.2 6243.9 6186.6 6197.3 6197.8 6208.9 6214.6 6211.1 6239.0 6244.5 6249.8 6255.1 5559.4 5594.4 5941.1 5962.6 6033.4 6066.4 6095.0 6095.4 6136.5 6169.9 5783.5 5816.7 5867.8 5881.2 5974.1 6054.8 6061.1 6081.0 6091.0 6094.3 5796.5 5876.3 5912.6 5915.1 5937.1 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#1] ext.html Cycles:180 Average:62602.02 Median:33303.42 stddev:133837.08 (401.9%) stddev-sans-first:134131.14 08:06:39 INFO - PROCESS | 1992 | Values: 434.1 473.3 485.2 488.8 502.4 37664.9 39734.8 39839.4 39965.6 40015.6 39963.0 40281.8 40286.8 40296.8 40401.6 8331.8 8528.7 9226.2 9457.7 9493.3 9090.0 11429.2 11473.1 11600.5 11611.9 11244.6 11312.5 11327.3 11343.5 11361.8 11414.3 11418.4 11466.0 11476.7 11513.8 11312.9 11364.0 11365.1 11371.0 11379.5 38681.8 39066.2 39130.0 39142.0 39222.8 3366.2 3383.9 3405.3 3427.5 3497.0 24001.5 25289.2 29540.6 30176.5 30323.1 3031.5 3046.3 3060.8 3092.6 3104.9 383638.0 448676.0 452224.0 453432.7 453496.0 55393.4 55558.4 55560.2 55660.4 55792.0 56758.4 56834.4 56969.7 57211.0 57346.0 13164.0 15556.7 15730.8 15806.7 15904.9 10986.5 11299.0 12071.1 12241.8 12327.8 14797.6 14933.5 14937.3 14940.7 15152.7 5227.4 5500.3 5924.8 6226.6 6231.6 859.6 962.1 986.2 1014.4 1037.8 27513.6 28229.0 28498.9 29230.4 29250.6 953.3 985.2 987.5 1037.1 1050.0 12622.7 12729.6 14840.3 15164.8 15230.2 587360.0 588343.0 590303.0 596644.0 597480.0 55176.3 55489.0 55541.4 55571.2 55580.7 1363.7 1395.4 1419.5 1421.8 1425.9 28047.3 28110.1 28197.9 28778.7 28910.0 47182.5 47358.5 47384.8 47472.3 47631.0 458195.7 459632.0 460708.0 461221.0 461253.0 22932.8 23720.3 23734.0 24357.1 37746.0 38781.6 39174.0 39303.8 39423.8 39627.5 32675.5 33201.8 33342.8 33677.8 34375.0 32836.3 33002.5 33661.0 33759.8 34478.3 29952.1 31235.8 33123.3 33247.3 33264.0 28494.0 29955.1 30118.0 30140.8 30683.7 21527.4 22627.5 23183.1 23442.9 23524.8 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#2] jquery.html Cycles:180 Average:35380.68 Median:17683.29 stddev:97908.64 (553.7%) stddev-sans-first:98147.98 08:06:39 INFO - PROCESS | 1992 | Values: 359.4 369.3 377.2 377.2 401.4 17687.6 18564.3 19868.9 19984.9 20120.7 11645.8 11742.3 11982.3 11998.8 12024.4 4965.8 5246.6 5300.4 5358.7 5372.8 3839.5 4056.4 4554.4 5321.9 5369.9 4029.8 6473.4 6502.9 6560.0 6580.5 6540.9 6543.5 6549.6 7262.5 7669.5 7180.8 7450.6 7539.7 7548.5 7554.1 24302.3 24670.8 24856.4 25092.0 25293.4 2445.0 2480.8 2522.8 2878.8 2990.6 15664.8 16245.8 16402.9 16473.3 16656.5 1566.7 1916.4 1959.7 1985.7 2009.6 130872.0 139490.0 144264.3 145008.0 145695.0 17303.4 20521.9 20891.4 21355.6 21374.9 34384.0 34798.1 34947.3 34995.8 35007.1 8553.6 10334.7 10611.9 10742.2 10926.9 7100.5 7467.7 8681.9 8760.5 8961.9 7812.8 9392.9 9511.5 9557.8 9588.4 3197.6 3715.9 3825.6 3834.5 3853.7 839.6 885.9 933.9 960.2 1019.6 19173.5 19748.8 19993.3 20024.2 20641.0 757.9 788.6 828.2 886.6 946.8 10054.6 10555.6 10591.0 10648.7 10730.1 548623.0 585538.0 588717.0 595301.0 602187.0 95826.0 116382.0 117218.0 120005.0 132588.0 378.1 416.7 447.7 448.0 449.2 10592.9 10962.5 11355.8 11579.6 11713.9 48334.3 49615.8 50457.7 51901.0 52956.7 72360.0 75456.0 76226.0 77575.2 78013.4 7494.6 7657.1 7914.8 7980.7 8095.6 7731.6 10347.4 10596.6 11760.4 12228.8 8158.0 10524.8 10613.5 10672.1 10675.5 9991.3 10138.9 10305.0 10337.5 10597.0 10252.8 10487.9 10721.7 10788.2 11057.4 7713.0 7943.6 7983.1 8036.2 8105.8 9489.7 10633.3 10672.3 10735.7 10813.7 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#3] mootools.html Cycles:180 Average:5291.09 Median:5045.06 stddev:2952.90 (58.5%) stddev-sans-first:2945.72 08:06:39 INFO - PROCESS | 1992 | Values: 1271.0 1500.7 1669.9 1864.9 1868.4 7457.6 7761.5 8004.6 8438.1 8457.5 7936.0 8221.5 8231.5 8338.9 8344.9 2267.9 2306.8 2307.8 2310.7 2316.9 2307.8 2325.8 2344.5 2348.3 2350.0 1785.9 2272.4 2315.4 2316.1 2317.1 2259.9 2265.9 2274.4 2289.6 2292.2 1974.2 2301.7 2315.4 2325.5 2331.8 8259.2 8311.0 8312.0 8318.2 8363.4 4951.9 5140.2 5148.7 5152.2 5173.8 3132.8 3254.6 3372.4 3389.4 3397.8 1024.8 1047.0 1062.9 1063.0 1068.6 10369.5 10724.1 10731.3 10740.2 10742.2 4200.1 4296.4 4362.4 4391.8 4405.3 8538.3 8600.3 8615.4 8633.1 8633.4 4980.5 5044.6 5045.5 5048.7 5064.8 3396.8 3663.6 3807.5 4383.4 4709.8 3017.8 3562.5 3605.8 3666.0 3700.7 1129.0 1142.4 1144.1 1152.1 1158.8 707.3 807.9 879.2 889.3 897.9 5127.7 5333.2 5456.5 5590.1 5602.9 433.7 434.0 436.2 437.0 437.4 3673.8 3729.1 3770.8 3779.5 3809.2 9524.8 9981.4 9991.0 10007.8 10011.8 9944.0 9949.2 9966.3 9971.6 9986.1 7426.0 7671.3 7711.2 7861.6 7891.6 4930.0 5263.5 5309.9 5378.6 5484.9 9322.8 9358.8 9366.2 9366.5 9382.3 7795.9 9353.0 9361.8 9468.8 9581.7 6573.4 6623.4 6674.8 6682.9 6716.4 7652.9 7702.4 7787.3 7800.6 7806.5 7082.0 7121.2 7122.0 7139.0 7146.4 6828.6 6922.2 6935.7 6963.0 7039.9 6382.4 6541.0 6542.4 6553.4 6586.3 4565.4 4640.2 4692.1 4753.5 4793.2 4593.2 4626.7 4770.0 4771.6 4868.9 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#4] prototype.html Cycles:180 Average:4474.86 Median:4867.20 stddev:1317.11 (27.1%) stddev-sans-first:1283.95 08:06:39 INFO - PROCESS | 1992 | Values: 352.5 359.1 359.5 362.5 369.4 4323.7 4376.5 4493.5 5265.7 5302.5 4580.5 5236.7 5260.9 5336.7 5337.5 3984.7 4069.6 4102.6 4179.9 4243.3 3462.7 4184.4 4203.6 4219.8 4223.3 3833.9 3851.3 3926.5 4152.7 4169.0 3212.5 3464.9 3929.8 4051.7 4064.5 3639.5 3645.4 3672.3 3697.2 3731.8 5246.2 5247.2 5254.3 5258.5 5284.8 4484.5 4813.8 4851.8 4855.1 4884.4 5049.6 5478.9 5506.8 5699.6 5709.4 3425.0 3838.6 4085.7 4100.2 4107.9 4696.9 5056.3 5988.8 5995.0 5997.6 3998.3 4112.4 4140.5 4168.3 4186.7 3365.6 4242.5 4248.7 4251.8 4258.1 4825.9 4831.6 4834.0 4853.6 4860.9 5325.8 5427.8 5542.2 5625.2 5753.4 1360.9 1368.2 1380.5 1384.5 1386.4 837.5 925.2 980.7 983.4 989.2 4468.6 4499.0 4815.5 5078.2 5122.4 4556.5 4927.0 4945.7 5598.1 5618.2 4129.4 4465.6 4673.5 4777.0 4878.5 2497.8 2558.8 2596.4 2825.9 2886.0 5026.4 5294.1 5325.0 5663.4 5738.8 4543.1 5165.4 5549.8 5603.7 5637.7 4958.6 5449.5 5629.8 5797.5 5807.3 4560.9 5126.9 5277.6 5426.4 5572.6 4866.5 5241.3 5352.4 5380.7 5388.0 4848.5 4867.9 5215.1 5688.9 5694.7 3568.9 4108.6 4136.4 4173.0 4183.7 5251.9 5383.1 5594.2 5773.6 5852.3 4578.5 4765.9 5163.7 5422.5 5518.8 5541.3 5545.8 5601.4 5611.6 5633.7 4794.0 4814.8 5452.7 5543.8 5553.8 4328.2 5431.6 5582.7 5657.5 5665.5 5207.8 5419.1 5436.6 5467.0 5493.9 08:06:39 INFO - PROCESS | 1992 | 08:06:39 INFO - PROCESS | 1992 | [#5] yui.html Cycles:180 Average:19937.84 Median:4455.50 stddev:28296.65 (635.1%) stddev-sans-first:28339.20 08:06:39 INFO - PROCESS | 1992 | Values: 709.2 738.6 771.4 775.6 823.1 14497.0 15476.4 15582.8 15634.8 15639.2 14099.6 14210.3 14229.9 14242.8 14251.6 685.3 707.2 846.0 848.1 868.9 864.0 873.8 876.9 877.5 879.3 937.1 938.6 940.4 942.6 942.8 922.5 931.5 932.1 934.2 934.6 687.5 691.2 692.1 692.1 695.4 14060.4 14217.9 14314.3 14784.4 14787.1 14108.2 14429.9 14468.5 14506.6 14539.1 11741.9 11780.9 11795.3 11817.6 11955.3 3650.9 3674.3 3686.3 3707.5 3821.9 78334.0 106651.5 110000.4 110547.9 111627.0 10888.3 10903.3 10904.7 10909.9 11356.6 22773.5 23002.5 23027.2 23114.3 23237.8 7615.8 7660.2 7732.3 7813.2 7840.4 3623.8 3776.5 4286.5 4392.9 4473.9 2696.2 3166.9 3295.5 3529.9 3635.5 616.9 631.1 634.4 645.9 649.8 633.3 655.8 663.2 678.7 687.9 8814.0 9118.5 9264.8 9322.9 9329.7 556.7 569.8 670.4 679.8 683.2 4437.1 4484.7 4512.4 4519.5 4622.5 90299.0 93110.0 94770.5 96182.0 108334.0 80869.6 81174.0 81207.8 86871.6 87270.1 74706.0 77186.2 77410.0 77538.6 77793.1 9704.3 9828.3 9842.0 9875.6 9922.2 37334.6 48160.3 50432.0 50499.0 50875.2 60833.4 64839.7 68482.0 69656.3 70284.3 12188.5 12665.3 12864.4 13016.0 13222.9 13272.4 13426.3 13607.6 13921.0 14075.8 13045.4 13055.2 13253.6 13412.3 13618.5 13183.7 13388.1 13514.1 13756.6 14054.8 13001.9 13128.6 13327.1 13802.7 13856.9 11340.6 11501.5 11526.6 11568.1 11816.7 10751.0 11315.5 11387.3 11487.7 11590.2 08:06:39 INFO - PROCESS | 1992 | -------- Summary: end -------- 08:06:39 INFO - PROCESS | 1992 | 08:06:40 INFO - TEST-INFO | 1992: exit 0 08:06:40 INFO - TEST-OK | dromaeo_css | took 1118066ms 08:06:40 INFO - TEST-START | kraken 08:06:40 INFO - operating with platform_type : mac_ 08:06:40 INFO - Initialising browser for kraken test... 08:06:40 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpgClecu/profile http://localhost:49305/getInfo.html) 08:06:43 INFO - PROCESS | 1998 | 2016-12-09 08:06:43.365 plugin-container[1999:282147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 08:06:43 INFO - PROCESS | 1998 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:43 INFO - PROCESS | 1998 | 2016-12-09 08:06:43.367 plugin-container[1999:282147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:06:43 INFO - PROCESS | 1998 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:43 INFO - PROCESS | 1998 | 2016-12-09 08:06:43.367 plugin-container[1999:282147] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:43 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 08:06:43 INFO - PROCESS | 1998 | colorDepth:24 08:06:43 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 08:06:43 INFO - PROCESS | 1998 | __metrics 08:06:43 ERROR - PROCESS | 1998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 08:06:44 INFO - TEST-INFO | 1998: exit 0 08:06:44 INFO - Browser initialized. 08:06:44 INFO - Running cycle 1/1 for kraken test... 08:06:44 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpgClecu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:46 INFO - PROCESS | 2000 | 2016-12-09 08:06:46.842 plugin-container[2001:282260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:06:46 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:46 INFO - PROCESS | 2000 | 2016-12-09 08:06:46.843 plugin-container[2001:282260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1b, name = 'com.apple.CFPasteboardClient' 08:06:46 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:46 INFO - PROCESS | 2000 | 2016-12-09 08:06:46.843 plugin-container[2001:282260] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:56 INFO - PROCESS | 2000 | RSS: Main: 236572672 08:06:56 INFO - PROCESS | 2000 | 08:06:59 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:00 INFO - PROCESS | 2000 | RSS: Main: 249102336 08:07:00 INFO - PROCESS | 2000 | 08:07:03 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-dft) 08:07:03 INFO - PROCESS | 2000 | RSS: Main: 256651264 08:07:03 INFO - PROCESS | 2000 | 08:07:06 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-fft) 08:07:07 INFO - PROCESS | 2000 | RSS: Main: 259149824 08:07:07 INFO - PROCESS | 2000 | 08:07:09 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator) 08:07:10 INFO - PROCESS | 2000 | RSS: Main: 261423104 08:07:10 INFO - PROCESS | 2000 | 08:07:12 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:12 INFO - PROCESS | 2000 | RSS: Main: 261730304 08:07:12 INFO - PROCESS | 2000 | 08:07:16 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:16 INFO - PROCESS | 2000 | RSS: Main: 267665408 08:07:16 INFO - PROCESS | 2000 | 08:07:19 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:20 INFO - PROCESS | 2000 | RSS: Main: 267284480 08:07:20 INFO - PROCESS | 2000 | 08:07:23 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial) 08:07:23 INFO - PROCESS | 2000 | RSS: Main: 267542528 08:07:23 INFO - PROCESS | 2000 | 08:07:25 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:26 INFO - PROCESS | 2000 | RSS: Main: 266739712 08:07:26 INFO - PROCESS | 2000 | 08:07:27 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:28 INFO - PROCESS | 2000 | RSS: Main: 266956800 08:07:28 INFO - PROCESS | 2000 | 08:07:31 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:31 INFO - PROCESS | 2000 | RSS: Main: 266858496 08:07:31 INFO - PROCESS | 2000 | 08:07:34 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:35 INFO - PROCESS | 2000 | RSS: Main: 267386880 08:07:35 INFO - PROCESS | 2000 | 08:07:38 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:39 INFO - PROCESS | 2000 | RSS: Main: 266846208 08:07:39 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49305/tests/kraken/driver.html?testName=ai-astar) 08:07:41 INFO - PROCESS | 2000 | RSS: Main: 267956224 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | __start_tp_report 08:07:41 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 08:07:41 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 08:07:41 INFO - PROCESS | 2000 | |i|pagename|runs| 08:07:41 INFO - PROCESS | 2000 | |0;ai-astar;115;133;171;127;117;116;113;167;171;144 08:07:41 INFO - PROCESS | 2000 | |1;audio-beat-detection;154;119;118;155;118;118;122;142;173;120 08:07:41 INFO - PROCESS | 2000 | |2;audio-dft;204;215;209;201;197;198;202;197;199;194 08:07:41 INFO - PROCESS | 2000 | |3;audio-fft;82;61;58;84;62;61;70;83;95;61 08:07:41 INFO - PROCESS | 2000 | |4;audio-oscillator;91;96;118;102;71;71;84;73;71;83 08:07:41 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;111;167;111;121;113;114;113;157;112;113 08:07:41 INFO - PROCESS | 2000 | |6;imaging-darkroom;153;96;97;97;106;123;97;96;94;99 08:07:41 INFO - PROCESS | 2000 | |7;imaging-desaturate;99;96;93;92;96;91;92;102;93;143 08:07:41 INFO - PROCESS | 2000 | |8;json-parse-financial;58;57;57;59;58;57;57;58;58;59 08:07:41 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;72;77;73;82;78;68;69;71;72;72 08:07:41 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;94;93;95;91;114;86;114;121;179;98 08:07:41 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;153;175;165;158;163;166;156;164;175;147 08:07:41 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;181;186;181;184;182;183;182;246;194;180 08:07:41 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;80;78;87;85;90;93;91;96;90;71 08:07:41 INFO - PROCESS | 2000 | __end_tp_report 08:07:41 INFO - PROCESS | 2000 | __start_cc_report 08:07:41 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,948 08:07:41 INFO - PROCESS | 2000 | __end_cc_report 08:07:41 INFO - PROCESS | 2000 | __startTimestamp1481299661524__endTimestamp 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | ------- Summary: start ------- 08:07:41 INFO - PROCESS | 2000 | Number of tests: 14 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:137.40 Median:138.50 stddev:24.21 (17.5%) stddev-sans-first:24.29 08:07:41 INFO - PROCESS | 2000 | Values: 115.0 133.0 171.0 127.0 117.0 116.0 113.0 167.0 171.0 144.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:132.00 stddev:20.44 (15.5%) stddev-sans-first:20.34 08:07:41 INFO - PROCESS | 2000 | Values: 154.0 119.0 118.0 155.0 118.0 118.0 122.0 142.0 173.0 120.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:201.60 Median:201.50 stddev:6.33 (3.1%) stddev-sans-first:6.65 08:07:41 INFO - PROCESS | 2000 | Values: 204.0 215.0 209.0 201.0 197.0 198.0 202.0 197.0 199.0 194.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:71.70 Median:76.00 stddev:13.15 (17.3%) stddev-sans-first:13.41 08:07:41 INFO - PROCESS | 2000 | Values: 82.0 61.0 58.0 84.0 62.0 61.0 70.0 83.0 95.0 61.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:78.00 stddev:15.85 (20.3%) stddev-sans-first:16.71 08:07:41 INFO - PROCESS | 2000 | Values: 91.0 96.0 118.0 102.0 71.0 71.0 84.0 73.0 71.0 83.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:123.20 Median:113.50 stddev:20.78 (18.3%) stddev-sans-first:21.56 08:07:41 INFO - PROCESS | 2000 | Values: 111.0 167.0 111.0 121.0 113.0 114.0 113.0 157.0 112.0 113.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:96.50 stddev:18.66 (19.3%) stddev-sans-first:9.07 08:07:41 INFO - PROCESS | 2000 | Values: 153.0 96.0 97.0 97.0 106.0 123.0 97.0 96.0 94.0 99.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:99.70 Median:93.00 stddev:15.61 (16.8%) stddev-sans-first:16.55 08:07:41 INFO - PROCESS | 2000 | Values: 99.0 96.0 93.0 92.0 96.0 91.0 92.0 102.0 93.0 143.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 08:07:41 INFO - PROCESS | 2000 | Values: 58.0 57.0 57.0 59.0 58.0 57.0 57.0 58.0 58.0 59.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:72.50 stddev:4.33 (6.0%) stddev-sans-first:4.56 08:07:41 INFO - PROCESS | 2000 | Values: 72.0 77.0 73.0 82.0 78.0 68.0 69.0 71.0 72.0 72.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:108.50 Median:92.00 stddev:27.37 (29.8%) stddev-sans-first:28.52 08:07:41 INFO - PROCESS | 2000 | Values: 94.0 93.0 95.0 91.0 114.0 86.0 114.0 121.0 179.0 98.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:162.20 Median:164.50 stddev:8.98 (5.5%) stddev-sans-first:8.89 08:07:41 INFO - PROCESS | 2000 | Values: 153.0 175.0 165.0 158.0 163.0 166.0 156.0 164.0 175.0 147.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.90 Median:183.50 stddev:20.12 (11.0%) stddev-sans-first:21.08 08:07:41 INFO - PROCESS | 2000 | Values: 181.0 186.0 181.0 184.0 182.0 183.0 182.0 246.0 194.0 180.0 08:07:41 INFO - PROCESS | 2000 | 08:07:41 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.10 Median:90.00 stddev:7.69 (8.5%) stddev-sans-first:7.84 08:07:41 INFO - PROCESS | 2000 | Values: 80.0 78.0 87.0 85.0 90.0 93.0 91.0 96.0 90.0 71.0 08:07:41 INFO - PROCESS | 2000 | -------- Summary: end -------- 08:07:41 INFO - PROCESS | 2000 | 08:07:42 INFO - TEST-INFO | 2000: exit 0 08:07:42 INFO - TEST-OK | kraken | took 61886ms 08:07:42 INFO - SUITE-END | took 1179s 08:07:42 INFO - Completed test suite (00:19:40) 08:07:42 INFO - javascript benchmark 08:07:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7149.650883269103, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.9497807532907, 3383.813890236037, 3417.4019546579343, 3419.965800341997, 3421.1618153552367, 4980.203167493201, 5389.056915039867, 5593.440655934404, 5677.403872593381, 5743.827685169441, 5572.721363931808, 5633.15502674599, 5693.715314234292, 5706.1726049722765, 5733.971330143354, 4251.404803327537, 5120.487951204868, 5220.973895130519, 5264.473552644724, 5282.2076688496645, 5160.716160611165, 5239.790408383679, 5289.814856480024, 5293.073712100387, 5324.440933701963, 5285.735713214343, 5309.0, 5309.256704061435, 5311.176767601009, 5324.76038578263, 5116.0, 5125.84622461323, 5131.332926719502, 5163.7159956202395, 5240.973795131, 5190.06578815813, 5204.4535323791215, 5217.530422261977, 5238.423773384925, 5257.684538927677, 5517.586181036399, 5654.575906806965, 5660.235868157787, 5730.598858079936, 5763.4812866842185, 6102.237220347457, 6144.262688477366, 6169.413905678954, 6255.374462553708, 6257.8748425031245, 6204.193454850885, 6229.781957631461, 6231.501479881644, 6233.940230160883, 6246.500279977591, 5836.854078648068, 5840.620359676607, 5872.383399743051, 5902.6163299385835, 5902.852428689274, 5917.84602002614, 6139.416755408229, 6276.623402595859, 6281.905771413432, 6296.433321001132, 6039.63762174271, 6043.0, 6105.399096011471, 6191.442770150708, 6213.96893015532, 6141.332587233735, 6234.812955611248, 6234.844128896723, 6273.435390814849, 6288.434040936338, 5893.705314734246, 6107.877842443215, 6229.4082062204925, 6275.34108918557, 6276.780312689034, 5830.62100963436, 6164.753409863645, 6185.195924529872, 6276.058591211264, 6282.1519094921605, 4822.541858523435, 4839.2983017462275, 4849.199882019428, 4913.533214344631, 4941.975290123526, 3689.3728066228805, 4362.17118747437, 4372.300431930876, 4432.49026361966, 4443.37792709021, 5888.234529511222, 5892.96873047215, 5893.381194974551, 5904.232449781501, 5959.910601340984, 5620.690862002547, 5776.855578610484, 6252.624842509464, 6262.279837818618, 6293.811185664437, 5655.915161272502, 5662.5753068520025, 5675.82972510817, 5840.211571437886, 5845.678487683133, 4840.34655321527, 5051.722155281422, 5341.839744807662, 5365.946340536545, 5436.130219164915, 5830.271216097988, 5831.096180092092, 6326.114343991753, 6333.1766870306565, 6369.840753981095, 6175.876482470236, 6278.4035516625845, 6306.810795676137, 6307.621542707452, 6311.400416960381, 6206.317305096345, 6206.410391012847, 6206.658633775186, 6235.220597425322, 6243.875122497434, 6186.597871138541, 6197.287311959002, 6197.845053873689, 6208.906866397098, 6214.5960512566535, 6211.130441738251, 6238.968805155945, 6244.500439964701, 6249.750009999549, 6255.093011513214, 5559.44405559457, 5594.384617692132, 5941.079132734433, 5962.55280853929, 6033.42682445167, 6066.393360663898, 6095.0, 6095.420935011167, 6136.478399335928, 6169.907451388143, 5783.508401785895, 5816.709164541671, 5867.794627188028, 5881.235439392852, 5974.103884417372, 6054.757809687563, 6061.121137435135, 6080.969595151996, 6091.0, 6094.268687757498, 5796.478316951326, 5876.294844618673, 5912.586118971631, 5915.142304365757, 5937.109433584824], "value": 5660.471542865294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.14473487230157, 473.33732774116254, 485.2381760635802, 488.78982037723785, 502.41217775203006, 37664.87005389836, 39734.801325993365, 39839.40240896389, 39965.60034399655, 40015.599844001554, 39963.0, 40281.798591007006, 40286.7985660072, 40296.79851600738, 40401.59598404022, 8331.750047498585, 8528.744137675849, 9226.215771659401, 9457.668981585646, 9493.288003399739, 9089.954550227272, 11429.199956003084, 11473.139514536444, 11600.535978560847, 11611.941940290286, 11244.550217991271, 11312.547498100108, 11327.32036077838, 11343.489542970545, 11361.829572556418, 11414.258073225255, 11418.371989540572, 11466.0, 11476.655700329004, 11513.827292590535, 11312.94343528277, 11364.0, 11365.147613928988, 11371.0, 11379.487923043484, 38681.80659096715, 39066.21867562661, 39130.02174945621, 39142.0, 39222.80388598067, 3366.1752870546875, 3383.8646454141804, 3405.3189362127428, 3427.503012063262, 3496.965030349689, 24001.51996960051, 25289.229753917232, 29540.556891646644, 30176.54735178974, 30323.090307290815, 3031.4694928387667, 3046.31457921968, 3060.8010479318773, 3092.58250136231, 3104.8602812873473, 383638.0, 448676.0, 452224.0, 453432.732836337, 453496.0, 55393.44606553963, 55558.444415556136, 55560.16659750107, 55660.44339556633, 55792.0, 56758.43241567614, 56834.431655683744, 56969.7151514248, 57211.0, 57346.0, 13164.0, 15556.688866222612, 15730.842691573167, 15806.68386632261, 15904.920475397548, 10986.505607247533, 11299.039581635489, 12071.094667899943, 12241.816372754416, 12327.753444931051, 14797.556073317817, 14933.477328293458, 14937.25313734309, 14940.701185976219, 15152.696946061238, 5227.373774209776, 5500.339959204921, 5924.763009479572, 6226.62640241587, 6231.563790534619, 859.6260626627437, 962.1436921140051, 986.2405947420447, 1014.3558840136419, 1037.818381783185, 27513.587296190573, 28229.0, 28498.857505712753, 29230.415391692048, 29250.561241581392, 953.2945620240972, 985.1970643925179, 987.4568987057233, 1037.0770014686934, 1049.981517927609, 12622.727908976289, 12729.55446559366, 14840.257987100602, 15164.848351516564, 15230.238488075553, 587360.0, 588343.0, 590303.0, 596644.0, 597480.0, 55176.310013648486, 55489.0, 55541.44458555443, 55571.166432503545, 55580.72209638926, 1363.7340718559983, 1395.3720825628507, 1419.4676996126452, 1421.7511935411262, 1425.9358328875226, 28047.298817529725, 28110.08073587155, 28197.859010704815, 28778.71221287844, 28910.0, 47182.528174717816, 47358.52641473541, 47384.7630761844, 47472.2879156806, 47631.04737905292, 458195.70902145276, 459632.0, 460708.0, 461221.0, 461253.0, 22932.770672293063, 23720.288391348287, 23734.0, 24357.14749983742, 37746.0, 38781.6121838778, 39174.0, 39303.80348098241, 39423.817285481484, 39627.45215669751, 32675.529601167527, 33201.83399082989, 33342.833285834386, 33677.831610841786, 34375.0, 32836.34327313488, 33002.51488683063, 33661.0, 33759.83120084384, 34478.310433790684, 29952.101436956928, 31235.843820780752, 33123.33753324968, 33247.335053299284, 33264.00207993764, 28494.0, 29955.101346959626, 30118.007449438475, 30140.84929575426, 30683.693163068976, 21527.35417937402, 22627.547449051257, 23183.07267709273, 23442.882785586644, 23524.823758812334], "value": 18836.84790003462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.4464524632067, 369.2670049950849, 377.1739889641685, 377.20786348667804, 401.36984933654173, 17687.55781105473, 18564.25742970281, 19868.90065549674, 19984.902340137265, 20120.698189527167, 11645.825312620296, 11742.295462272248, 11982.281063136217, 11998.82001769972, 12024.398780061005, 4965.801367945287, 5246.554042906358, 5300.443453437391, 5358.678479291236, 5372.811951581676, 3839.5008648875605, 4056.3509838425857, 4554.43069616298, 5321.893562128756, 5369.865753356178, 4029.7783621900785, 6473.446372870524, 6502.869942601145, 6559.9672001640165, 6580.473562115043, 6540.901886471706, 6543.476521878239, 6549.574277671936, 7262.491625586211, 7669.501482403626, 7180.7845764627145, 7450.627468626547, 7539.660715267826, 7548.509346892434, 7554.131274903347, 24302.270931872074, 24670.753292467027, 24856.3785905352, 25092.0, 25293.367665808317, 2444.963325550118, 2480.8139389545677, 2522.798176145904, 2878.7553057990094, 2990.551417287424, 15664.765028524582, 16245.756313655305, 16402.917985409997, 16473.34106635733, 16656.50030499087, 1566.6631674190103, 1916.4250724782648, 1959.715841203032, 1985.6723640599284, 2009.6081264153495, 130872.0, 139490.0, 144264.278678607, 145008.0, 145695.0, 17303.442690157946, 20521.943659585686, 20891.37325880226, 21355.572888542454, 21374.893125534272, 34384.0, 34798.13004674904, 34947.30105397878, 34995.825020874734, 35007.124821879144, 8553.61508732096, 10334.741631459123, 10611.893881061245, 10742.194335424874, 10926.945365273123, 7100.46746494015, 7467.663955122032, 8681.869771953427, 8760.539586863153, 8961.865572016424, 7812.804679883048, 9392.906070939203, 9511.524423778783, 9557.761055973657, 9588.37675551087, 3197.6322722886703, 3715.9442608360355, 3825.5600605930676, 3834.539855217392, 3853.7109716771356, 839.5802098950525, 885.93798434109, 933.8739270198437, 960.2222200017868, 1019.6227395863579, 19173.520661983563, 19748.802511974984, 19993.300234492013, 20024.199032038847, 20641.0, 757.874556283918, 788.5978151142958, 828.2380210206625, 886.6320477002101, 946.7822400847843, 10054.64808731691, 10555.63055293061, 10591.0, 10648.680539583826, 10730.141588672888, 548623.0, 585538.0, 588717.0, 595301.0, 602186.9781302131, 95826.0, 116382.0, 117218.0, 120005.0, 132588.0, 378.0774909221491, 416.7312083705993, 447.65754198038525, 447.97088189267595, 449.1645539296905, 10592.89407105919, 10962.506687199255, 11355.829662554903, 11579.610446746445, 11713.88286117128, 48334.27498587454, 49615.75192124161, 50457.73855653638, 51900.96198076093, 52956.73521632367, 72360.0, 75456.0, 76226.0, 77575.2242477568, 78013.43973120619, 7494.5503269803985, 7657.115577789483, 7914.802129946797, 7980.720674776355, 8095.635696393559, 7731.574763388067, 10347.379157250589, 10596.576136954436, 11760.411979401168, 12228.816567751313, 8158.0, 10524.842127368249, 10613.522391492246, 10672.146228301872, 10675.46622668879, 9991.25065620067, 10138.898611013796, 10305.0, 10337.534810933375, 10597.0, 10252.794944101226, 10487.94756026215, 10721.678349649523, 10788.190885683449, 11057.447127643425, 7712.958750568826, 7943.642536086006, 7983.081945576333, 8036.196380361917, 8105.797355066171, 9489.715308540755, 10633.308834925705, 10672.30630009047, 10735.677929662123, 10813.67558973232], "value": 9854.715145178352, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.0, 1500.6698526324208, 1669.9248533815985, 1864.8787828791128, 1868.3647559829656, 7457.552546847193, 7761.534307941528, 8004.559749213791, 8438.071812100672, 8457.534835584049, 7936.0, 8221.506709597428, 8231.547264900428, 8338.874916876237, 8344.91655083449, 2267.852589581676, 2306.8039216666602, 2307.7692230776956, 2310.699609050821, 2316.918907838226, 2307.8384513084093, 2325.813934885205, 2344.4842134730416, 2348.3307257431634, 2349.9882500587473, 1785.9285628574842, 2272.36373815332, 2315.4442933695877, 2316.085146367184, 2317.142657216824, 2259.9209027684033, 2265.864048157116, 2274.3972847195423, 2289.6222123349626, 2292.2321022457495, 1974.2004488182308, 2301.6547517872286, 2315.386422598013, 2325.5348930214027, 2331.80179684727, 8259.174082591753, 8310.958445207796, 8312.0, 8318.209770071833, 8363.372747043935, 4951.900961980777, 5140.1518749406305, 5148.716820574867, 5152.175651895679, 5173.76718047685, 3132.8120312781307, 3254.560634314361, 3372.3592517421857, 3389.440742277521, 3397.8470968806464, 1024.774549599087, 1047.0471870597796, 1062.8671416072991, 1062.9946850265776, 1068.6259809066842, 10369.48152592375, 10724.142068634568, 10731.302465339806, 10740.194485413625, 10742.248042637018, 4200.075983283673, 4296.441462609903, 4362.432883725095, 4391.824327026947, 4405.339199120158, 8538.316934645338, 8600.268977137013, 8615.353848461391, 8633.093525179891, 8633.352498562634, 4980.5019498049905, 5044.621653376012, 5045.495450454999, 5048.722320272347, 5064.822731204464, 3396.796192228425, 3663.5970043295215, 3807.5240594925635, 4383.364412160219, 4709.8351557696005, 3017.7887547871437, 3562.4656301554974, 3605.8197090145914, 3666.0, 3700.703943684499, 1128.966131016071, 1142.3831131189065, 1144.1476100305326, 1152.1013609384527, 1158.8030034894089, 707.3421717802493, 807.8909347238048, 879.2482427524502, 889.3330002498126, 897.9057198994011, 5127.720056355205, 5333.173358129496, 5456.508914197741, 5590.105583106683, 5602.915956260659, 433.6725772042088, 433.9674524410682, 436.1821584529008, 437.0, 437.4073130907638, 3673.779573225615, 3729.1050147964834, 3770.792606406619, 3779.508663873679, 3809.2000679857542, 9524.809503809885, 9981.351212171186, 9991.0, 10007.799844003224, 10011.79976400468, 9944.0, 9949.204063674888, 9966.2525310602, 9971.601135954626, 9986.051325124101, 7426.0, 7671.273963358311, 7711.151773304932, 7861.567613781297, 7891.565963871927, 4929.950700492949, 5263.526282634582, 5309.946900530946, 5378.5966052547, 5484.862878428071, 9322.766930826783, 9358.81282374335, 9366.157045865904, 9366.531673416439, 9382.296327775308, 7795.922040779519, 9353.0, 9361.765955851159, 9468.763280917756, 9581.664641737505, 6573.408393244631, 6623.437007854193, 6674.799756007327, 6682.899756503753, 6716.361945615159, 7652.885206721792, 7702.383809295131, 7787.338076263354, 7800.648970796215, 7806.531608103532, 7081.964590177016, 7121.181064177686, 7122.038524799293, 7139.0, 7146.3568278855155, 6828.624425656438, 6922.169339679271, 6935.653217339012, 6963.025176475398, 7039.859202816017, 6382.425581697669, 6541.0, 6542.411182993554, 6553.377429144223, 6586.341365863567, 4565.406497155349, 4640.234361330343, 4692.1084993851055, 4753.524647535219, 4793.161196790478, 4593.173228818845, 4626.706633339051, 4770.022145460103, 4771.570558649738, 4868.926966095441], "value": 4207.4526601606285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.53289391556194, 359.05926472641664, 359.5326076101068, 362.48527091530025, 369.41816638793904, 4323.697341186118, 4376.49670287917, 4493.52817954115, 5265.684058956461, 5302.469753024696, 4580.519045500216, 5236.73816309184, 5260.868478288045, 5336.6531175473565, 5337.519623233918, 3984.721069525134, 4069.552349241581, 4102.5897410258885, 4179.895502612429, 4243.32106862902, 3462.688358047775, 4184.351425529047, 4203.600657937491, 4219.810108545107, 4223.282042052859, 3833.884983450487, 3851.345271303885, 3926.4699265599206, 4152.667786577082, 4169.041120542277, 3212.518122281653, 3464.896053118398, 3929.82315795787, 4051.7163798534116, 4064.4512990746166, 3639.508666330038, 3645.3620616392027, 3672.3389789838084, 3697.186618943828, 3731.794751288678, 5246.186841039645, 5247.16045432729, 5254.31693879797, 5258.474152584749, 5284.81503147388, 4484.461864576239, 4813.831515896927, 4851.757412129379, 4855.126077306083, 4884.438289596706, 5049.576203422378, 5478.863028424282, 5506.834794956118, 5699.629524080921, 5709.4290570942985, 3425.0, 3838.596947320547, 4085.673146148301, 4100.2414553307435, 4107.9178416431505, 4696.906061878777, 5056.342675452204, 5988.814082859768, 5995.0, 5997.550183736237, 3998.260321840469, 4112.424260603518, 4140.4617399738445, 4168.270552653274, 4186.68599855006, 3365.5793025871767, 4242.469691288589, 4248.681348898783, 4251.80866860992, 4258.084511829971, 4825.927611085836, 4831.613470922318, 4833.975830120827, 4853.635977301717, 4860.927086093711, 5325.786968521294, 5427.83716488506, 5542.196381524656, 5625.184348269478, 5753.3958934311295, 1360.9180701342457, 1368.206440264644, 1380.5099189787682, 1384.5015794314038, 1386.3622733542481, 837.5477242289218, 925.1997022575558, 980.6959842448864, 983.4099540275778, 989.1740396768635, 4468.597826195658, 4498.987727761293, 4815.518448155157, 5078.21287700407, 5122.359705036871, 4556.498785133633, 4926.950730492721, 4945.727984960861, 5598.104303311532, 5618.174093419655, 4129.357211384716, 4465.6427485801705, 4673.462551806586, 4777.031886837719, 4878.487758785347, 2497.825152239362, 2558.846469211853, 2596.350912271932, 2825.8587070646386, 2885.994234007345, 5026.371703537058, 5294.067665302214, 5325.041492531304, 5663.433656634304, 5738.82354117405, 4543.137313701367, 5165.398726394829, 5549.834534747667, 5603.719814009283, 5637.661740295595, 4958.603311734981, 5449.455054494598, 5629.831105066773, 5797.507211886952, 5807.274090738658, 4560.863174104782, 5126.923096153486, 5277.630565860353, 5426.430224826494, 5572.62855972131, 4866.464688884149, 5241.324753755285, 5352.421035794372, 5380.650257733235, 5387.973060134675, 4848.490908454562, 4867.926981095357, 5215.061288968022, 5688.890666320193, 5694.743736531783, 3568.946465803067, 4108.609682080198, 4136.400221967858, 4173.0, 4183.698965568864, 5251.894962100813, 5383.111786555174, 5594.1608758686525, 5773.624714393551, 5852.297724273115, 4578.5421457853945, 4765.927666275061, 5163.66436181647, 5422.457754224546, 5518.751656175562, 5541.2796336476, 5545.7781688732, 5601.411851755507, 5611.6352437091455, 5633.6619802811965, 4794.0, 4814.807407703653, 5452.700101494456, 5543.752655652446, 5553.750081246434, 4328.2425575524785, 5431.646942948696, 5582.692951887523, 5657.519110875622, 5665.49010589049, 5207.817726379559, 5419.051665958363, 5436.592255580768, 5467.015937131196, 5493.890122197614], "value": 4076.782355822025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.1525626875886, 738.6085374751382, 771.3636250093667, 775.6276987046218, 823.1357075071178, 14497.0, 15476.380944762195, 15582.844171558281, 15634.765478517831, 15639.218039098043, 14099.647508812284, 14210.289485525735, 14229.857701422983, 14242.786358204608, 14251.643708907282, 685.266764561919, 707.2079271216245, 846.0, 848.1433751910569, 868.9435186712875, 863.9611217495228, 873.838339907116, 876.9298456123495, 877.4910551879926, 879.3141349747208, 937.1097457415449, 938.6198589571235, 940.3652534539193, 942.5993952570165, 942.8350038743226, 922.5110691333604, 931.5435436636034, 932.1470854168496, 934.2012579244749, 934.63082082577, 687.5153017122916, 691.2499937567745, 692.0829900382014, 692.1106378303855, 695.405428358751, 14060.367283472267, 14217.857821421756, 14314.284285785774, 14784.408623655041, 14787.11277323364, 14108.153510789385, 14429.92785036068, 14468.49360272396, 14506.564803055926, 14539.127652340894, 11741.941290293495, 11780.882191178065, 11795.29228246308, 11817.645470635895, 11955.282683039046, 3650.9269814603826, 3674.2651469705897, 3686.318031164243, 3707.536557930259, 3821.9426708599394, 78334.0, 106651.46674266578, 110000.4499977503, 110547.89452105456, 111627.0, 10888.346699197915, 10903.34579925207, 10904.672859814218, 10909.890901091047, 11356.615110826653, 22773.544529109324, 23002.53994920126, 23027.194048208232, 23114.306570802903, 23237.76762232356, 7615.809604759815, 7660.233976602295, 7732.342750866239, 7813.179616140337, 7840.3727701784865, 3623.8006909620226, 3776.527934008249, 4286.464191976003, 4392.9121417572105, 4473.865784026484, 2696.21809675192, 3166.857491412892, 3295.47272436409, 3529.9294014119573, 3635.5455568053994, 616.9413905678954, 631.119588174494, 634.4195061518751, 645.9289478157399, 649.8212991427396, 633.2875515045574, 655.8032590222914, 663.2074670768385, 678.6633412494166, 687.8796210663114, 8814.0, 9118.498482583389, 9264.814703705888, 9322.906770932339, 9329.673461428818, 556.6993823335354, 569.831899589622, 670.4401824476519, 679.7722762874394, 683.2245401469368, 4437.134758722018, 4484.68607197493, 4512.4133862597655, 4519.502854685982, 4622.537746225351, 90299.0, 93110.0, 94770.52614736882, 96182.0, 108334.0, 80869.59565202254, 81174.0, 81207.84901887264, 86871.56564217138, 87270.12729872747, 74706.00577497612, 77186.2281377179, 77410.0, 77538.6123069381, 77793.05517361998, 9704.320697551386, 9828.26288028415, 9841.994574964114, 9875.555599997873, 9922.206223501958, 37334.62665373312, 48160.27759583679, 50432.0, 50499.0, 50875.23687144622, 60833.39166608454, 64839.67580162069, 68481.97277040749, 69656.30343696498, 70284.29715702777, 12188.51245950152, 12665.303408312631, 12864.356782161041, 13015.958723301923, 13222.933885330513, 13272.402741876831, 13426.328683565587, 13607.591772246848, 13921.025528213333, 14075.788863166856, 13045.412956416794, 13055.151415157985, 13253.602391928258, 13412.262325572186, 13618.455261789417, 13183.67040823987, 13388.129771565207, 13514.05401621877, 13756.587302380945, 14054.78917816254, 13001.934990325366, 13128.60614181576, 13327.133736307109, 13802.723945521235, 13856.86143138596, 11340.623329653605, 11501.482433290355, 11526.59656912004, 11568.13239007061, 11816.70458238551, 10750.95990713453, 11315.547378104784, 11387.259828111146, 11487.712807179887, 11590.188686791844], "value": 7410.023726137148, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1637.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 133.0, 171.0, 127.0, 117.0, 116.0, 113.0, 167.0, 171.0, 144.0], "value": 137.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 118.0, 155.0, 118.0, 118.0, 122.0, 142.0, 173.0, 120.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 215.0, 209.0, 201.0, 197.0, 198.0, 202.0, 197.0, 199.0, 194.0], "value": 201.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 58.0, 84.0, 62.0, 61.0, 70.0, 83.0, 95.0, 61.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 118.0, 102.0, 71.0, 71.0, 84.0, 73.0, 71.0, 83.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 167.0, 111.0, 121.0, 113.0, 114.0, 113.0, 157.0, 112.0, 113.0], "value": 123.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 96.0, 97.0, 97.0, 106.0, 123.0, 97.0, 96.0, 94.0, 99.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 93.0, 92.0, 96.0, 91.0, 92.0, 102.0, 93.0, 143.0], "value": 99.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 59.0, 58.0, 57.0, 57.0, 58.0, 58.0, 59.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 73.0, 82.0, 78.0, 68.0, 69.0, 71.0, 72.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 91.0, 114.0, 86.0, 114.0, 121.0, 179.0, 98.0], "value": 108.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 175.0, 165.0, 158.0, 163.0, 166.0, 156.0, 164.0, 175.0, 147.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 186.0, 181.0, 184.0, 182.0, 183.0, 182.0, 246.0, 194.0, 180.0], "value": 189.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 87.0, 85.0, 90.0, 93.0, 91.0, 96.0, 90.0, 71.0], "value": 86.1, "unit": "score"}]}]} 08:07:42 INFO - Return code: 0 08:07:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:42 ERROR - # TBPL SUCCESS # 08:07:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:42 INFO - 2016-12-09 08:07:42.861 screenresolution[2005:282641] starting screenresolution argv=screenresolution get 08:07:42 INFO - 2016-12-09 08:07:42.864 screenresolution[2005:282641] Display 0: 1600x1200x32@60 08:07:42 INFO - 2016-12-09 08:07:42.870 screenresolution[2006:282644] starting screenresolution argv=screenresolution list 08:07:42 INFO - Available Modes on Display 0 08:07:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:43 INFO - Intel Iris: 08:07:43 INFO - Chipset Model: Intel Iris 08:07:43 INFO - Type: GPU 08:07:43 INFO - Bus: Built-In 08:07:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:43 INFO - Vendor: Intel (0x8086) 08:07:43 INFO - Device ID: 0x0a2e 08:07:43 INFO - Revision ID: 0x0009 08:07:43 INFO - Displays: 08:07:43 INFO - Display: 08:07:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:43 INFO - Display Serial Number: 1600x1200 60 08:07:43 INFO - Main Display: Yes 08:07:43 INFO - Mirror: Off 08:07:43 INFO - Online: Yes 08:07:43 INFO - Rotation: Supported 08:07:43 INFO - Return code: 0 08:07:43 INFO - Running post-action listener: _resource_record_post_action 08:07:43 INFO - [mozharness: 2016-12-09 16:07:43.105055Z] Finished run-tests step (success) 08:07:43 INFO - Running post-run listener: _resource_record_post_run 08:07:43 INFO - Total resource usage - Wall time: 1203s; CPU: 55.0%; Read bytes: 2208256; Write bytes: 552902656; Read time: 28; Write time: 1680 08:07:43 INFO - TinderboxPrint: CPU usage
54.7% 08:07:43 INFO - TinderboxPrint: I/O read bytes / time
2,208,256 / 28 08:07:43 INFO - TinderboxPrint: I/O write bytes / time
552,902,656 / 1,680 08:07:43 INFO - TinderboxPrint: CPU idle
2,180.1 (45.3%) 08:07:43 INFO - TinderboxPrint: CPU system
969.9 (20.1%) 08:07:43 INFO - TinderboxPrint: CPU user
1,663.7 (34.6%) 08:07:43 INFO - TinderboxPrint: Swap in / out
267,444,224 / 0 08:07:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245115392; Write bytes: 236873728; Read time: 17985; Write time: 500 08:07:43 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 2171392; Write bytes: 300275712; Read time: 28; Write time: 1141 08:07:43 INFO - Running post-run listener: _upload_blobber_files 08:07:43 INFO - Blob upload gear active. 08:07:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:43 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 08:07:43 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'] 08:07:43 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 08:07:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:44 INFO - (blobuploader) - INFO - Done attempting. 08:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:45 INFO - (blobuploader) - INFO - Done attempting. 08:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:48 INFO - (blobuploader) - INFO - Done attempting. 08:07:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:48 INFO - Return code: 0 08:07:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5287545409608533f53384251646f70f78bcf1aba65b69b409c0f7196ab921728608dca4ae3525fd2e92ff362d461b307792073747035879dc14595ca3090164", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21a3f760111e76b87a163d677233df587b989668e019120af1812c10f9dc1ecae6a2576ac53f475ac5dd358cb46300fc93d7084cdd7ffd27ebc3fb8ca2afc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3602ed109023add7631536e9c48f5ac48b4c21c548313874928eb85c074b38ed76e357ba6955c0d2cd9b0072902488ea1a4eb20a82b9747524c47432c1a69837"} 08:07:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:48 INFO - Contents: 08:07:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5287545409608533f53384251646f70f78bcf1aba65b69b409c0f7196ab921728608dca4ae3525fd2e92ff362d461b307792073747035879dc14595ca3090164", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21a3f760111e76b87a163d677233df587b989668e019120af1812c10f9dc1ecae6a2576ac53f475ac5dd358cb46300fc93d7084cdd7ffd27ebc3fb8ca2afc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3602ed109023add7631536e9c48f5ac48b4c21c548313874928eb85c074b38ed76e357ba6955c0d2cd9b0072902488ea1a4eb20a82b9747524c47432c1a69837"} 08:07:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:48 INFO - Copying logs to upload dir... 08:07:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.612296 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-12-09 08:07:48.406201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:07:48.409761) ========= 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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/5287545409608533f53384251646f70f78bcf1aba65b69b409c0f7196ab921728608dca4ae3525fd2e92ff362d461b307792073747035879dc14595ca3090164", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21a3f760111e76b87a163d677233df587b989668e019120af1812c10f9dc1ecae6a2576ac53f475ac5dd358cb46300fc93d7084cdd7ffd27ebc3fb8ca2afc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3602ed109023add7631536e9c48f5ac48b4c21c548313874928eb85c074b38ed76e357ba6955c0d2cd9b0072902488ea1a4eb20a82b9747524c47432c1a69837"} build_url:https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/Ihq1X4m9RfmoUEBW0aNCww/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5287545409608533f53384251646f70f78bcf1aba65b69b409c0f7196ab921728608dca4ae3525fd2e92ff362d461b307792073747035879dc14595ca3090164", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21a3f760111e76b87a163d677233df587b989668e019120af1812c10f9dc1ecae6a2576ac53f475ac5dd358cb46300fc93d7084cdd7ffd27ebc3fb8ca2afc21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3602ed109023add7631536e9c48f5ac48b4c21c548313874928eb85c074b38ed76e357ba6955c0d2cd9b0072902488ea1a4eb20a82b9747524c47432c1a69837"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:07:48.444280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:07:48.444617) ========= 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.i8ejc43G0a/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.GgaiN5Nm0Q/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005023 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:07:48.493408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:07:48.493719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:07:48.494047) ========= ========= Total master_lag: 0.18 =========